Attachment 575303 Details for Bug 805231 – RHEL5-U8 image factory logs

RHEL5-U8 image factory logs

imagefactory.log (text/x-log), 22.79 KB, created by pushpesh sharma on 2012-04-05 07:25:56 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: pushpesh sharma

Created: 2012-04-05 07:25:56 UTC

Size: 22.79 KB

patch

obsolete

>2012-04-05 03:10:25,979 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:10:38,170 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:10:38,218 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(worker 0) Message: Created Image Warehouse instance http://localhost:9090 - buckets(target_images, templates, icicles, provider_images)
>2012-04-05 03:10:38,219 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(worker 0) Message: Image Warehouse returned status (500) with message: 
>2012-04-05 03:10:38,220 INFO imgfac.ImageWarehouse.ImageWarehouse thread(worker 0) Message: Creating a bucket returned status (500), .
>2012-04-05 03:10:38,229 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(worker 0) Message: Setting metadata ({'object_type': 'template', 'uuid': '1dab7e9e-6a08-4e8e-8212-c602fabcf4ec'}) for http://localhost:9090/templates/1dab7e9e-6a08-4e8e-8212-c602fabcf4ec
>2012-04-05 03:10:38,312 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(worker 0) Message: Image Warehouse returned status (500) with message: 
>2012-04-05 03:10:38,312 INFO imgfac.ImageWarehouse.ImageWarehouse thread(worker 0) Message: Creating a bucket returned status (500), .
>2012-04-05 03:10:38,314 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(worker 0) Message: Setting metadata ({'timestamp': '1333609838.31', 'image': '6a956e96-7eee-11e1-8855-00215e20316a', 'object_type': 'build', 'uuid': '45168494-d6f5-4ba0-8cb7-d09310b9b3ee'}) for http://localhost:9090/builds/45168494-d6f5-4ba0-8cb7-d09310b9b3ee
>2012-04-05 03:10:38,480 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(worker 0) Message: Created Image Warehouse instance http://localhost:9090 - buckets(target_images, templates, icicles, provider_images)
>2012-04-05 03:10:38,481 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(worker 0) Message: Found neither a call-time config nor a config file - doing nothing
>2012-04-05 03:10:38,483 DEBUG imgfac.BuildJob.BuildJob thread(f22f849a) Message: f22f849a-7ac3-4109-848e-8c6eb319ec52 for ec2 about to enter None queue...
>2012-04-05 03:10:38,484 DEBUG imgfac.BuildJob.BuildJob thread(f22f849a) Message: Builder (f22f849a-7ac3-4109-848e-8c6eb319ec52) changed status from NEW to BUILDING
>2012-04-05 03:10:38,484 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(f22f849a) Message: Building Linux for non-upload cloud (ec2)
>2012-04-05 03:10:38,486 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(f22f849a) Message: Storing placeholder object for non upload cloud image
>2012-04-05 03:10:38,488 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Image Warehouse returned status (500) with message: 
>2012-04-05 03:10:38,488 INFO imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Creating a bucket returned status (500), .
>2012-04-05 03:10:38,491 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Setting metadata ({'object_type': 'template', 'uuid': '1dab7e9e-6a08-4e8e-8212-c602fabcf4ec'}) for http://localhost:9090/templates/1dab7e9e-6a08-4e8e-8212-c602fabcf4ec
>2012-04-05 03:10:38,574 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Image Warehouse returned status (500) with message: 
>2012-04-05 03:10:38,574 INFO imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Creating a bucket returned status (500), .
>2012-04-05 03:10:38,574 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Uploading 0kB of 0kB
>2012-04-05 03:10:38,575 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Uploading 0kB of 0kB
>2012-04-05 03:10:38,575 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Uploading 0kB of 0kB
>2012-04-05 03:10:38,576 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Uploading 0kB of 0kB
>2012-04-05 03:10:38,576 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Uploading 0kB of 0kB
>2012-04-05 03:10:38,576 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Uploading 0kB of 0kB
>2012-04-05 03:10:38,576 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Setting metadata ({'icicle': 'none', 'uuid': 'f22f849a-7ac3-4109-848e-8c6eb319ec52', 'template': '1dab7e9e-6a08-4e8e-8212-c602fabcf4ec', 'target_parameters': None, 'object_type': 'target_image', 'target': 'ec2', 'build': '45168494-d6f5-4ba0-8cb7-d09310b9b3ee'}) for http://localhost:9090/target_images/f22f849a-7ac3-4109-848e-8c6eb319ec52
>2012-04-05 03:10:38,820 DEBUG imgfac.BuildJob.BuildJob thread(f22f849a) Message: Builder (f22f849a-7ac3-4109-848e-8c6eb319ec52) changed percent complete from 0 to 100
>2012-04-05 03:10:38,820 DEBUG imgfac.BuildJob.BuildJob thread(f22f849a) Message: Builder (f22f849a-7ac3-4109-848e-8c6eb319ec52) changed status from BUILDING to COMPLETED
>2012-04-05 03:10:38,820 DEBUG imgfac.BuildJob.BuildJob thread(f22f849a) Message: f22f849a-7ac3-4109-848e-8c6eb319ec52 for ec2 about to exit None queue...
>2012-04-05 03:10:38,820 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Getting metadata (['latest_unpushed']) from http://localhost:9090/images/6a956e96-7eee-11e1-8855-00215e20316a
>2012-04-05 03:10:38,821 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Image Warehouse returned status (404) with message: 
>2012-04-05 03:10:38,821 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Getting metadata (['latest_build']) from http://localhost:9090/images/6a956e96-7eee-11e1-8855-00215e20316a
>2012-04-05 03:10:38,823 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Image Warehouse returned status (404) with message: 
>2012-04-05 03:10:38,823 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(f22f849a) Message: Setting metadata ({'latest_unpushed': '45168494-d6f5-4ba0-8cb7-d09310b9b3ee'}) for http://localhost:9090/images/6a956e96-7eee-11e1-8855-00215e20316a
>2012-04-05 03:10:38,825 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(f22f849a) Message: Completed placeholder warehouse object for linux non-upload image...
>2012-04-05 03:10:38,912 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:10:47,531 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:10:47,574 DEBUG imgfac.BuildDispatcher.BuildDispatcher thread(worker 2) Message: Testing provider for XML: syntax error: line 1, column 0
>2012-04-05 03:10:47,574 DEBUG imgfac.BuildDispatcher.BuildDispatcher thread(worker 2) Message: Testing provider for JSON: No JSON object could be decoded
>2012-04-05 03:10:47,574 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(worker 2) Message: Querying (http://localhost:9090/target_images/_query) with expression ($build == "45168494-d6f5-4ba0-8cb7-d09310b9b3ee" && $target == "ec2")
>2012-04-05 03:10:47,615 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(worker 2) Message: Getting metadata (['template']) from http://localhost:9090/target_images/f22f849a-7ac3-4109-848e-8c6eb319ec52
>2012-04-05 03:10:47,616 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(worker 2) Message: Created Image Warehouse instance http://localhost:9090 - buckets(target_images, templates, icicles, provider_images)
>2012-04-05 03:10:47,619 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(worker 2) Message: Created Image Warehouse instance http://localhost:9090 - buckets(target_images, templates, icicles, provider_images)
>2012-04-05 03:10:47,620 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(worker 2) Message: Found neither a call-time config nor a config file - doing nothing
>2012-04-05 03:10:48,104 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:10:48,987 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: Original URL http://download.eng.pnq.redhat.com/pub/rhel/released/RHEL-5-Server/U8/x86_64/os/ resolved to http://download.eng.pnq.redhat.com/pub/rhel/released/RHEL-5-Server/U8/x86_64/os/
>2012-04-05 03:10:48,987 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: Name: factory-build-9e5933fe-6a76-45e5-8d7f-028a697cab0e, UUID: da19f85a-a7ef-41b4-b008-760cb2381f83
>2012-04-05 03:10:48,987 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: MAC: 52:54:00:dd:f7:1a, distro: RHEL-5
>2012-04-05 03:10:48,987 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: update: U8, arch: x86_64, diskimage: /var/lib/imagefactory/images/factory-build-9e5933fe-6a76-45e5-8d7f-028a697cab0e.dsk
>2012-04-05 03:10:48,987 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: nicmodel: virtio, clockoffset: utc
>2012-04-05 03:10:48,987 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: mousetype: ps2, disk_bus: virtio, disk_dev: vda
>2012-04-05 03:10:48,987 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: icicletmp: /var/lib/oz/icicletmp/factory-build-9e5933fe-6a76-45e5-8d7f-028a697cab0e, listen_port: 45254
>2012-04-05 03:10:48,987 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: Original ISO path: /var/lib/oz/isos/RHEL-5U8x86_64-url.iso
>2012-04-05 03:10:48,987 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: Modified ISO cache: /var/lib/oz/isos/RHEL-5U8x86_64-url-oz.iso
>2012-04-05 03:10:48,988 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: Output ISO path: /var/lib/imagefactory/images/factory-build-9e5933fe-6a76-45e5-8d7f-028a697cab0e-url-oz.iso
>2012-04-05 03:10:48,988 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: ISO content path: /var/lib/oz/isocontent/factory-build-9e5933fe-6a76-45e5-8d7f-028a697cab0e-url
>2012-04-05 03:10:48,988 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Being asked to push for provider ec2-ap-southeast-1
>2012-04-05 03:10:48,988 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: distro: RHEL-5 - update: U8 - arch: x86_64
>2012-04-05 03:10:48,989 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: acting as EC2 user: 5558-3213-4843
>2012-04-05 03:10:48,989 DEBUG imgfac.BuildJob.BuildJob thread(9e5933fe) Message: 9e5933fe-6a76-45e5-8d7f-028a697cab0e for ec2 about to enter ec2 queue...
>2012-04-05 03:10:48,989 DEBUG imgfac.ReservationManager.ReservationManager thread(9e5933fe) Message: ENTERING queue: (ec2)
>2012-04-05 03:10:48,989 DEBUG imgfac.ReservationManager.ReservationManager thread(9e5933fe) Message: SUCCESS ENTERING queue: (ec2)
>2012-04-05 03:10:48,989 DEBUG imgfac.BuildJob.BuildJob thread(9e5933fe) Message: Builder (9e5933fe-6a76-45e5-8d7f-028a697cab0e) changed status from NEW to PUSHING
>2012-04-05 03:10:48,990 DEBUG imgfac.BuildJob.BuildJob thread(9e5933fe) Message: Builder (9e5933fe-6a76-45e5-8d7f-028a697cab0e) changed percent complete from 0 to 0
>2012-04-05 03:10:50,955 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Creating temporary security group (imagefactory-9e5933fe-6a76-45e5-8d7f-028a697cab0e)
>2012-04-05 03:10:57,420 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Starting ami ami-da8dc988 with instance_type m1.large
>2012-04-05 03:10:58,548 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Waiting for EC2 instance to start: 0/300
>2012-04-05 03:11:14,983 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Waiting for EC2 instance to start: 10/300
>2012-04-05 03:11:19,548 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:11:20,574 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Waiting for EC2 ssh access: 0/300
>2012-04-05 03:11:49,666 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:12:05,899 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Waiting for EC2 ssh access: 10/300
>2012-04-05 03:12:19,529 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:12:25,159 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Waiting 20 seconds for remaining boot tasks
>2012-04-05 03:12:45,165 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Stopping cron and killing any updatedb process that may be running
>2012-04-05 03:12:49,525 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:12:52,958 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Done
>2012-04-05 03:12:52,958 INFO imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Creating cloud-info file indicating target (ec2)
>2012-04-05 03:12:56,855 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Customizing guest: ec2-122-248-211-131.ap-southeast-1.compute.amazonaws.com
>2012-04-05 03:12:56,856 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: Installing additional repository files
>2012-04-05 03:12:56,856 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: Installing custom packages
>2012-04-05 03:12:56,856 INFO oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: Uploading custom files
>2012-04-05 03:12:56,856 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: Running custom commands
>2012-04-05 03:12:56,856 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: Removing non-persisted repos
>2012-04-05 03:12:56,856 DEBUG oz.Guest.RHEL5RemoteGuest thread(9e5933fe) Message: Syncing
>2012-04-05 03:13:00,600 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Customization step complete
>2012-04-05 03:13:00,601 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Generating ICICLE from customized guest
>2012-04-05 03:13:05,825 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: ICICLE generation complete
>2012-04-05 03:13:05,825 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Re-de-activate firstboot just in case it has been revived during customize
>2012-04-05 03:13:09,765 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: De-activation complete
>2012-04-05 03:13:09,765 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Performing image prep tasks for EBS backed images
>2012-04-05 03:13:09,765 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Removing existing authorized_keys file to allow key injection on RHEL reboot
>2012-04-05 03:13:13,859 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Creating a new EBS backed image from our running EBS instance
>2012-04-05 03:13:14,566 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: EUCA creat_image call returned AMI ID: ami-56763104
>2012-04-05 03:13:14,566 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Now waiting for AMI to become available
>2012-04-05 03:13:19,528 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:13:25,971 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [0 of 1200 seconds elapsed]
>2012-04-05 03:13:36,746 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [10 of 1200 seconds elapsed]
>2012-04-05 03:13:47,389 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [20 of 1200 seconds elapsed]
>2012-04-05 03:13:49,542 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:13:58,162 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [30 of 1200 seconds elapsed]
>2012-04-05 03:14:08,800 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [40 of 1200 seconds elapsed]
>2012-04-05 03:14:19,445 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [50 of 1200 seconds elapsed]
>2012-04-05 03:14:19,534 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:14:30,086 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [60 of 1200 seconds elapsed]
>2012-04-05 03:14:40,724 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [70 of 1200 seconds elapsed]
>2012-04-05 03:14:49,669 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:14:51,363 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [80 of 1200 seconds elapsed]
>2012-04-05 03:15:02,014 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [90 of 1200 seconds elapsed]
>2012-04-05 03:15:12,666 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [100 of 1200 seconds elapsed]
>2012-04-05 03:15:19,539 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:15:23,308 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [110 of 1200 seconds elapsed]
>2012-04-05 03:15:33,942 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [120 of 1200 seconds elapsed]
>2012-04-05 03:15:44,579 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [130 of 1200 seconds elapsed]
>2012-04-05 03:15:49,813 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:15:55,226 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: AMI status (pending) - waiting for 'available' - [140 of 1200 seconds elapsed]
>2012-04-05 03:16:06,015 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(9e5933fe) Message: Image Warehouse returned status (500) with message: 
>2012-04-05 03:16:06,015 INFO imgfac.ImageWarehouse.ImageWarehouse thread(9e5933fe) Message: Creating a bucket returned status (500), .
>2012-04-05 03:16:06,018 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(9e5933fe) Message: Setting metadata ({'object_type': 'icicle', 'uuid': 'e8adb1d7-d2da-49e2-ab78-2b5b645b95c8'}) for http://localhost:9090/icicles/e8adb1d7-d2da-49e2-ab78-2b5b645b95c8
>2012-04-05 03:16:06,101 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(9e5933fe) Message: Image Warehouse returned status (500) with message: 
>2012-04-05 03:16:06,101 INFO imgfac.ImageWarehouse.ImageWarehouse thread(9e5933fe) Message: Creating a bucket returned status (500), .
>2012-04-05 03:16:06,104 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(9e5933fe) Message: Setting metadata ({'provider_account_identifier': 'AKIAIXL2ECBLMAI5GEKQ', 'target_image': 'f22f849a-7ac3-4109-848e-8c6eb319ec52', 'uuid': '9e5933fe-6a76-45e5-8d7f-028a697cab0e', 'icicle': 'e8adb1d7-d2da-49e2-ab78-2b5b645b95c8', 'target_identifier': u'ami-56763104', 'object_type': 'provider_image', 'provider': 'ec2-ap-southeast-1'}) for http://localhost:9090/provider_images/9e5933fe-6a76-45e5-8d7f-028a697cab0e
>2012-04-05 03:16:06,391 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Terminating EC2 instance and deleting temp security group
>2012-04-05 03:16:08,579 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Instance status (shutting-down) - waiting for 'terminated'. [0 of 300 seconds elapsed]
>2012-04-05 03:16:14,221 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Instance status (shutting-down) - waiting for 'terminated'. [5 of 300 seconds elapsed]
>2012-04-05 03:16:19,828 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:16:19,861 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Instance status (shutting-down) - waiting for 'terminated'. [10 of 300 seconds elapsed]
>2012-04-05 03:16:25,504 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Instance status (shutting-down) - waiting for 'terminated'. [15 of 300 seconds elapsed]
>2012-04-05 03:16:31,182 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Instance status (shutting-down) - waiting for 'terminated'. [20 of 300 seconds elapsed]
>2012-04-05 03:16:36,828 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Instance status (shutting-down) - waiting for 'terminated'. [25 of 300 seconds elapsed]
>2012-04-05 03:16:43,863 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Removed temporary security group (imagefactory-9e5933fe-6a76-45e5-8d7f-028a697cab0e)
>2012-04-05 03:16:43,864 DEBUG imgfac.builders.BaseBuilder.RHEL5_ec2_Builder thread(9e5933fe) Message: Fedora_ec2_Builder instance 140556429063568 pushed image with uuid f22f849a-7ac3-4109-848e-8c6eb319ec52 to provider_image UUID (9e5933fe-6a76-45e5-8d7f-028a697cab0e) and set metadata: {'provider_account_identifier': 'AKIAIXL2ECBLMAI5GEKQ', 'target_image': 'f22f849a-7ac3-4109-848e-8c6eb319ec52', 'target_identifier': u'ami-56763104', 'icicle': 'e8adb1d7-d2da-49e2-ab78-2b5b645b95c8', 'provider': 'ec2-ap-southeast-1'}
>2012-04-05 03:16:43,864 DEBUG imgfac.BuildJob.BuildJob thread(9e5933fe) Message: Builder (9e5933fe-6a76-45e5-8d7f-028a697cab0e) changed percent complete from 0 to 100
>2012-04-05 03:16:43,864 DEBUG imgfac.BuildJob.BuildJob thread(9e5933fe) Message: Builder (9e5933fe-6a76-45e5-8d7f-028a697cab0e) changed status from PUSHING to COMPLETED
>2012-04-05 03:16:43,864 DEBUG imgfac.BuildJob.BuildJob thread(9e5933fe) Message: 9e5933fe-6a76-45e5-8d7f-028a697cab0e for ec2 about to exit ec2 queue...
>2012-04-05 03:16:43,864 DEBUG imgfac.ReservationManager.ReservationManager thread(9e5933fe) Message: EXITING queue: (ec2)
>2012-04-05 03:16:43,864 DEBUG imgfac.ReservationManager.ReservationManager thread(9e5933fe) Message: SUCCESS EXITING queue: (ec2)
>2012-04-05 03:16:43,864 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(9e5933fe) Message: Setting metadata ({'latest_build': '45168494-d6f5-4ba0-8cb7-d09310b9b3ee'}) for http://localhost:9090/images/6a956e96-7eee-11e1-8855-00215e20316a
>2012-04-05 03:16:43,867 DEBUG imgfac.ImageWarehouse.ImageWarehouse thread(9e5933fe) Message: Setting metadata ({'latest_unpushed': None}) for http://localhost:9090/images/6a956e96-7eee-11e1-8855-00215e20316a
>2012-04-05 03:16:49,543 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>2012-04-05 03:17:19,531 DEBUG paste.httpserver.ThreadPool thread(MainThread) Message: Added task (0 tasks queued)
>

Actions: View

Attachments on bug 805231: 575303