Bug 719382
| Summary: | unable to push template to us-west after pushing to us-east | ||
|---|---|---|---|
| Product: | [Retired] CloudForms Cloud Engine | Reporter: | wes hayutin <whayutin> |
| Component: | imagefactory | Assignee: | Martyn Taylor <mtaylor> |
| Status: | CLOSED CURRENTRELEASE | QA Contact: | wes hayutin <whayutin> |
| Severity: | unspecified | Docs Contact: | |
| Priority: | unspecified | ||
| Version: | 0.3.1 | CC: | akarol, dajohnso, deltacloud-maint, markmc, mtaylor, sloranz, sreichar, ssachdev, sseago |
| Target Milestone: | beta | ||
| Target Release: | --- | ||
| Hardware: | Unspecified | ||
| OS: | Unspecified | ||
| Whiteboard: | |||
| Fixed In Version: | Doc Type: | Bug Fix | |
| Doc Text: | Story Points: | --- | |
| Clone Of: | Environment: | ||
| Last Closed: | Type: | --- | |
| Regression: | --- | Mount Type: | --- |
| Documentation: | --- | CRM: | |
| Verified Versions: | Category: | --- | |
| oVirt Team: | --- | RHEL 7.3 requirements from Atomic Host: | |
| Cloudforms Team: | --- | Target Upstream Version: | |
| Embargoed: | |||
| Bug Depends On: | |||
| Bug Blocks: | 699883 | ||
[root@ibm-x3620m3-01 ~]# rpm -qa | grep aeolus aeolus-configure-2.0.1-0.fc14.20110628141215gitb8aaf85.noarch aeolus-conductor-daemons-0.3.0-0.fc14.20110705143716git65ca9f4.noarch aeolus-conductor-0.3.0-0.fc14.20110705143716git65ca9f4.noarch aeolus-conductor-doc-0.3.0-0.fc14.20110705143716git65ca9f4.noarch aeolus-all-0.3.0-0.fc14.20110705143716git65ca9f4.noarch rubygem-aeolus-cli-0.0.1-1.fc14.20110705143716git65ca9f4.noarch [root@ibm-x3620m3-01 ~]# rpm -qa | grep factory rubygem-image_factory_console-0.4.0-1.fc14.20110705143716git65ca9f4.noarch rubygem-image_factory_connector-0.0.3-1.fc14.20110705143716git65ca9f4.noarch imagefactory-0.2.2-1.fc14.noarch [root@ibm-x3620m3-01 ~]# rpm -qa | grep oz oz-0.4.0-1.fc14.x86_64 [root@ibm-x3620m3-01 ~]# To confirm.. I built another template and pushed directly to us-west.. and its working..
[root@ibm-x3620m3-01 ~]# aeolus-image build --target ec2 --template /root/template02.tpl
Target Image: 97435a7e-dd7e-4375-a664-042ecbc46ba7
Image: 4437be70-6a7e-4bff-b917-46d7d86555bc
Build: 60526e0b-0d54-46c6-b89b-7832926c1373
Status: COMPLETED
Percent Complete: 100
[root@ibm-x3620m3-01 ~]# aeolus-image push --provider ec2-us-west-1 --id 4437be70-6a7e-4bff-b917-46d7d86555bc
Provider Image: 844da529-0812-4edd-92e4-22519338cd4b
Image: 4437be70-6a7e-4bff-b917-46d7d86555bc
Build: 60526e0b-0d54-46c6-b89b-7832926c1373
Status: PUSHING
Percent Complete: 0
2011-07-06 12:21:33,762 DEBUG imagefactory.qmfagent.ImageFactoryAgent.ImageFactoryAgent pid(5231) Message: Method called: name = build_image
args = {'image': '', 'build': '', 'template': '<template>\n<name>tmpl2</name>\n<description>foo-bar</description>\n<os>\n<name>Fedora</name>\n<arch>x86_64</arch>\n<version>14</version>\n<install type="url">\n<url>http://download.fedoraproject.org/pub/fedora/linux/releases/14/Fedora/x86_64/os/</url>\n</install>\n</os>\n<repositories>\n<repository name="custom">\n<url>http://repos.fedorapeople.org/repos/aeolus/demo/webapp/</url>\n<signed>false</signed>\n</repository>\n</repositories>\n</template>\n\n\n', 'targets': ['ec2']}
handle = <cqmf2.AgentEvent; proxy of <Swig Object of type 'qmf::AgentEvent *' at 0x1d35cf0> >
addr = redhat.com:imagefactory:a9e43167-c645-41c3-81a3-19ef5dc5bb44:image_factory
subtypes = {}
userId = anonymous
2011-07-06 12:21:33,762 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Created Image Warehouse instance http://localhost:9090 - buckets(target_images, templates, icicles, provider_images)
2011-07-06 12:21:33,854 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time...
2011-07-06 12:21:33,880 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'object_type': 'image', 'uuid': '4437be70-6a7e-4bff-b917-46d7d86555bc'}) for http://localhost:9090/images/4437be70-6a7e-4bff-b917-46d7d86555bc
2011-07-06 12:21:33,884 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time...
2011-07-06 12:21:33,890 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'image': '4437be70-6a7e-4bff-b917-46d7d86555bc', 'object_type': 'build', 'uuid': '60526e0b-0d54-46c6-b89b-7832926c1373'}) for http://localhost:9090/builds/60526e0b-0d54-46c6-b89b-7832926c1373
2011-07-06 12:21:33,894 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Created Image Warehouse instance http://localhost:9090 - buckets(target_images, templates, icicles, provider_images)
2011-07-06 12:21:33,896 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Building Linux for non-upload cloud (ec2)
2011-07-06 12:21:33,896 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Storing placeholder object for non upload cloud image
2011-07-06 12:21:33,898 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time...
2011-07-06 12:21:33,906 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'object_type': 'template', 'uuid': '522f9e2f-5223-42ef-8bf7-f17b0dd937dd'}) for http://localhost:9090/templates/522f9e2f-5223-42ef-8bf7-f17b0dd937dd
2011-07-06 12:21:33,910 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time...
2011-07-06 12:21:33,918 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'icicle': 'none', 'uuid': '97435a7e-dd7e-4375-a664-042ecbc46ba7', 'template': '522f9e2f-5223-42ef-8bf7-f17b0dd937dd', 'target_parameters': None, 'object_type': 'target_image', 'target': 'ec2', 'build': '60526e0b-0d54-46c6-b89b-7832926c1373'}) for http://localhost:9090/target_images/97435a7e-dd7e-4375-a664-042ecbc46ba7
2011-07-06 12:21:33,927 DEBUG imagefactory.BuildJob.BuildAdaptor pid(5231) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed percent complete from 0 to 100
2011-07-06 12:21:33,928 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Getting metadata (['latest_unpushed']) from http://localhost:9090/images/4437be70-6a7e-4bff-b917-46d7d86555bc
2011-07-06 12:21:33,929 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Getting metadata (['latest_build']) from http://localhost:9090/images/4437be70-6a7e-4bff-b917-46d7d86555bc
2011-07-06 12:21:33,931 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'latest_unpushed': '60526e0b-0d54-46c6-b89b-7832926c1373'}) for http://localhost:9090/images/4437be70-6a7e-4bff-b917-46d7d86555bc
2011-07-06 12:21:33,933 DEBUG imagefactory.BuildJob.BuildAdaptor pid(5231) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed status from NEW to COMPLETED
2011-07-06 12:21:33,933 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Completed placeholder warehouse object for linux non-upload image...
2011-07-06 12:23:40,776 DEBUG imagefactory.qmfagent.ImageFactoryAgent.ImageFactoryAgent pid(5231) Message: Method called: name = push_image
args = {'credentials': '<provider_accounts>\n<provider_account>\n<name>rhevm</name>\n<provider>rhevm</provider>\n<provider_type>rhev-m</provider_type>\n<provider_credentials>\n <rhev-m_credentials>\n <password>100yard-</password>\n <username>rhev.eng.bos.redhat.com</username>\n </rhev-m_credentials>\n</provider_credentials>\n</provider_account>\n<provider_account>\n<name>wes-us-east-1</name>\n<provider>ec2-us-east-1</provider>\n<provider_type>ec2</provider_type>\n<provider_credentials>\n <ec2_credentials>\n <access_key>AKIAJ557U7P7OIHRV2EQ</access_key>\n <account_number>6735-0069-5950</account_number>\n <certificate>-----BEGIN CERTIFICATE-----\nMIICeDCCAeGgAwIBAgIGAIMhOJTUMA0GCSqGSIb3DQEBBQUAMFMxCzAJBgNVBAYT\nAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMQwwCgYDVQQLEwNBV1MxITAfBgNVBAMT\nGEFXUyBMaW1pdGVkLUFzc3VyYW5jZSBDQTAeFw0xMDA0MTkxNDU2MDRaFw0xMTA0\nMTkxNDU2MDRaMFMxCzAJBgNVBAYTAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMRcw\nFQYDVQQLEw5BV1MtRGV2ZWxvcGVyczEWMBQGA1UEAxMNMTNxb2pvMnhpa3AxMzCB\nnzANBgkqhkiG9w0BAQEFAAOBjQAwgYkCgYEAhsjKFoUJvEiZLdqALUAyFdDoeBKt\nZcqCRa5459+zp/d4XcykugpLlvcEfuKOrQcmqA08JWEN/4Xj4nIz+HoEtui3KFgg\n2YJ/VImlVeaSn4AGjfLsrEjLHnEBSGgNAJsh53fuEQTga8Y00T2qQ7d/Ebh6OXI3\niRKjY5Bm0d5mqrsCAwEAAaNXMFUwDgYDVR0PAQH/BAQDAgWgMBYGA1UdJQEB/wQM\nMAoGCCsGAQUFBwMCMAwGA1UdEwEB/wQCMAAwHQYDVR0OBBYEFDML4N2PsXn7nurg\n5bXHxMkFVQbLMA0GCSqGSIb3DQEBBQUAA4GBAIUGLc0R3HnEDXlXQMiLfQygqXEv\ndouihRgqCO+LOWb3tJbpk49TkhSFcjO0TJnKMb+XzuAdfswwgXSmwbbvrcDT/OdD\njHbCrLTCBBXIgShKZTrTYOAII5sokU4wg5QS0w9cEWcxceUWRaP8ELdai+ubrlif\noCeB2dgQxL18+uK5\n-----END CERTIFICATE-----\n</certificate>\n <key>-----BEGIN PRIVATE KEY-----\nMIICdQIBADANBgkqhkiG9w0BAQEFAASCAl8wggJbAgEAAoGBAIbIyhaFCbxImS3agC1AMhXQ6HgS
\nrWXKgkWueOffs6f3eF3MpLoKS5b3BH7ijq0HJqgNPCVhDf+F4+JyM/h6BLbotyhYINmCf1SJpVXm
\nkp+ABo3y7KxIyx5xAUhoDQCbIed37hEE4GvGNNE9qkO3fxG4ejlyN4kSo2OQZtHeZqq7AgMBAAEC
\ngYByI9mXZoRPET++5/mB2IpRlT84Z8C1od/eOJkk63kNtfEVpfadoZhPuNHyzdM7TgH7cHHNybn7
\n+Jt6KXI/ar1QDIse7S+xU700AWJVaUt3FqlrglmGT018oGWqH1/3D9/4yVsdvxCKcKYuvre3j2gU
\nsi7uJPpWYqCLhs41EuIUiQJBAPcuRXEtVV5MJipuYljERZHfxT4Yh/b8agfr1dsrHvd4jly9rJnE
\nIwB3vn0mMS9Fs/f0rUc3RAZRSrsuwYravU8CQQCLl+YDqZOwVfZIkJO2ipWb1xgjVuikLDRTYAXr
\n0NqbDdeBozAdPNVvicrGpg61J0Un6r5zjnkMFfS6SpM4bFjVAkAuwbz3DLlCTitGCX1nBzGVx3t7
\nJI7LpLG17+GTRNPlwhND7ckxiQ2J8BzDda8GHyxM8ia4+vZOL6BwSgboajo3AkAsiTjkYDzzXGmn
\n+yB1c7+JqdVUqQyuHEBRfWhGNSsZnw/rl1HpchgybsbYG/DDURUaSCWdHo52EaczrElODhtFAkAU
\n95df+umPXSwSzFaSCVVaGm7QlH8yBx8nFHF+yeFPV5QmDWmj59Y9UM6vM4MHtUAdpEhIzzAoI/Et
\nlMA4EBbB
\n-----END PRIVATE KEY-----\n</key>\n <secret_access_key>7COhvBzxrz2agtOPgk3bZM7W3ej9QI/j6WvYiHdg</secret_access_key>\n </ec2_credentials>\n</provider_credentials>\n</provider_account>\n<provider_account>\n<name>wes-us-west-1</name>\n<provider>ec2-us-west-1</provider>\n<provider_type>ec2</provider_type>\n<provider_credentials>\n <ec2_credentials>\n <access_key>AKIAJ557U7P7OIHRV2EQ</access_key>\n <account_number>6735-0069-5950</account_number>\n <certificate>-----BEGIN CERTIFICATE-----\nMIICeDCCAeGgAwIBAgIGAIMhOJTUMA0GCSqGSIb3DQEBBQUAMFMxCzAJBgNVBAYT\nAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMQwwCgYDVQQLEwNBV1MxITAfBgNVBAMT\nGEFXUyBMaW1pdGVkLUFzc3VyYW5jZSBDQTAeFw0xMDA0MTkxNDU2MDRaFw0xMTA0\nMTkxNDU2MDRaMFMxCzAJBgNVBAYTAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMRcw\nFQYDVQQLEw5BV1MtRGV2ZWxvcGVyczEWMBQGA1UEAxMNMTNxb2pvMnhpa3AxMzCB\nnzANBgkqhkiG9w0BAQEFAAOBjQAwgYkCgYEAhsjKFoUJvEiZLdqALUAyFdDoeBKt\nZcqCRa5459+zp/d4XcykugpLlvcEfuKOrQcmqA08JWEN/4Xj4nIz+HoEtui3KFgg\n2YJ/VImlVeaSn4AGjfLsrEjLHnEBSGgNAJsh53fuEQTga8Y00T2qQ7d/Ebh6OXI3\niRKjY5Bm0d5mqrsCAwEAAaNXMFUwDgYDVR0PAQH/BAQDAgWgMBYGA1UdJQEB/wQM\nMAoGCCsGAQUFBwMCMAwGA1UdEwEB/wQCMAAwHQYDVR0OBBYEFDML4N2PsXn7nurg\n5bXHxMkFVQbLMA0GCSqGSIb3DQEBBQUAA4GBAIUGLc0R3HnEDXlXQMiLfQygqXEv\ndouihRgqCO+LOWb3tJbpk49TkhSFcjO0TJnKMb+XzuAdfswwgXSmwbbvrcDT/OdD\njHbCrLTCBBXIgShKZTrTYOAII5sokU4wg5QS0w9cEWcxceUWRaP8ELdai+ubrlif\noCeB2dgQxL18+uK5\n-----END CERTIFICATE-----\n</certificate>\n <key>-----BEGIN PRIVATE KEY-----\nMIICdQIBADANBgkqhkiG9w0BAQEFAASCAl8wggJbAgEAAoGBAIbIyhaFCbxImS3agC1AMhXQ6HgS
\nrWXKgkWueOffs6f3eF3MpLoKS5b3BH7ijq0HJqgNPCVhDf+F4+JyM/h6BLbotyhYINmCf1SJpVXm
\nkp+ABo3y7KxIyx5xAUhoDQCbIed37hEE4GvGNNE9qkO3fxG4ejlyN4kSo2OQZtHeZqq7AgMBAAEC
\ngYByI9mXZoRPET++5/mB2IpRlT84Z8C1od/eOJkk63kNtfEVpfadoZhPuNHyzdM7TgH7cHHNybn7
\n+Jt6KXI/ar1QDIse7S+xU700AWJVaUt3FqlrglmGT018oGWqH1/3D9/4yVsdvxCKcKYuvre3j2gU
\nsi7uJPpWYqCLhs41EuIUiQJBAPcuRXEtVV5MJipuYljERZHfxT4Yh/b8agfr1dsrHvd4jly9rJnE
\nIwB3vn0mMS9Fs/f0rUc3RAZRSrsuwYravU8CQQCLl+YDqZOwVfZIkJO2ipWb1xgjVuikLDRTYAXr
\n0NqbDdeBozAdPNVvicrGpg61J0Un6r5zjnkMFfS6SpM4bFjVAkAuwbz3DLlCTitGCX1nBzGVx3t7
\nJI7LpLG17+GTRNPlwhND7ckxiQ2J8BzDda8GHyxM8ia4+vZOL6BwSgboajo3AkAsiTjkYDzzXGmn
\n+yB1c7+JqdVUqQyuHEBRfWhGNSsZnw/rl1HpchgybsbYG/DDURUaSCWdHo52EaczrElODhtFAkAU
\n95df+umPXSwSzFaSCVVaGm7QlH8yBx8nFHF+yeFPV5QmDWmj59Y9UM6vM4MHtUAdpEhIzzAoI/Et
\nlMA4EBbB
\n-----END PRIVATE KEY-----\n</key>\n <secret_access_key>7COhvBzxrz2agtOPgk3bZM7W3ej9QI/j6WvYiHdg</secret_access_key>\n </ec2_credentials>\n</provider_credentials>\n</provider_account>\n</provider_accounts>\n', 'image': '4437be70-6a7e-4bff-b917-46d7d86555bc', 'build': '', 'providers': ['ec2-us-west-1']}
handle = <cqmf2.AgentEvent; proxy of <Swig Object of type 'qmf::AgentEvent *' at 0x1d35cf0> >
addr = redhat.com:imagefactory:a9e43167-c645-41c3-81a3-19ef5dc5bb44:image_factory
subtypes = {}
userId = anonymous
2011-07-06 12:23:40,777 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Getting metadata (['latest_unpushed']) from http://localhost:9090/images/4437be70-6a7e-4bff-b917-46d7d86555bc
2011-07-06 12:23:40,778 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Querying (http://localhost:9090/target_images/_query) with expression ($build == "60526e0b-0d54-46c6-b89b-7832926c1373" && $target == "ec2")
2011-07-06 12:23:40,781 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Getting metadata (['template']) from http://localhost:9090/target_images/97435a7e-dd7e-4375-a664-042ecbc46ba7
2011-07-06 12:23:40,782 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Created Image Warehouse instance http://localhost:9090 - buckets(target_images, templates, icicles, provider_images)
2011-07-06 12:23:40,815 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Created Image Warehouse instance http://localhost:9090 - buckets(target_images, templates, icicles, provider_images)
2011-07-06 12:23:40,819 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Name: tmpl2, UUID: dc56185b-612d-4a3a-9556-a57b7a2cd9a0
2011-07-06 12:23:40,819 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: MAC: 52:54:00:4d:cd:7b, distro: Fedora
2011-07-06 12:23:40,819 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: update: 14, arch: x86_64, diskimage: /var/tmp/tmpl2.dsk
2011-07-06 12:23:40,819 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: nicmodel: virtio, clockoffset: utc
2011-07-06 12:23:40,820 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: mousetype: ps2, disk_bus: virtio, disk_dev: vda
2011-07-06 12:23:40,820 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: icicletmp: /var/lib/oz/icicletmp/tmpl2, listen_port: 18375
2011-07-06 12:23:40,820 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Original ISO path: /var/lib/oz/isos/Fedora14x86_64-url.iso
2011-07-06 12:23:40,820 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Modified ISO cache: /var/lib/oz/isos/Fedora14x86_64-url-oz.iso
2011-07-06 12:23:40,820 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Output ISO path: /var/tmp/tmpl2-url-oz.iso
2011-07-06 12:23:40,820 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: ISO content path: /var/lib/oz/isocontent/tmpl2-url
2011-07-06 12:23:41,334 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Original URL http://download.fedoraproject.org/pub/fedora/linux/releases/14/Fedora/x86_64/os/ resolved to http://download.fedora.devel.redhat.com/pub/fedora/linux/releases/14/Fedora/x86_64/os/
2011-07-06 12:23:41,335 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Being asked to push for provider ec2-us-west-1
2011-07-06 12:23:41,335 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: distro: Fedora - update: 14 - arch: x86_64
2011-07-06 12:23:41,336 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: acting as EC2 user: 6735-0069-5950
2011-07-06 12:23:41,336 DEBUG imagefactory.BuildJob.BuildAdaptor pid(5231) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed status from NEW to PUSHING
2011-07-06 12:23:41,336 DEBUG imagefactory.BuildJob.BuildAdaptor pid(5231) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed percent complete from 0 to 0
2011-07-06 12:23:41,337 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Starting ami ami-c9693a8c with instance_type m1.large
2011-07-06 12:23:41,655 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Creating temporary security group (imagefactory-844da529-0812-4edd-92e4-22519338cd4b)
2011-07-06 12:23:45,195 WARNING boto pid(5231) Message: Error converting code (pending) to int
2011-07-06 12:23:55,206 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 instance to start: 0/300
2011-07-06 12:24:05,386 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 instance to start: 10/300
2011-07-06 12:24:15,574 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 instance to start: 20/300
2011-07-06 12:24:25,745 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 instance to start: 30/300
2011-07-06 12:24:25,920 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting up to 300 seconds for ssh to become available on ec2-50-18-23-214.us-west-1.compute.amazonaws.com
2011-07-06 12:24:25,920 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 ssh access: 0/300
2011-07-06 12:24:41,100 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 ssh access: 10/300
2011-07-06 12:24:55,372 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 ssh access: 20/300
2011-07-06 12:24:56,933 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting 20 seconds for remaining boot tasks
2011-07-06 12:25:16,945 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Removing utility package and repo
2011-07-06 12:25:22,145 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Removal complete
2011-07-06 12:25:22,145 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Customizing guest: ec2-50-18-23-214.us-west-1.compute.amazonaws.com
2011-07-06 12:25:22,146 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Installing additional repository files
2011-07-06 12:25:25,452 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Installing custom packages
2011-07-06 12:25:25,452 INFO oz.Guest.FedoraRemoteGuest pid(5231) Message: Uploading custom files
2011-07-06 12:25:25,453 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Syncing
2011-07-06 12:25:26,936 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Customization step complete
2011-07-06 12:25:26,937 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Generating ICICLE from customized guest
2011-07-06 12:25:29,041 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: ICICLE generation complete
2011-07-06 12:25:29,041 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Re-de-activate firstboot just in case it has been revived during customize
2011-07-06 12:25:30,520 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: De-activation complete
2011-07-06 12:25:30,521 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Uploading cert material
2011-07-06 12:25:40,378 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Cert upload complete
2011-07-06 12:25:40,378 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Executing bundle vol command: euca-bundle-vol -c /tmp/tmpQPci6o -k /tmp/tmpPRXlG2 -u 6735-0069-5950 -e /mnt,/tmp,/root/.ssh --arch x86_64 -d /mnt/bundles --kernel aki-9ba0f1de -p 844da529-0812-4edd-92e4-22519338cd4b -s 10240 --ec2cert /tmp/cert-ec2.pem --fstab /etc/fstab -v /
So this bug us same as what i meant in https://bugzilla.redhat.com/show_bug.cgi?id=717646 :) So I think the 'push' command uses the "latest unpushed" tag on the image to decide which build to push. Once the first 'push' has happened, there is no 'latest unpushed' anymore. So a few things come to mind here: 1) better validation is needed, as I think the real cause of failure is being obscured (no latest unpushed) 2) Ideally we'd push to all providers at once (since if you push to another provider later, there's no guarantee that the packages will be the same if the underlying repos had changed). So I'm not sure if we want to explicitly disallow pushing a build more than once (and provide a clear error message if it's attempted -- "please submit new build and push to all providers" or something like that), or if we want to alter the push method and use latest_build if latest_unpushed is nil (with the caveats above -- we run the risk of us-east and us-west AMIs with a different installed package list. I see this error condition after cleaning up a provider (provider had no remaining space left) and trying to push again. This is an ec2 build/push the build and push are not done on local hardware. So an out of space seems odd, I guess its possible in ec2. Things seem to be working if I combine the providers in a push. So, I'm retesting this anyway.. and if you include the providers together in one command things appear to be working. [root@hp-z200-06 ~]# aeolus-image push --provider ec2-us-east-1,ec2-us-west-1 --id 6146bfdb-1f48-4333-b285-844d4ee56c1e Provider Image: 4a5e9ebe-edf6-4254-94d6-692844186538 Image: 6146bfdb-1f48-4333-b285-844d4ee56c1e Build: 6e963603-dc84-4f0a-9991-dd1c504a7d28 Status: PUSHING Percent Complete: 0 Provider Image: 23beb33b-fe68-443c-9f68-eb47b16cf313 Image: 6146bfdb-1f48-4333-b285-844d4ee56c1e Build: 6e963603-dc84-4f0a-9991-dd1c504a7d28 Status: PUSHING Percent Complete: 0 [root@hp-z200-06 ~]# /tmp/cert-ec2.pem -a "<access_key>" -s "<secret_key>" -U http://s3-us-west-1.amazonaws.com/ 2011-07-14 14:30:32,880 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: Upload output: Checking bucket: imagefactory-ec2-us-east-1-6735-0069-5950 Uploading manifest file Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.00 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.01 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.02 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.03 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.04 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.05 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.06 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.07 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.08 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.09 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.10 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.11 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.12 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.13 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.14 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.15 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.16 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.17 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.18 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.19 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.20 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.21 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.22 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.23 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.24 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.25 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.26 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.27 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.28 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.29 Uploading part: 4a5e9ebe-edf6-4254-94d6-692844186538.part.30 Uploaded image as imagefactory-ec2-us-east-1-6735-0069-5950/4a5e9ebe-edf6-4254-94d6-692844186538.manifest.xml 2011-07-14 14:30:32,880 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: Executing register command: euca-register -U http://ec2.us-east-1.amazonaws.com/ -A "access_key" -S "secret_key" imagefactory-ec2-us-east-1-6735-0069-5950/4a5e9ebe-edf6-4254-94d6-692844186538.manifest.xml 2011-07-14 14:30:34,761 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: Register output: IMAGE ami-9319ddfa 2011-07-14 14:30:34,763 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: Extracted AMI ID: ami-9319ddfa 2011-07-14 14:30:34,765 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(18031) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time... 2011-07-14 14:30:34,768 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(18031) Message: Setting metadata ({'object_type': 'icicle', 'uuid': '0f1d5490-4cc5-4f4b-9ffc-5f08af78d1b4'}) for http://localhost:9090/icicles/0f1d5490-4cc5-4f4b-9ffc-5f08af78d1b4 2011-07-14 14:30:34,853 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(18031) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time... 2011-07-14 14:30:34,864 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(18031) Message: Setting metadata ({'target_image': 'cb6ca4a2-3625-4283-bd05-a047be721cb9', 'uuid': '4a5e9ebe-edf6-4254-94d6-692844186538', 'icicle': '0f1d5490-4cc5-4f4b-9ffc-5f08af78d1b4', 'target_identifier': 'ami-9319ddfa', 'object_type': 'provider_image', 'provider': 'ec2-us-east-1'}) for http://localhost:9090/provider_images/4a5e9ebe-edf6-4254-94d6-692844186538 2011-07-14 14:30:35,115 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: Stopping EC2 instance and deleting temp security group 2011-07-14 14:30:36,026 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: FedoraBuilder instance 140323492920080 pushed image with uuid cb6ca4a2-3625-4283-bd05-a047be721cb9 to provider_image UUID (4a5e9ebe-edf6-4254-94d6-692844186538) and set metadata: {'target_image': 'cb6ca4a2-3625-4283-bd05-a047be721cb9', 'target_identifier': 'ami-9319ddfa', 'icicle': '0f1d5490-4cc5-4f4b-9ffc-5f08af78d1b4', 'provider': 'ec2-us-east-1'} 2011-07-14 14:30:36,026 DEBUG imagefactory.BuildJob.BuildAdaptor pid(18031) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed percent complete from 0 to 100 2011-07-14 14:30:36,027 DEBUG imagefactory.BuildJob.BuildAdaptor pid(18031) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed status from PUSHING to COMPLETED 2011-07-14 14:30:43,443 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: Upload output: Checking bucket: imagefactory-ec2-us-west-1-6735-0069-5950 Uploading manifest file Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.00 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.01 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.02 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.03 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.04 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.05 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.06 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.07 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.08 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.09 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.10 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.11 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.12 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.13 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.14 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.15 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.16 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.17 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.18 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.19 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.20 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.21 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.22 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.23 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.24 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.25 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.26 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.27 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.28 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.29 Uploading part: 23beb33b-fe68-443c-9f68-eb47b16cf313.part.30 Uploaded image as imagefactory-ec2-us-west-1-6735-0069-5950/23beb33b-fe68-443c-9f68-eb47b16cf313.manifest.xml 2011-07-14 14:30:43,443 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: Executing register command: euca-register -U http://ec2.us-west-1.amazonaws.com/ -A "access_key" -S "secret_key" imagefactory-ec2-us-west-1-6735-0069-5950/23beb33b-fe68-443c-9f68-eb47b16cf313.manifest.xml 2011-07-14 14:30:46,059 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: Register output: IMAGE ami-01acfe44 2011-07-14 14:30:46,059 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: Extracted AMI ID: ami-01acfe44 2011-07-14 14:30:46,062 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(18031) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time... 2011-07-14 14:30:46,065 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(18031) Message: Setting metadata ({'object_type': 'icicle', 'uuid': '618a8e74-bbc6-4c41-b33d-197becb28623'}) for http://localhost:9090/icicles/618a8e74-bbc6-4c41-b33d-197becb28623 2011-07-14 14:30:46,150 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(18031) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time... 2011-07-14 14:30:46,153 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(18031) Message: Setting metadata ({'target_image': 'cb6ca4a2-3625-4283-bd05-a047be721cb9', 'uuid': '23beb33b-fe68-443c-9f68-eb47b16cf313', 'icicle': '618a8e74-bbc6-4c41-b33d-197becb28623', 'target_identifier': 'ami-01acfe44', 'object_type': 'provider_image', 'provider': 'ec2-us-west-1'}) for http://localhost:9090/provider_images/23beb33b-fe68-443c-9f68-eb47b16cf313 2011-07-14 14:30:46,401 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: Stopping EC2 instance and deleting temp security group 2011-07-14 14:30:49,446 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(18031) Message: FedoraBuilder instance 140323492995536 pushed image with uuid cb6ca4a2-3625-4283-bd05-a047be721cb9 to provider_image UUID (23beb33b-fe68-443c-9f68-eb47b16cf313) and set metadata: {'target_image': 'cb6ca4a2-3625-4283-bd05-a047be721cb9', 'target_identifier': 'ami-01acfe44', 'icicle': '618a8e74-bbc6-4c41-b33d-197becb28623', 'provider': 'ec2-us-west-1'} 2011-07-14 14:30:49,446 DEBUG imagefactory.BuildJob.BuildAdaptor pid(18031) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed percent complete from 0 to 100 2011-07-14 14:30:49,447 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(18031) Message: Setting metadata ({'latest_build': '6e963603-dc84-4f0a-9991-dd1c504a7d28'}) for http://localhost:9090/images/6146bfdb-1f48-4333-b285-844d4ee56c1e 2011-07-14 14:30:49,450 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(18031) Message: Setting metadata ({'latest_unpushed': None}) for http://localhost:9090/images/6146bfdb-1f48-4333-b285-844d4ee56c1e 2011-07-14 14:30:49,506 DEBUG imagefactory.BuildJob.BuildAdaptor pid(18031) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed status from PUSHING to COMPLETED will try this separately Hrm.. so it seems you have to push to multiple providers in the same command or you have to currently rebuild the image to repush.
Still seems like a bug, I think Mike mentioned a flag or condition needs to be ignored from aeolus-image.
Notice I tried pushing the same image id that worked above to ec2-us-east-1, and it failed..
[root@hp-z200-06 ~]# aeolus-image push --provider ec2-us-east-1 --id 6146bfdb-1f48-4333-b285-844d4ee56c1e
/usr/lib/ruby/gems/1.8/gems/aeolus-cli-0.0.1/lib/push_command.rb:21:in `run': undefined method `each' for #<Qmf2::QmfAgentException:0x7f98fba5cf30> (NoMethodError)
from /usr/lib/ruby/gems/1.8/gems/aeolus-cli-0.0.1/lib/config_parser.rb:199:in `push'
from /usr/lib/ruby/gems/1.8/gems/aeolus-cli-0.0.1/lib/config_parser.rb:30:in `send'
from /usr/lib/ruby/gems/1.8/gems/aeolus-cli-0.0.1/lib/config_parser.rb:30:in `process'
from /usr/lib/ruby/gems/1.8/gems/aeolus-cli-0.0.1/bin/aeolus-image:6
from /usr/bin/aeolus-image:19:in `load'
from /usr/bin/aeolus-image:19
2011-07-14 14:33:53 warn
******** Image Factory Log *****************************
2011-07-14 14:33:51,782 ERROR imagefactory.qmfagent.ImageFactoryAgent.ImageFactoryAgent pid(18031) Message: 'template' must be a UUID, URL, XML string or XML document path...
Traceback (most recent call last):
File "/usr/lib/python2.6/site-packages/imagefactory/qmfagent/ImageFactoryAgent.py", line 74, in method
result = getattr(target_obj, methodName)(**args)
File "/usr/lib/python2.6/site-packages/imagefactory/qmfagent/ImageFactory.py", line 125, in push_image
return BuildDispatcher().push_image_to_providers(image, build, providers, credentials, BuildAdaptor, self.agent)
File "/usr/lib/python2.6/site-packages/imagefactory/BuildDispatcher.py", line 78, in push_image_to_providers
job = job_cls(template, target, image_id, build_id, *args, **kwargs)
File "/usr/lib/python2.6/site-packages/imagefactory/qmfagent/BuildAdaptor.py", line 76, in __init__
super(BuildAdaptor, self).__init__(template, target, image_id, build_id)
File "/usr/lib/python2.6/site-packages/imagefactory/BuildJob.py", line 42, in __init__
self.template = template if isinstance(template, Template) else Template(template)
File "/usr/lib/python2.6/site-packages/imagefactory/Template.py", line 83, in __init__
raise ValueError("'template' must be a UUID, URL, XML string or XML document path...")
ValueError: 'template' must be a UUID, URL, XML string or XML document path...
This problem is not limited to EC2. My understanding of Scott's entry is that the latest un-pushed tag is only set for the latest build (not provider/target dependent). This means that an image that has been puhsed can not be pushed again - at least with the current implementation. I was going to enter a new BZ but searching show that the cause of EC2 failure is the same I am seeing. It is my understanding, after talking to Mark and reviewing the mailing list threads on this topic, that we should not expect to be able to explicitly push an _image_ object to an individual provider. It should, however, be possible to push the build object or target_image object to the provider. Can you guys attempt one or both of these approaches? The introductory message describing the new model, and the valid actions in aeolus-image can be found here: https://fedorahosted.org/pipermail/aeolus-devel/2011-May/001667.html here's how I see it working: $> aeolus-image build ... Image: f94cbbf0 Build: a5128ad1 $> aeolus-image push --id f94cbbf0 --provider ec2-us-east-1 ... $> aeolus-image push --id f94cbbf0 --provider ec2-us-west-1 Error: image f94cbbf0 has already been pushed $> aeolus-image push --build a5128ad1 --provider ec2-us-west-1 ... Specifying an image id to push is a convenient shortcut for "push the latest build of this image" The common case would be that you'd push to multiple providers at once I don't think we want the convenience shortcut to apply where the build has already been pushed to a provider, in order to encourage pushing to multiple providers at once But we still allow explicitly pushing a build which has already been pushed to a provider, if you supply the build ID I hope that makes some sense? I agree w/ Mark on this and the behavior listed in comment #10 commit 5c1350a0db8068d6c04dc6aef5c7c5c469030b37
Author: Martyn Taylor <mtaylor>
Date: Mon Jul 18 16:13:58 2011 +0100
BZ#719382 Enable aeolus-image push --build, throw error on push via image twice
[root@dell-pem600-01 ~]# aeolus-image push --provider ec2-us-west-1 --id e4d9088a-3737-4ca9-b6df-4653a7d19334 An Error occured whilst trying to push this build, please check aeolus-image --help for details on how to use this command [root@dell-pem600-01 ~]# aeolus-image push --provider ec2-us-west-1 --id e4d9088a-3737-4ca9-b6df-4653a7d19334 --build 575649a5-ab36-4b49-96fe-48721c121c6f Provider Image: c1eee6fb-1175-445e-ba59-3ac9fdc78978 Image: e4d9088a-3737-4ca9-b6df-4653a7d19334 Build: 575649a5-ab36-4b49-96fe-48721c121c6f Status: PUSHING Percent Complete: 0 moving of the blocker I'd like to move this from image-factory to aeolus-image based on the above comments and the thread started at https://fedorahosted.org/pipermail/aeolus-devel/2011-July/003311.html release pending... release pending... release pending.. 2 closing out old bugs perm close |
Description of problem: [root@ibm-x3620m3-01 ~]# aeolus-image build --target ec2 --template /root/template.tpl Target Image: 5de7d16a-edf6-4fa4-b20f-094ade49b99b Image: 3142d550-f608-4efd-ada9-9a6261aa8514 Build: 42267e72-e58e-4ca4-9057-3df2347d89d7 Status: COMPLETED Percent Complete: 100 [root@ibm-x3620m3-01 ~]# aeolus-image push --provider ec2-us-east-1 --id 3142d550-f608-4efd-ada9-9a6261aa8514 Provider Image: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82 Image: 3142d550-f608-4efd-ada9-9a6261aa8514 Build: 42267e72-e58e-4ca4-9057-3df2347d89d7 Status: PUSHING Percent Complete: 0 [root@ibm-x3620m3-01 ~]# aeolus-image push --provider ec2-us-west-1 --id 3142d550-f608-4efd-ada9-9a6261aa8514 /usr/lib/ruby/gems/1.8/gems/aeolus-cli-0.0.1/lib/push_command.rb:21:in `run': undefined method `each' for #<Qmf2::QmfAgentException:0x7fb9b32a4df0> (NoMethodError) from /usr/lib/ruby/gems/1.8/gems/aeolus-cli-0.0.1/lib/config_parser.rb:199:in `push' from /usr/lib/ruby/gems/1.8/gems/aeolus-cli-0.0.1/lib/config_parser.rb:30:in `send' from /usr/lib/ruby/gems/1.8/gems/aeolus-cli-0.0.1/lib/config_parser.rb:30:in `process' from /usr/lib/ruby/gems/1.8/gems/aeolus-cli-0.0.1/bin/aeolus-image:6 from /usr/bin/aeolus-image:19:in `load' from /usr/bin/aeolus-image:19 2011-07-06 12:11:57 warning Connection [48292 localhost:5672] closed [root@ibm-x3620m3-01 ~]# factory log for 1. building template for ec2 2. pushing to us-east 3. pushing to us-west [root@ibm-x3620m3-01 ~]# tail -f /var/log/imagefactory.log 2011-07-06 11:50:33,088 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time... 2011-07-06 11:50:33,119 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'object_type': 'template', 'uuid': '593f2ff9-52ea-455a-9aed-40ec75d69432'}) for http://localhost:9090/templates/593f2ff9-52ea-455a-9aed-40ec75d69432 2011-07-06 11:50:33,123 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time... 2011-07-06 11:50:33,150 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'icicle': 'none', 'uuid': '5de7d16a-edf6-4fa4-b20f-094ade49b99b', 'template': '593f2ff9-52ea-455a-9aed-40ec75d69432', 'target_parameters': None, 'object_type': 'target_image', 'target': 'ec2', 'build': '42267e72-e58e-4ca4-9057-3df2347d89d7'}) for http://localhost:9090/target_images/5de7d16a-edf6-4fa4-b20f-094ade49b99b 2011-07-06 11:50:33,160 DEBUG imagefactory.BuildJob.BuildAdaptor pid(5231) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed percent complete from 0 to 100 2011-07-06 11:50:33,160 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Getting metadata (['latest_unpushed']) from http://localhost:9090/images/3142d550-f608-4efd-ada9-9a6261aa8514 2011-07-06 11:50:33,162 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Getting metadata (['latest_build']) from http://localhost:9090/images/3142d550-f608-4efd-ada9-9a6261aa8514 2011-07-06 11:50:33,163 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'latest_unpushed': '42267e72-e58e-4ca4-9057-3df2347d89d7'}) for http://localhost:9090/images/3142d550-f608-4efd-ada9-9a6261aa8514 2011-07-06 11:50:33,165 DEBUG imagefactory.BuildJob.BuildAdaptor pid(5231) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed status from NEW to COMPLETED 2011-07-06 11:50:33,166 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Completed placeholder warehouse object for linux non-upload image... 2011-07-06 11:58:55,377 DEBUG imagefactory.qmfagent.ImageFactoryAgent.ImageFactoryAgent pid(5231) Message: Method called: name = push_image args = {'credentials': '<provider_accounts>\n<provider_account>\n<name>rhevm</name>\n<provider>rhevm</provider>\n<provider_type>rhev-m</provider_type>\n<provider_credentials>\n <rhev-m_credentials>\n <password>100yard-</password>\n <username>rhev.eng.bos.redhat.com</username>\n </rhev-m_credentials>\n</provider_credentials>\n</provider_account>\n<provider_account>\n<name>wes-us-east-1</name>\n<provider>ec2-us-east-1</provider>\n<provider_type>ec2</provider_type>\n<provider_credentials>\n <ec2_credentials>\n <access_key>AKIAJ557U7P7OIHRV2EQ</access_key>\n <account_number>6735-0069-5950</account_number>\n <certificate>-----BEGIN CERTIFICATE-----\nMIICeDCCAeGgAwIBAgIGAIMhOJTUMA0GCSqGSIb3DQEBBQUAMFMxCzAJBgNVBAYT\nAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMQwwCgYDVQQLEwNBV1MxITAfBgNVBAMT\nGEFXUyBMaW1pdGVkLUFzc3VyYW5jZSBDQTAeFw0xMDA0MTkxNDU2MDRaFw0xMTA0\nMTkxNDU2MDRaMFMxCzAJBgNVBAYTAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMRcw\nFQYDVQQLEw5BV1MtRGV2ZWxvcGVyczEWMBQGA1UEAxMNMTNxb2pvMnhpa3AxMzCB\nnzANBgkqhkiG9w0BAQEFAAOBjQAwgYkCgYEAhsjKFoUJvEiZLdqALUAyFdDoeBKt\nZcqCRa5459+zp/d4XcykugpLlvcEfuKOrQcmqA08JWEN/4Xj4nIz+HoEtui3KFgg\n2YJ/VImlVeaSn4AGjfLsrEjLHnEBSGgNAJsh53fuEQTga8Y00T2qQ7d/Ebh6OXI3\niRKjY5Bm0d5mqrsCAwEAAaNXMFUwDgYDVR0PAQH/BAQDAgWgMBYGA1UdJQEB/wQM\nMAoGCCsGAQUFBwMCMAwGA1UdEwEB/wQCMAAwHQYDVR0OBBYEFDML4N2PsXn7nurg\n5bXHxMkFVQbLMA0GCSqGSIb3DQEBBQUAA4GBAIUGLc0R3HnEDXlXQMiLfQygqXEv\ndouihRgqCO+LOWb3tJbpk49TkhSFcjO0TJnKMb+XzuAdfswwgXSmwbbvrcDT/OdD\njHbCrLTCBBXIgShKZTrTYOAII5sokU4wg5QS0w9cEWcxceUWRaP8ELdai+ubrlif\noCeB2dgQxL18+uK5\n-----END CERTIFICATE-----\n</certificate>\n <key>-----BEGIN PRIVATE KEY-----\nMIICdQIBADANBgkqhkiG9w0BAQEFAASCAl8wggJbAgEAAoGBAIbIyhaFCbxImS3agC1AMhXQ6HgS
\nrWXKgkWueOffs6f3eF3MpLoKS5b3BH7ijq0HJqgNPCVhDf+F4+JyM/h6BLbotyhYINmCf1SJpVXm
\nkp+ABo3y7KxIyx5xAUhoDQCbIed37hEE4GvGNNE9qkO3fxG4ejlyN4kSo2OQZtHeZqq7AgMBAAEC
\ngYByI9mXZoRPET++5/mB2IpRlT84Z8C1od/eOJkk63kNtfEVpfadoZhPuNHyzdM7TgH7cHHNybn7
\n+Jt6KXI/ar1QDIse7S+xU700AWJVaUt3FqlrglmGT018oGWqH1/3D9/4yVsdvxCKcKYuvre3j2gU
\nsi7uJPpWYqCLhs41EuIUiQJBAPcuRXEtVV5MJipuYljERZHfxT4Yh/b8agfr1dsrHvd4jly9rJnE
\nIwB3vn0mMS9Fs/f0rUc3RAZRSrsuwYravU8CQQCLl+YDqZOwVfZIkJO2ipWb1xgjVuikLDRTYAXr
\n0NqbDdeBozAdPNVvicrGpg61J0Un6r5zjnkMFfS6SpM4bFjVAkAuwbz3DLlCTitGCX1nBzGVx3t7
\nJI7LpLG17+GTRNPlwhND7ckxiQ2J8BzDda8GHyxM8ia4+vZOL6BwSgboajo3AkAsiTjkYDzzXGmn
\n+yB1c7+JqdVUqQyuHEBRfWhGNSsZnw/rl1HpchgybsbYG/DDURUaSCWdHo52EaczrElODhtFAkAU
\n95df+umPXSwSzFaSCVVaGm7QlH8yBx8nFHF+yeFPV5QmDWmj59Y9UM6vM4MHtUAdpEhIzzAoI/Et
\nlMA4EBbB
\n-----END PRIVATE KEY-----\n</key>\n <secret_access_key>7COhvBzxrz2agtOPgk3bZM7W3ej9QI/j6WvYiHdg</secret_access_key>\n </ec2_credentials>\n</provider_credentials>\n</provider_account>\n<provider_account>\n<name>wes-us-west-1</name>\n<provider>ec2-us-west-1</provider>\n<provider_type>ec2</provider_type>\n<provider_credentials>\n <ec2_credentials>\n <access_key>AKIAJ557U7P7OIHRV2EQ</access_key>\n <account_number>6735-0069-5950</account_number>\n <certificate>-----BEGIN CERTIFICATE-----\nMIICeDCCAeGgAwIBAgIGAIMhOJTUMA0GCSqGSIb3DQEBBQUAMFMxCzAJBgNVBAYT\nAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMQwwCgYDVQQLEwNBV1MxITAfBgNVBAMT\nGEFXUyBMaW1pdGVkLUFzc3VyYW5jZSBDQTAeFw0xMDA0MTkxNDU2MDRaFw0xMTA0\nMTkxNDU2MDRaMFMxCzAJBgNVBAYTAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMRcw\nFQYDVQQLEw5BV1MtRGV2ZWxvcGVyczEWMBQGA1UEAxMNMTNxb2pvMnhpa3AxMzCB\nnzANBgkqhkiG9w0BAQEFAAOBjQAwgYkCgYEAhsjKFoUJvEiZLdqALUAyFdDoeBKt\nZcqCRa5459+zp/d4XcykugpLlvcEfuKOrQcmqA08JWEN/4Xj4nIz+HoEtui3KFgg\n2YJ/VImlVeaSn4AGjfLsrEjLHnEBSGgNAJsh53fuEQTga8Y00T2qQ7d/Ebh6OXI3\niRKjY5Bm0d5mqrsCAwEAAaNXMFUwDgYDVR0PAQH/BAQDAgWgMBYGA1UdJQEB/wQM\nMAoGCCsGAQUFBwMCMAwGA1UdEwEB/wQCMAAwHQYDVR0OBBYEFDML4N2PsXn7nurg\n5bXHxMkFVQbLMA0GCSqGSIb3DQEBBQUAA4GBAIUGLc0R3HnEDXlXQMiLfQygqXEv\ndouihRgqCO+LOWb3tJbpk49TkhSFcjO0TJnKMb+XzuAdfswwgXSmwbbvrcDT/OdD\njHbCrLTCBBXIgShKZTrTYOAII5sokU4wg5QS0w9cEWcxceUWRaP8ELdai+ubrlif\noCeB2dgQxL18+uK5\n-----END CERTIFICATE-----\n</certificate>\n <key>-----BEGIN PRIVATE KEY-----\nMIICdQIBADANBgkqhkiG9w0BAQEFAASCAl8wggJbAgEAAoGBAIbIyhaFCbxImS3agC1AMhXQ6HgS
\nrWXKgkWueOffs6f3eF3MpLoKS5b3BH7ijq0HJqgNPCVhDf+F4+JyM/h6BLbotyhYINmCf1SJpVXm
\nkp+ABo3y7KxIyx5xAUhoDQCbIed37hEE4GvGNNE9qkO3fxG4ejlyN4kSo2OQZtHeZqq7AgMBAAEC
\ngYByI9mXZoRPET++5/mB2IpRlT84Z8C1od/eOJkk63kNtfEVpfadoZhPuNHyzdM7TgH7cHHNybn7
\n+Jt6KXI/ar1QDIse7S+xU700AWJVaUt3FqlrglmGT018oGWqH1/3D9/4yVsdvxCKcKYuvre3j2gU
\nsi7uJPpWYqCLhs41EuIUiQJBAPcuRXEtVV5MJipuYljERZHfxT4Yh/b8agfr1dsrHvd4jly9rJnE
\nIwB3vn0mMS9Fs/f0rUc3RAZRSrsuwYravU8CQQCLl+YDqZOwVfZIkJO2ipWb1xgjVuikLDRTYAXr
\n0NqbDdeBozAdPNVvicrGpg61J0Un6r5zjnkMFfS6SpM4bFjVAkAuwbz3DLlCTitGCX1nBzGVx3t7
\nJI7LpLG17+GTRNPlwhND7ckxiQ2J8BzDda8GHyxM8ia4+vZOL6BwSgboajo3AkAsiTjkYDzzXGmn
\n+yB1c7+JqdVUqQyuHEBRfWhGNSsZnw/rl1HpchgybsbYG/DDURUaSCWdHo52EaczrElODhtFAkAU
\n95df+umPXSwSzFaSCVVaGm7QlH8yBx8nFHF+yeFPV5QmDWmj59Y9UM6vM4MHtUAdpEhIzzAoI/Et
\nlMA4EBbB
\n-----END PRIVATE KEY-----\n</key>\n <secret_access_key>7COhvBzxrz2agtOPgk3bZM7W3ej9QI/j6WvYiHdg</secret_access_key>\n </ec2_credentials>\n</provider_credentials>\n</provider_account>\n</provider_accounts>\n', 'image': '3142d550-f608-4efd-ada9-9a6261aa8514', 'build': '', 'providers': ['ec2-us-east-1']} handle = <cqmf2.AgentEvent; proxy of <Swig Object of type 'qmf::AgentEvent *' at 0x1d35cf0> > addr = redhat.com:imagefactory:a9e43167-c645-41c3-81a3-19ef5dc5bb44:image_factory subtypes = {} userId = anonymous 2011-07-06 11:58:55,379 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Getting metadata (['latest_unpushed']) from http://localhost:9090/images/3142d550-f608-4efd-ada9-9a6261aa8514 2011-07-06 11:58:55,380 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Querying (http://localhost:9090/target_images/_query) with expression ($build == "42267e72-e58e-4ca4-9057-3df2347d89d7" && $target == "ec2") 2011-07-06 11:58:55,394 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Getting metadata (['template']) from http://localhost:9090/target_images/5de7d16a-edf6-4fa4-b20f-094ade49b99b 2011-07-06 11:58:55,395 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Created Image Warehouse instance http://localhost:9090 - buckets(target_images, templates, icicles, provider_images) 2011-07-06 11:58:55,433 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Created Image Warehouse instance http://localhost:9090 - buckets(target_images, templates, icicles, provider_images) 2011-07-06 11:58:55,463 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Name: tmpl1, UUID: 0506a611-0933-4dcf-9fd7-5ab062b54895 2011-07-06 11:58:55,464 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: MAC: 52:54:00:fc:c5:8c, distro: Fedora 2011-07-06 11:58:55,464 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: update: 14, arch: x86_64, diskimage: /var/tmp/tmpl1.dsk 2011-07-06 11:58:55,464 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: nicmodel: virtio, clockoffset: utc 2011-07-06 11:58:55,464 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: mousetype: ps2, disk_bus: virtio, disk_dev: vda 2011-07-06 11:58:55,464 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: icicletmp: /var/lib/oz/icicletmp/tmpl1, listen_port: 49571 2011-07-06 11:58:55,464 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Original ISO path: /var/lib/oz/isos/Fedora14x86_64-url.iso 2011-07-06 11:58:55,464 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Modified ISO cache: /var/lib/oz/isos/Fedora14x86_64-url-oz.iso 2011-07-06 11:58:55,465 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Output ISO path: /var/tmp/tmpl1-url-oz.iso 2011-07-06 11:58:55,465 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: ISO content path: /var/lib/oz/isocontent/tmpl1-url 2011-07-06 11:58:55,994 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Original URL http://download.fedoraproject.org/pub/fedora/linux/releases/14/Fedora/x86_64/os/ resolved to http://download.fedora.devel.redhat.com/pub/fedora/linux/releases/14/Fedora/x86_64/os/ 2011-07-06 11:58:55,994 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Being asked to push for provider ec2-us-east-1 2011-07-06 11:58:55,994 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: distro: Fedora - update: 14 - arch: x86_64 2011-07-06 11:58:56,002 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: acting as EC2 user: 6735-0069-5950 2011-07-06 11:58:56,002 DEBUG imagefactory.BuildJob.BuildAdaptor pid(5231) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed status from NEW to PUSHING 2011-07-06 11:58:56,003 DEBUG imagefactory.BuildJob.BuildAdaptor pid(5231) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed percent complete from 0 to 0 2011-07-06 11:58:56,003 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Starting ami ami-d6b946bf with instance_type m1.large 2011-07-06 11:58:56,454 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Creating temporary security group (imagefactory-baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82) 2011-07-06 11:58:57,744 WARNING boto pid(5231) Message: Error converting code (pending) to int 2011-07-06 11:59:07,748 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 instance to start: 0/300 2011-07-06 11:59:17,893 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 instance to start: 10/300 2011-07-06 11:59:28,001 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 instance to start: 20/300 2011-07-06 11:59:38,098 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 instance to start: 30/300 2011-07-06 11:59:48,193 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 instance to start: 40/300 2011-07-06 11:59:48,316 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting up to 300 seconds for ssh to become available on ec2-50-19-204-3.compute-1.amazonaws.com 2011-07-06 11:59:48,316 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 ssh access: 0/300 2011-07-06 11:59:58,506 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 ssh access: 10/300 2011-07-06 12:00:09,258 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 ssh access: 20/300 2011-07-06 12:00:19,994 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting for EC2 ssh access: 30/300 2011-07-06 12:00:20,791 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Waiting 20 seconds for remaining boot tasks 2011-07-06 12:00:40,811 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Removing utility package and repo 2011-07-06 12:00:43,566 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Removal complete 2011-07-06 12:00:43,566 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Customizing guest: ec2-50-19-204-3.compute-1.amazonaws.com 2011-07-06 12:00:43,604 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Installing additional repository files 2011-07-06 12:00:45,403 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Installing custom packages 2011-07-06 12:00:45,404 INFO oz.Guest.FedoraRemoteGuest pid(5231) Message: Uploading custom files 2011-07-06 12:00:45,404 DEBUG oz.Guest.FedoraRemoteGuest pid(5231) Message: Syncing 2011-07-06 12:00:46,131 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Customization step complete 2011-07-06 12:00:46,132 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Generating ICICLE from customized guest 2011-07-06 12:00:47,414 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: ICICLE generation complete 2011-07-06 12:00:47,414 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Re-de-activate firstboot just in case it has been revived during customize 2011-07-06 12:00:48,101 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: De-activation complete 2011-07-06 12:00:48,101 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Uploading cert material 2011-07-06 12:00:52,712 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Cert upload complete 2011-07-06 12:00:52,712 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Executing bundle vol command: euca-bundle-vol -c /tmp/tmpbhM7fd -k /tmp/tmpJCswFX -u 6735-0069-5950 -e /mnt,/tmp,/root/.ssh --arch x86_64 -d /mnt/bundles --kernel aki-427d952b -p baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82 -s 10240 --ec2cert /tmp/cert-ec2.pem --fstab /etc/fstab -v / 2011-07-06 12:04:30,011 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Bundle output: Filesystem label=/ OS type: Linux Block size=4096 (log=2) Fragment size=4096 (log=2) Stride=0 blocks, Stripe width=0 blocks 655360 inodes, 2621440 blocks 131072 blocks (5.00%) reserved for the super user First data block=0 Maximum filesystem blocks=2684354560 80 block groups 32768 blocks per group, 32768 fragments per group 8192 inodes per group Superblock backups stored on blocks: 32768, 98304, 163840, 229376, 294912, 819200, 884736, 1605632 Writing inode tables: done Creating journal (32768 blocks): done Writing superblocks and filesystem accounting information: done This filesystem will be automatically checked every 30 mounts or 180 days, whichever comes first. Use tune2fs -c or -i to override. Unable to read ramdisk id Unable to read product codes Unable to read product codes ['blkid', '-sFS_TYPE', '-ovalue', '/tmp/tmpGqPqBj/dev'] ['blkid', '-sUUID', '-ovalue', '/tmp/tmpGqPqBj/dev'] ['blkid', '-sLABEL', '-ovalue', '/tmp/tmpGqPqBj/dev'] Warning: rsync reports files partially copied: ('', 'rsync: rsync_xal_clear: lremovexattr("etc/ld.so.conf.d/.libc6-xen.conf.VjyAt9","security.selinux") failed: Permission denied (13)\nrsync: rsync_xal_clear: lremovexattr("etc/sysconfig/.cloud-info.FIfBKj","security.selinux") failed: Permission denied (13)\nrsync: rsync_xal_clear: lremovexattr("var/cache/ldconfig/.aux-cache.JK35nR","security.selinux") failed: Permission denied (13)\nrsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1042) [sender=3.0.7]\n') Checking image Encrypting image Splitting image... Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.00 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.01 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.02 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.03 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.04 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.05 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.06 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.07 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.08 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.09 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.10 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.11 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.12 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.13 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.14 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.15 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.16 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.17 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.18 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.19 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.20 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.21 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.22 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.23 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.24 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.25 Part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.26 Generating manifest /mnt/bundles/baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.manifest.xml 2011-07-06 12:04:31,837 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Executing upload bundle command: euca-upload-bundle -b imagefactory-ec2-us-east-1-6735-0069-5950 -m /mnt/bundles/baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.manifest.xml --ec2cert /tmp/cert-ec2.pem -a "AKIAJ557U7P7OIHRV2EQ" -s "7COhvBzxrz2agtOPgk3bZM7W3ej9QI/j6WvYiHdg" -U http://s3.amazonaws.com/ 2011-07-06 12:06:32,198 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Upload output: Checking bucket: imagefactory-ec2-us-east-1-6735-0069-5950 Uploading manifest file Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.00 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.01 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.02 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.03 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.04 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.05 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.06 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.07 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.08 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.09 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.10 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.11 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.12 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.13 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.14 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.15 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.16 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.17 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.18 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.19 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.20 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.21 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.22 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.23 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.24 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.25 Uploading part: baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.part.26 Uploaded image as imagefactory-ec2-us-east-1-6735-0069-5950/baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.manifest.xml 2011-07-06 12:06:32,198 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Executing register command: euca-register -U http://ec2.us-east-1.amazonaws.com/ -A "AKIAJ557U7P7OIHRV2EQ" -S "7COhvBzxrz2agtOPgk3bZM7W3ej9QI/j6WvYiHdg" imagefactory-ec2-us-east-1-6735-0069-5950/baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82.manifest.xml 2011-07-06 12:06:35,908 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Register output: IMAGE ami-b4b842dd 2011-07-06 12:06:35,909 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Extracted AMI ID: ami-b4b842dd 2011-07-06 12:06:35,914 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time... 2011-07-06 12:06:35,977 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'object_type': 'icicle', 'uuid': '142f59eb-d62e-4055-8814-25c58dca23d7'}) for http://localhost:9090/icicles/142f59eb-d62e-4055-8814-25c58dca23d7 2011-07-06 12:06:35,980 INFO imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Creating a bucket returned status 500. If only iwhd would provide a sane way to know if a bucket exists so we wouldn't have to try and create one every time... 2011-07-06 12:06:35,987 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'target_image': '5de7d16a-edf6-4fa4-b20f-094ade49b99b', 'uuid': 'baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82', 'icicle': '142f59eb-d62e-4055-8814-25c58dca23d7', 'target_identifier': 'ami-b4b842dd', 'object_type': 'provider_image', 'provider': 'ec2-us-east-1'}) for http://localhost:9090/provider_images/baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82 2011-07-06 12:06:35,995 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: Stopping EC2 instance and deleting temp security group 2011-07-06 12:06:38,670 DEBUG imagefactory.builders.BaseBuilder.FedoraBuilder pid(5231) Message: FedoraBuilder instance 140395233716432 pushed image with uuid 5de7d16a-edf6-4fa4-b20f-094ade49b99b to provider_image UUID (baaeb6f6-b5bc-4e61-ab0b-9d98d98b6c82) and set metadata: {'target_image': '5de7d16a-edf6-4fa4-b20f-094ade49b99b', 'target_identifier': 'ami-b4b842dd', 'icicle': '142f59eb-d62e-4055-8814-25c58dca23d7', 'provider': 'ec2-us-east-1'} 2011-07-06 12:06:38,670 DEBUG imagefactory.BuildJob.BuildAdaptor pid(5231) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed percent complete from 0 to 100 2011-07-06 12:06:38,671 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'latest_build': '42267e72-e58e-4ca4-9057-3df2347d89d7'}) for http://localhost:9090/images/3142d550-f608-4efd-ada9-9a6261aa8514 2011-07-06 12:06:38,673 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Setting metadata ({'latest_unpushed': None}) for http://localhost:9090/images/3142d550-f608-4efd-ada9-9a6261aa8514 2011-07-06 12:06:38,675 DEBUG imagefactory.BuildJob.BuildAdaptor pid(5231) Message: Raising event with agent handler (<ImageFactoryAgent(Thread-1, initial)>), changed status from PUSHING to COMPLETED 2011-07-06 12:11:56,397 DEBUG imagefactory.qmfagent.ImageFactoryAgent.ImageFactoryAgent pid(5231) Message: Method called: name = push_image args = {'credentials': '<provider_accounts>\n<provider_account>\n<name>rhevm</name>\n<provider>rhevm</provider>\n<provider_type>rhev-m</provider_type>\n<provider_credentials>\n <rhev-m_credentials>\n <password>100yard-</password>\n <username>rhev.eng.bos.redhat.com</username>\n </rhev-m_credentials>\n</provider_credentials>\n</provider_account>\n<provider_account>\n<name>wes-us-east-1</name>\n<provider>ec2-us-east-1</provider>\n<provider_type>ec2</provider_type>\n<provider_credentials>\n <ec2_credentials>\n <access_key>AKIAJ557U7P7OIHRV2EQ</access_key>\n <account_number>6735-0069-5950</account_number>\n <certificate>-----BEGIN CERTIFICATE-----\nMIICeDCCAeGgAwIBAgIGAIMhOJTUMA0GCSqGSIb3DQEBBQUAMFMxCzAJBgNVBAYT\nAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMQwwCgYDVQQLEwNBV1MxITAfBgNVBAMT\nGEFXUyBMaW1pdGVkLUFzc3VyYW5jZSBDQTAeFw0xMDA0MTkxNDU2MDRaFw0xMTA0\nMTkxNDU2MDRaMFMxCzAJBgNVBAYTAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMRcw\nFQYDVQQLEw5BV1MtRGV2ZWxvcGVyczEWMBQGA1UEAxMNMTNxb2pvMnhpa3AxMzCB\nnzANBgkqhkiG9w0BAQEFAAOBjQAwgYkCgYEAhsjKFoUJvEiZLdqALUAyFdDoeBKt\nZcqCRa5459+zp/d4XcykugpLlvcEfuKOrQcmqA08JWEN/4Xj4nIz+HoEtui3KFgg\n2YJ/VImlVeaSn4AGjfLsrEjLHnEBSGgNAJsh53fuEQTga8Y00T2qQ7d/Ebh6OXI3\niRKjY5Bm0d5mqrsCAwEAAaNXMFUwDgYDVR0PAQH/BAQDAgWgMBYGA1UdJQEB/wQM\nMAoGCCsGAQUFBwMCMAwGA1UdEwEB/wQCMAAwHQYDVR0OBBYEFDML4N2PsXn7nurg\n5bXHxMkFVQbLMA0GCSqGSIb3DQEBBQUAA4GBAIUGLc0R3HnEDXlXQMiLfQygqXEv\ndouihRgqCO+LOWb3tJbpk49TkhSFcjO0TJnKMb+XzuAdfswwgXSmwbbvrcDT/OdD\njHbCrLTCBBXIgShKZTrTYOAII5sokU4wg5QS0w9cEWcxceUWRaP8ELdai+ubrlif\noCeB2dgQxL18+uK5\n-----END CERTIFICATE-----\n</certificate>\n <key>-----BEGIN PRIVATE KEY-----\nMIICdQIBADANBgkqhkiG9w0BAQEFAASCAl8wggJbAgEAAoGBAIbIyhaFCbxImS3agC1AMhXQ6HgS
\nrWXKgkWueOffs6f3eF3MpLoKS5b3BH7ijq0HJqgNPCVhDf+F4+JyM/h6BLbotyhYINmCf1SJpVXm
\nkp+ABo3y7KxIyx5xAUhoDQCbIed37hEE4GvGNNE9qkO3fxG4ejlyN4kSo2OQZtHeZqq7AgMBAAEC
\ngYByI9mXZoRPET++5/mB2IpRlT84Z8C1od/eOJkk63kNtfEVpfadoZhPuNHyzdM7TgH7cHHNybn7
\n+Jt6KXI/ar1QDIse7S+xU700AWJVaUt3FqlrglmGT018oGWqH1/3D9/4yVsdvxCKcKYuvre3j2gU
\nsi7uJPpWYqCLhs41EuIUiQJBAPcuRXEtVV5MJipuYljERZHfxT4Yh/b8agfr1dsrHvd4jly9rJnE
\nIwB3vn0mMS9Fs/f0rUc3RAZRSrsuwYravU8CQQCLl+YDqZOwVfZIkJO2ipWb1xgjVuikLDRTYAXr
\n0NqbDdeBozAdPNVvicrGpg61J0Un6r5zjnkMFfS6SpM4bFjVAkAuwbz3DLlCTitGCX1nBzGVx3t7
\nJI7LpLG17+GTRNPlwhND7ckxiQ2J8BzDda8GHyxM8ia4+vZOL6BwSgboajo3AkAsiTjkYDzzXGmn
\n+yB1c7+JqdVUqQyuHEBRfWhGNSsZnw/rl1HpchgybsbYG/DDURUaSCWdHo52EaczrElODhtFAkAU
\n95df+umPXSwSzFaSCVVaGm7QlH8yBx8nFHF+yeFPV5QmDWmj59Y9UM6vM4MHtUAdpEhIzzAoI/Et
\nlMA4EBbB
\n-----END PRIVATE KEY-----\n</key>\n <secret_access_key>7COhvBzxrz2agtOPgk3bZM7W3ej9QI/j6WvYiHdg</secret_access_key>\n </ec2_credentials>\n</provider_credentials>\n</provider_account>\n<provider_account>\n<name>wes-us-west-1</name>\n<provider>ec2-us-west-1</provider>\n<provider_type>ec2</provider_type>\n<provider_credentials>\n <ec2_credentials>\n <access_key>AKIAJ557U7P7OIHRV2EQ</access_key>\n <account_number>6735-0069-5950</account_number>\n <certificate>-----BEGIN CERTIFICATE-----\nMIICeDCCAeGgAwIBAgIGAIMhOJTUMA0GCSqGSIb3DQEBBQUAMFMxCzAJBgNVBAYT\nAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMQwwCgYDVQQLEwNBV1MxITAfBgNVBAMT\nGEFXUyBMaW1pdGVkLUFzc3VyYW5jZSBDQTAeFw0xMDA0MTkxNDU2MDRaFw0xMTA0\nMTkxNDU2MDRaMFMxCzAJBgNVBAYTAlVTMRMwEQYDVQQKEwpBbWF6b24uY29tMRcw\nFQYDVQQLEw5BV1MtRGV2ZWxvcGVyczEWMBQGA1UEAxMNMTNxb2pvMnhpa3AxMzCB\nnzANBgkqhkiG9w0BAQEFAAOBjQAwgYkCgYEAhsjKFoUJvEiZLdqALUAyFdDoeBKt\nZcqCRa5459+zp/d4XcykugpLlvcEfuKOrQcmqA08JWEN/4Xj4nIz+HoEtui3KFgg\n2YJ/VImlVeaSn4AGjfLsrEjLHnEBSGgNAJsh53fuEQTga8Y00T2qQ7d/Ebh6OXI3\niRKjY5Bm0d5mqrsCAwEAAaNXMFUwDgYDVR0PAQH/BAQDAgWgMBYGA1UdJQEB/wQM\nMAoGCCsGAQUFBwMCMAwGA1UdEwEB/wQCMAAwHQYDVR0OBBYEFDML4N2PsXn7nurg\n5bXHxMkFVQbLMA0GCSqGSIb3DQEBBQUAA4GBAIUGLc0R3HnEDXlXQMiLfQygqXEv\ndouihRgqCO+LOWb3tJbpk49TkhSFcjO0TJnKMb+XzuAdfswwgXSmwbbvrcDT/OdD\njHbCrLTCBBXIgShKZTrTYOAII5sokU4wg5QS0w9cEWcxceUWRaP8ELdai+ubrlif\noCeB2dgQxL18+uK5\n-----END CERTIFICATE-----\n</certificate>\n <key>-----BEGIN PRIVATE KEY-----\nMIICdQIBADANBgkqhkiG9w0BAQEFAASCAl8wggJbAgEAAoGBAIbIyhaFCbxImS3agC1AMhXQ6HgS
\nrWXKgkWueOffs6f3eF3MpLoKS5b3BH7ijq0HJqgNPCVhDf+F4+JyM/h6BLbotyhYINmCf1SJpVXm
\nkp+ABo3y7KxIyx5xAUhoDQCbIed37hEE4GvGNNE9qkO3fxG4ejlyN4kSo2OQZtHeZqq7AgMBAAEC
\ngYByI9mXZoRPET++5/mB2IpRlT84Z8C1od/eOJkk63kNtfEVpfadoZhPuNHyzdM7TgH7cHHNybn7
\n+Jt6KXI/ar1QDIse7S+xU700AWJVaUt3FqlrglmGT018oGWqH1/3D9/4yVsdvxCKcKYuvre3j2gU
\nsi7uJPpWYqCLhs41EuIUiQJBAPcuRXEtVV5MJipuYljERZHfxT4Yh/b8agfr1dsrHvd4jly9rJnE
\nIwB3vn0mMS9Fs/f0rUc3RAZRSrsuwYravU8CQQCLl+YDqZOwVfZIkJO2ipWb1xgjVuikLDRTYAXr
\n0NqbDdeBozAdPNVvicrGpg61J0Un6r5zjnkMFfS6SpM4bFjVAkAuwbz3DLlCTitGCX1nBzGVx3t7
\nJI7LpLG17+GTRNPlwhND7ckxiQ2J8BzDda8GHyxM8ia4+vZOL6BwSgboajo3AkAsiTjkYDzzXGmn
\n+yB1c7+JqdVUqQyuHEBRfWhGNSsZnw/rl1HpchgybsbYG/DDURUaSCWdHo52EaczrElODhtFAkAU
\n95df+umPXSwSzFaSCVVaGm7QlH8yBx8nFHF+yeFPV5QmDWmj59Y9UM6vM4MHtUAdpEhIzzAoI/Et
\nlMA4EBbB
\n-----END PRIVATE KEY-----\n</key>\n <secret_access_key>7COhvBzxrz2agtOPgk3bZM7W3ej9QI/j6WvYiHdg</secret_access_key>\n </ec2_credentials>\n</provider_credentials>\n</provider_account>\n</provider_accounts>\n', 'image': '3142d550-f608-4efd-ada9-9a6261aa8514', 'build': '', 'providers': ['ec2-us-west-1']} handle = <cqmf2.AgentEvent; proxy of <Swig Object of type 'qmf::AgentEvent *' at 0x1d35cf0> > addr = redhat.com:imagefactory:a9e43167-c645-41c3-81a3-19ef5dc5bb44:image_factory subtypes = {} userId = anonymous 2011-07-06 12:11:56,398 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Getting metadata (['latest_unpushed']) from http://localhost:9090/images/3142d550-f608-4efd-ada9-9a6261aa8514 2011-07-06 12:11:56,399 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Querying (http://localhost:9090/target_images/_query) with expression ($build == "None" && $target == "ec2") 2011-07-06 12:11:56,401 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Getting metadata (['template']) from http://localhost:9090/target_images/None 2011-07-06 12:11:56,402 DEBUG imagefactory.ImageWarehouse.ImageWarehouse pid(5231) Message: Created Image Warehouse instance http://localhost:9090 - buckets(target_images, templates, icicles, provider_images) 2011-07-06 12:11:56,403 ERROR imagefactory.qmfagent.ImageFactoryAgent.ImageFactoryAgent pid(5231) Message: 'template' must be a UUID, URL, XML string or XML document path... Traceback (most recent call last): File "/usr/lib/python2.7/site-packages/imagefactory/qmfagent/ImageFactoryAgent.py", line 74, in method result = getattr(target_obj, methodName)(**args) File "/usr/lib/python2.7/site-packages/imagefactory/qmfagent/ImageFactory.py", line 125, in push_image return BuildDispatcher().push_image_to_providers(image, build, providers, credentials, BuildAdaptor, self.agent) File "/usr/lib/python2.7/site-packages/imagefactory/BuildDispatcher.py", line 78, in push_image_to_providers job = job_cls(template, target, image_id, build_id, *args, **kwargs) File "/usr/lib/python2.7/site-packages/imagefactory/qmfagent/BuildAdaptor.py", line 76, in __init__ super(BuildAdaptor, self).__init__(template, target, image_id, build_id) File "/usr/lib/python2.7/site-packages/imagefactory/BuildJob.py", line 42, in __init__ self.template = template if isinstance(template, Template) else Template(template) File "/usr/lib/python2.7/site-packages/imagefactory/Template.py", line 83, in __init__ raise ValueError("'template' must be a UUID, URL, XML string or XML document path...") ValueError: 'template' must be a UUID, URL, XML string or XML document path...