Bug 766414

Summary: RHEL57 built w/ imagefactory kernel panic when launching in vsphere 4.x
Product: [Retired] CloudForms Cloud Engine Reporter: wes hayutin <whayutin>
Component: imagefactoryAssignee: Ian McLeod <imcleod>
Status: CLOSED ERRATA QA Contact: Martin Kočí <mkoci>
Severity: unspecified Docs Contact:
Priority: unspecified    
Version: 1.0.0CC: akarol, brad, dajohnso, deltacloud-maint, dgao, jrd, ssachdev, whayutin
Target Milestone: rc   
Target Release: ---   
Hardware: Unspecified   
OS: Unspecified   
Whiteboard:
Fixed In Version: Doc Type: Bug Fix
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2012-05-15 20:21:26 UTC Type: ---
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:

Description wes hayutin 2011-12-12 01:33:48 UTC 
Description of problem:

 <template>
   <name>RHEL5_VMWareTools</name>
   <os>    
     <name>RHEL-5</name>    
     <version>U7</version>
     <arch>x86_64</arch>
     <rootpw>asdf</rootpw>
     <install type="url">
       <url>http://download.devel.redhat.com/released/RHEL-5-Server/U7/x86_64/os/</url>
     </install>
   </os>
   <description>RHEL57 x86_64 and VMWareTools</description>
  <repositories>
     <repository name='vmwareTools'>
       <url>http://packages.vmware.com/tools/esx/4.1u1/rhel5/x86_64</url>
       <signed>False</signed>
     </repository>
  </repositories>
   <packages>
     <package name='vmware-open-vm-tools-nox'/> 
   </packages>
 </template>



2011-12-11 15:21:16,203 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Going to write treeinfo to /var/lib/oz/icicletmp/RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0/treeinfo
2011-12-11 15:21:16,203 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Trying to get treeinfo from http://download.devel.redhat.com/released/RHEL-5-Server/U7/x86_64/os//.treeinfo
2011-12-11 15:21:16,319 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Got treeinfo, parsing
2011-12-11 15:21:16,320 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Returning kernel images/pxeboot/vmlinuz and initrd images/pxeboot/initrd.img
2011-12-11 15:21:16,320 INFO oz.Guest.RHEL5Guest pid(9383) Message: Fetching the original media
2011-12-11 15:21:16,320 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Attempting to get the lock for /var/lib/oz/kernels/RHEL-5U7x86_64-kernel
2011-12-11 15:21:16,321 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Got the lock, doing the download
2011-12-11 15:21:16,455 INFO oz.Guest.RHEL5Guest pid(9383) Message: Fetching the original install media from http://download.devel.redhat.com/released/RHEL-5-Server/U7/x86_64/os/images/pxeboot/vmlinuz
2011-12-11 15:21:16,558 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: 0kB of 2056kB
2011-12-11 15:21:17,393 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: 2056kB of 2056kB
2011-12-11 15:21:17,393 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: 2056kB of 2056kB
2011-12-11 15:21:17,393 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: 2056kB of 2056kB
2011-12-11 15:21:17,393 INFO oz.Guest.RHEL5Guest pid(9383) Message: Fetching the original media
2011-12-11 15:21:17,394 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Attempting to get the lock for /var/lib/oz/kernels/RHEL-5U7x86_64-ramdisk
2011-12-11 15:21:17,394 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Got the lock, doing the download
2011-12-11 15:21:17,506 INFO oz.Guest.RHEL5Guest pid(9383) Message: Fetching the original install media from http://download.devel.redhat.com/released/RHEL-5-Server/U7/x86_64/os/images/pxeboot/initrd.img
2011-12-11 15:21:17,608 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: 0kB of 11106kB
2011-12-11 15:21:19,374 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: 10240kB of 11106kB
2011-12-11 15:21:19,506 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: 11106kB of 11106kB
2011-12-11 15:21:19,748 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: 11106kB of 11106kB
2011-12-11 15:21:19,748 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: 11106kB of 11106kB
2011-12-11 15:21:19,755 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Putting the kickstart in place
2011-12-11 15:21:19,755 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Writing cpio to /var/lib/oz/icicletmp/RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0/extra.cpio
2011-12-11 15:21:19,782 DEBUG imgfac.BuildJob.BuildJob pid(9383) Message: Builder (94b35b19-71b8-46d1-813c-f612105b40f0) changed percent complete from 0 to 10
2011-12-11 15:21:19,782 INFO oz.Guest.RHEL5Guest pid(9383) Message: Generating 10GB diskimage for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0
2011-12-11 15:21:19,783 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Doing base install via Oz
2011-12-11 15:21:19,783 INFO oz.Guest.RHEL5Guest pid(9383) Message: Running install for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0
2011-12-11 15:21:19,783 INFO oz.Guest.RHEL5Guest pid(9383) Message: Generate XML for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 with bootdev None
2011-12-11 15:21:19,784 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Generated XML:
<?xml version="1.0"?>
<domain type="kvm">
  <name>RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0</name>
  <memory>1048576</memory>
  <currentMemory>1048576</currentMemory>
  <uuid>21acff52-2a24-47d6-841e-f36b1797d9f3</uuid>
  <clock offset="utc"/>
  <vcpu>1</vcpu>
  <features>
    <acpi/>
    <apic/>
    <pae/>
  </features>
  <os>
    <type>hvm</type>
    <kernel>/var/lib/imagefactory/images/RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0-kernel</kernel>
    <initrd>/var/lib/imagefactory/images/RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0-ramdisk</initrd>
    <cmdline>method=http://download.devel.redhat.com/released/RHEL-5-Server/U7/x86_64/os/ ks=file:/ks.cfg</cmdline>
  </os>
  <on_poweroff>destroy</on_poweroff>
  <on_reboot>destroy</on_reboot>
  <on_crash>destroy</on_crash>
  <devices>
    <console device="pty"/>
    <graphics port="-1" type="vnc"/>
    <interface type="bridge">
      <source bridge="virbr0"/>
      <mac address="52:54:00:c2:b5:ab"/>
      <model type="virtio"/>
    </interface>
    <input bus="ps2" type="mouse"/>
    <console type="pty">
      <target port="0"/>
    </console>
    <serial type="tcp">
      <source mode="bind" host="127.0.0.1" service="22484"/>
      <protocol type="raw"/>
      <target port="1"/>
    </serial>
    <disk device="disk" type="file">
      <target dev="vda" bus="virtio"/>
      <source file="/var/lib/imagefactory/images/base-image-94b35b19-71b8-46d1-813c-f612105b40f0.dsk"/>
    </disk>
  </devices>
</domain>

2011-12-11 15:21:20,281 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3600/3600
2011-12-11 15:21:30,376 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3590/3600
2011-12-11 15:21:40,525 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3580/3600
2011-12-11 15:21:50,603 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3570/3600
2011-12-11 15:22:00,728 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3560/3600
2011-12-11 15:22:10,841 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3550/3600
2011-12-11 15:22:20,999 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3540/3600
2011-12-11 15:22:31,094 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3530/3600
2011-12-11 15:22:41,161 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3520/3600
2011-12-11 15:22:51,256 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3510/3600
2011-12-11 15:23:01,313 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3500/3600
2011-12-11 15:23:11,436 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3490/3600
2011-12-11 15:23:16,228 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:23:21,492 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3480/3600
2011-12-11 15:23:31,550 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3470/3600
2011-12-11 15:23:41,670 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3460/3600
2011-12-11 15:23:51,809 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3450/3600
2011-12-11 15:24:01,951 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3440/3600
2011-12-11 15:24:12,076 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3430/3600
2011-12-11 15:24:22,143 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3420/3600
2011-12-11 15:24:32,208 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3410/3600
2011-12-11 15:24:42,263 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3400/3600
2011-12-11 15:24:52,317 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3390/3600
2011-12-11 15:25:02,376 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3380/3600
2011-12-11 15:25:12,439 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3370/3600
2011-12-11 15:25:16,399 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:25:22,514 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3360/3600
2011-12-11 15:25:32,569 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3350/3600
2011-12-11 15:25:42,627 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3340/3600
2011-12-11 15:25:52,686 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3330/3600
2011-12-11 15:26:02,743 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3320/3600
2011-12-11 15:26:12,801 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3310/3600
2011-12-11 15:26:22,917 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3300/3600
2011-12-11 15:26:32,977 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3290/3600
2011-12-11 15:26:43,045 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3280/3600
2011-12-11 15:26:53,112 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3270/3600
2011-12-11 15:27:03,171 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3260/3600
2011-12-11 15:27:13,229 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3250/3600
2011-12-11 15:27:16,580 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:27:23,286 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3240/3600
2011-12-11 15:27:33,344 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3230/3600
2011-12-11 15:27:43,457 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3220/3600
2011-12-11 15:27:53,522 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3210/3600
2011-12-11 15:28:03,577 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3200/3600
2011-12-11 15:28:13,646 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3190/3600
2011-12-11 15:28:23,732 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3180/3600
2011-12-11 15:28:33,825 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3170/3600
2011-12-11 15:28:43,880 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3160/3600
2011-12-11 15:28:53,944 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3150/3600
2011-12-11 15:29:04,027 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3140/3600
2011-12-11 15:29:14,181 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3130/3600
2011-12-11 15:29:16,760 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:29:24,239 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3120/3600
2011-12-11 15:29:34,326 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3110/3600
2011-12-11 15:29:44,382 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3100/3600
2011-12-11 15:29:54,484 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3090/3600
2011-12-11 15:30:04,548 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3080/3600
2011-12-11 15:30:14,610 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3070/3600
2011-12-11 15:30:24,668 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to finish installing, 3060/3600
2011-12-11 15:30:30,756 INFO oz.Guest.RHEL5Guest pid(9383) Message: Install of RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 succeeded
2011-12-11 15:30:30,757 INFO oz.Guest.RHEL5Guest pid(9383) Message: Generate XML for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 with bootdev hd
2011-12-11 15:30:30,758 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Generated XML:
<?xml version="1.0"?>
<domain type="kvm">
  <name>RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0</name>
  <memory>1048576</memory>
  <currentMemory>1048576</currentMemory>
  <uuid>21acff52-2a24-47d6-841e-f36b1797d9f3</uuid>
  <clock offset="utc"/>
  <vcpu>1</vcpu>
  <features>
    <acpi/>
    <apic/>
    <pae/>
  </features>
  <os>
    <type>hvm</type>
    <boot dev="hd"/>
  </os>
  <on_poweroff>destroy</on_poweroff>
  <on_reboot>destroy</on_reboot>
  <on_crash>destroy</on_crash>
  <devices>
    <console device="pty"/>
    <graphics port="-1" type="vnc"/>
    <interface type="bridge">
      <source bridge="virbr0"/>
      <mac address="52:54:00:c2:b5:ab"/>
      <model type="virtio"/>
    </interface>
    <input bus="ps2" type="mouse"/>
    <console type="pty">
      <target port="0"/>
    </console>
    <serial type="tcp">
      <source mode="bind" host="127.0.0.1" service="22484"/>
      <protocol type="raw"/>
      <target port="1"/>
    </serial>
    <disk device="disk" type="file">
      <target dev="vda" bus="virtio"/>
      <source file="/var/lib/imagefactory/images/base-image-94b35b19-71b8-46d1-813c-f612105b40f0.dsk"/>
    </disk>
  </devices>
</domain>

2011-12-11 15:30:30,758 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Base install complete - Doing customization and ICICLE generation
2011-12-11 15:30:30,758 DEBUG imgfac.BuildJob.BuildJob pid(9383) Message: Builder (94b35b19-71b8-46d1-813c-f612105b40f0) changed percent complete from 10 to 30
2011-12-11 15:30:30,758 INFO oz.Guest.RHEL5Guest pid(9383) Message: Customizing image
2011-12-11 15:30:30,759 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Generated XML:
<?xml version="1.0"?>
<domain type="kvm">
  <name>RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0</name>
  <memory>1048576</memory>
  <currentMemory>1048576</currentMemory>
  <uuid>21acff52-2a24-47d6-841e-f36b1797d9f3</uuid>
  <clock offset="utc"/>
  <vcpu>1</vcpu>
  <features>
    <acpi/>
    <apic/>
    <pae/>
  </features>
  <os>
    <type>hvm</type>
    <boot dev="hd"/>
  </os>
  <on_poweroff>destroy</on_poweroff>
  <on_reboot>destroy</on_reboot>
  <on_crash>destroy</on_crash>
  <devices>
    <console device="pty"/>
    <graphics port="-1" type="vnc"/>
    <interface type="bridge">
      <source bridge="virbr0"/>
      <mac address="52:54:00:c2:b5:ab"/>
      <model type="virtio"/>
    </interface>
    <input bus="ps2" type="mouse"/>
    <console type="pty">
      <target port="0"/>
    </console>
    
    <disk device="disk" type="file">
      <target dev="vda" bus="virtio"/>
      <source file="/var/lib/imagefactory/images/base-image-94b35b19-71b8-46d1-813c-f612105b40f0.dsk"/>
    </disk>
  <serial type="tcp"><source mode="bind" host="127.0.0.1" service="22484"/><protocol type="raw"/><target port="1"/></serial></devices>
</domain>

2011-12-11 15:30:30,759 INFO oz.Guest.RHEL5Guest pid(9383) Message: Collection Setup
2011-12-11 15:30:30,761 INFO oz.Guest.RHEL5Guest pid(9383) Message: Setting up guestfs handle for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0
2011-12-11 15:30:30,761 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Adding disk image /var/lib/imagefactory/images/base-image-94b35b19-71b8-46d1-813c-f612105b40f0.dsk
2011-12-11 15:30:30,762 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Launching guestfs
2011-12-11 15:30:34,250 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Inspecting guest OS
2011-12-11 15:30:35,139 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Getting mountpoints
2011-12-11 15:30:35,139 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Root device: /dev/VolGroup00/LogVol00
2011-12-11 15:30:35,253 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Step 1: Uploading ssh keys
2011-12-11 15:30:35,264 INFO oz.Guest.RHEL5Guest pid(9383) Message: Generating new openssh key
2011-12-11 15:30:35,265 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Step 2: setup sshd
2011-12-11 15:30:35,384 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Step 3: Open up the firewall
2011-12-11 15:30:35,385 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Step 4: Guest announcement
2011-12-11 15:30:35,425 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Step 5: Set SELinux to permissive mode
2011-12-11 15:30:35,443 INFO oz.Guest.RHEL5Guest pid(9383) Message: Cleaning up guestfs handle for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0
2011-12-11 15:30:35,443 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Syncing
2011-12-11 15:30:35,771 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Unmounting all
2011-12-11 15:30:36,372 INFO oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot
2011-12-11 15:30:36,373 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 300/300
2011-12-11 15:30:46,413 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 290/300
2011-12-11 15:30:56,946 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 280/300
2011-12-11 15:31:07,046 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 270/300
2011-12-11 15:31:16,964 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:31:17,125 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 260/300
2011-12-11 15:31:27,205 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 250/300
2011-12-11 15:31:37,297 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 240/300
2011-12-11 15:31:47,333 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 230/300
2011-12-11 15:31:57,407 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 220/300
2011-12-11 15:32:07,488 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 210/300
2011-12-11 15:32:17,545 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 200/300
2011-12-11 15:32:27,609 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 190/300
2011-12-11 15:32:37,662 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 180/300
2011-12-11 15:32:47,777 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for guest RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to boot, 170/300
2011-12-11 15:32:55,888 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: IP address of guest is 192.168.122.150
2011-12-11 15:32:55,890 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Installing additional repository files
2011-12-11 15:32:57,344 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Installing custom packages
2011-12-11 15:33:09,759 INFO oz.Guest.RHEL5Guest pid(9383) Message: Uploading custom files
2011-12-11 15:33:09,759 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Running custom commands
2011-12-11 15:33:09,759 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Syncing
2011-12-11 15:33:12,463 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Generating ICICLE
2011-12-11 15:33:13,509 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to shutdown, 60/60
2011-12-11 15:33:17,171 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:33:23,548 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to shutdown, 50/60
2011-12-11 15:33:33,629 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Waiting for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0 to shutdown, 40/60
2011-12-11 15:33:37,645 INFO oz.Guest.RHEL5Guest pid(9383) Message: Collection Teardown
2011-12-11 15:33:37,647 INFO oz.Guest.RHEL5Guest pid(9383) Message: Setting up guestfs handle for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0
2011-12-11 15:33:37,647 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Adding disk image /var/lib/imagefactory/images/base-image-94b35b19-71b8-46d1-813c-f612105b40f0.dsk
2011-12-11 15:33:37,647 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Launching guestfs
2011-12-11 15:33:41,141 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Inspecting guest OS
2011-12-11 15:33:42,068 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Getting mountpoints
2011-12-11 15:33:42,068 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Root device: /dev/VolGroup00/LogVol00
2011-12-11 15:33:42,192 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Teardown step 1
2011-12-11 15:33:42,192 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Resetting authorized_keys
2011-12-11 15:33:42,225 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Teardown step 2
2011-12-11 15:33:42,225 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Resetting sshd_config
2011-12-11 15:33:42,254 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Resetting sshd service
2011-12-11 15:33:42,301 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Teardown step 3
2011-12-11 15:33:42,301 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Resetting iptables rules
2011-12-11 15:33:42,303 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Teardown step 4
2011-12-11 15:33:42,303 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Resetting announcement to host
2011-12-11 15:33:42,308 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Removing reportip
2011-12-11 15:33:42,308 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Resetting crond service
2011-12-11 15:33:42,318 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Teardown step 5
2011-12-11 15:33:42,331 INFO oz.Guest.RHEL5Guest pid(9383) Message: Cleaning up guestfs handle for RHEL5_VMWareTools-94b35b19-71b8-46d1-813c-f612105b40f0
2011-12-11 15:33:42,332 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Syncing
2011-12-11 15:33:42,508 DEBUG oz.Guest.RHEL5Guest pid(9383) Message: Unmounting all
2011-12-11 15:33:42,625 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Customization and ICICLE generation complete
2011-12-11 15:33:42,625 DEBUG imgfac.BuildJob.BuildJob pid(9383) Message: Builder (94b35b19-71b8-46d1-813c-f612105b40f0) changed percent complete from 30 to 50
2011-12-11 15:33:42,625 INFO oz.Guest.RHEL5Guest pid(9383) Message: Cleaning up after install
2011-12-11 15:33:42,629 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Generated disk image (/var/lib/imagefactory/images/base-image-94b35b19-71b8-46d1-813c-f612105b40f0.dsk)
2011-12-11 15:33:42,629 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Doing further Factory specific modification of Oz image
2011-12-11 15:33:42,630 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: init guestfs
2011-12-11 15:33:42,630 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: add input image
2011-12-11 15:33:42,630 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: launch guestfs
2011-12-11 15:33:46,168 INFO imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Creating cloud-info file indicating target (vsphere)
2011-12-11 15:33:46,189 INFO imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Updating rc.local with Audrey conditional
2011-12-11 15:33:47,989 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Removed HWADDR from image's /etc/sysconfig/network-scripts/ifcfg-eth0
2011-12-11 15:33:48,428 INFO imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Transforming image for use on VMWare
2011-12-11 15:33:48,428 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Converting raw kvm image (/var/lib/imagefactory/images/base-image-94b35b19-71b8-46d1-813c-f612105b40f0.dsk) to vmware stream-optimized image (/var/lib/imagefactory/images/vmware-image-94b35b19-71b8-46d1-813c-f612105b40f0.vmdk)
2011-12-11 15:35:08,590 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: VMWare stream conversion complete
2011-12-11 15:35:08,590 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Storing Fedora image at http://localhost:9090/...
2011-12-11 15:35:08,634 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Image Warehouse returned status (500) with message: 
2011-12-11 15:35:08,634 INFO imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Creating a bucket returned status (500), .
2011-12-11 15:35:08,645 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Setting metadata ({'object_type': 'template', 'uuid': '862fe430-8b81-48df-bfb4-837bc08721a9'}) for http://localhost:9090/templates/862fe430-8b81-48df-bfb4-837bc08721a9
2011-12-11 15:35:08,730 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Image Warehouse returned status (500) with message: 
2011-12-11 15:35:08,730 INFO imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Creating a bucket returned status (500), .
2011-12-11 15:35:08,743 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Setting metadata ({'object_type': 'icicle', 'uuid': 'a0e6032a-0e4f-4c7e-8826-e1caebea59fe'}) for http://localhost:9090/icicles/a0e6032a-0e4f-4c7e-8826-e1caebea59fe
2011-12-11 15:35:08,829 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Image Warehouse returned status (500) with message: 
2011-12-11 15:35:08,829 INFO imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Creating a bucket returned status (500), .
2011-12-11 15:35:08,833 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 0kB of 293395kB
2011-12-11 15:35:08,970 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 10240kB of 293395kB
2011-12-11 15:35:09,173 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 20480kB of 293395kB
2011-12-11 15:35:09,275 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 30720kB of 293395kB
2011-12-11 15:35:09,378 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 40960kB of 293395kB
2011-12-11 15:35:09,482 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 51200kB of 293395kB
2011-12-11 15:35:09,603 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 61440kB of 293395kB
2011-12-11 15:35:09,706 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 71680kB of 293395kB
2011-12-11 15:35:09,804 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 81920kB of 293395kB
2011-12-11 15:35:09,903 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 92160kB of 293395kB
2011-12-11 15:35:09,998 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 102400kB of 293395kB
2011-12-11 15:35:10,097 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 112640kB of 293395kB
2011-12-11 15:35:10,196 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 122880kB of 293395kB
2011-12-11 15:35:10,294 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 133120kB of 293395kB
2011-12-11 15:35:10,379 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 143360kB of 293395kB
2011-12-11 15:35:10,478 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 153600kB of 293395kB
2011-12-11 15:35:10,579 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 163840kB of 293395kB
2011-12-11 15:35:10,676 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 174080kB of 293395kB
2011-12-11 15:35:10,776 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 184320kB of 293395kB
2011-12-11 15:35:10,898 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 194560kB of 293395kB
2011-12-11 15:35:11,002 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 204800kB of 293395kB
2011-12-11 15:35:11,104 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 215040kB of 293395kB
2011-12-11 15:35:11,207 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 225280kB of 293395kB
2011-12-11 15:35:11,309 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 235520kB of 293395kB
2011-12-11 15:35:11,412 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 245760kB of 293395kB
2011-12-11 15:35:11,514 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 256000kB of 293395kB
2011-12-11 15:35:11,616 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 266240kB of 293395kB
2011-12-11 15:35:11,711 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 276480kB of 293395kB
2011-12-11 15:35:11,814 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 286720kB of 293395kB
2011-12-11 15:35:11,875 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 293395kB of 293395kB
2011-12-11 15:35:11,875 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 293395kB of 293395kB
2011-12-11 15:35:11,881 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 293395kB of 293395kB
2011-12-11 15:35:11,882 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 293395kB of 293395kB
2011-12-11 15:35:11,882 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Uploading 293395kB of 293395kB
2011-12-11 15:35:11,882 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Setting metadata ({'icicle': 'a0e6032a-0e4f-4c7e-8826-e1caebea59fe', 'uuid': '94b35b19-71b8-46d1-813c-f612105b40f0', 'template': '862fe430-8b81-48df-bfb4-837bc08721a9', 'target_parameters': 'No target parameters for cloud type vsphere', 'object_type': 'target_image', 'target': 'vsphere', 'build': '39db696a-bdb0-4303-8ea7-68632760b4f3'}) for http://localhost:9090/target_images/94b35b19-71b8-46d1-813c-f612105b40f0
2011-12-11 15:35:12,139 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Image warehouse storage complete
2011-12-11 15:35:12,139 DEBUG imgfac.BuildJob.BuildJob pid(9383) Message: Builder (94b35b19-71b8-46d1-813c-f612105b40f0) changed percent complete from 50 to 100
2011-12-11 15:35:12,139 DEBUG imgfac.BuildJob.BuildJob pid(9383) Message: Builder (94b35b19-71b8-46d1-813c-f612105b40f0) changed status from BUILDING to COMPLETED

11-12-11 15:35:18,683 DEBUG imgfac.BuildJob.BuildJob pid(9383) Message: Builder (39b07eb2-facc-408f-bf35-4cc5b18d83eb) changed status from NEW to PUSHING
2011-12-11 15:35:18,683 DEBUG imgfac.BuildJob.BuildJob pid(9383) Message: Builder (39b07eb2-facc-408f-bf35-4cc5b18d83eb) changed percent complete from 0 to 0
2011-12-11 15:35:18,686 DEBUG imgfac.builders.BaseBuilder.RHEL5_vsphere_Builder pid(9383) Message: Image file /var/lib/imagefactory/images/vmware-image-94b35b19-71b8-46d1-813c-f612105b40f0.vmdk already present - skipping warehouse download
2011-12-11 15:35:18,802 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:35:19,411 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:36:19,630 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:37:19,811 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:38:20,174 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:39:20,343 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:40:20,528 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:41:20,711 DEBUG paste.httpserver.ThreadPool pid(9383) Message: Added task (0 tasks queued)
2011-12-11 15:41:38,764 DEBUG imgfac.VMWare.VMImport pid(9383) Message: Marking newly created VM as a template
2011-12-11 15:41:41,233 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Image Warehouse returned status (500) with message: 
2011-12-11 15:41:41,233 INFO imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Creating a bucket returned status (500), .
2011-12-11 15:41:41,239 DEBUG imgfac.ImageWarehouse.ImageWarehouse pid(9383) Message: Setting metadata ({'provider_account_identifier': 'Administrator', 'target_image': '94b35b19-71b8-46d1-813c-f612105b40f0', 'uuid': '39b07eb2-facc-408f-bf35-4cc5b18d83eb', 'icicle': 'none', 'target_identifier': 'factory-image-39b07eb2-facc-408f-bf35-4cc5b18d83eb', 'object_type': 'provider_image', 'provider': 'vsphere'}) for http://localhost:9090/provider_images/39b07eb2-facc-408f-bf35-4cc5b18d83eb
2011-12-11 15:41:41,534 DEBUG imgfac.BuildJob.BuildJob pid(9383) Message: Builder (39b07eb2-facc-408f-bf35-4cc5b18d83eb) changed percent complete from 0 to 100
2011-12-11 15:41:41,534 DEBUG imgfac.BuildJob.BuildJob pid(9383) Message: Builder (39b07eb2-facc-408f-bf35-4cc5b18d83eb) changed status from PUSHING to COMPLETED


This template would kernel panic if I started it via aeolus or vsphere.
Looking into the root cause now... Reporting the issue only
Comment 1 wes hayutin 2011-12-12 14:19:43 UTC 
trying w/o additional packages..

 aeolus-cli build --target vsphere --template /root/RHEL57.tpl
Image: 27455dbf-d400-404a-b8b5-d820140de32c
Build: 7cc24377-8ba5-4fa5-b1f2-40b7d0003cde
Target Image: 03a6ff17-b050-41a3-a238-b94a30a9beae       :Status BUILDING
[root@qeblade30 ~]# aeolus-cli push --account vsphere_Administrator --targetimage 03a6ff17-b050-41a3-a238-b94a30a9beae
Target Image: 03a6ff17-b050-41a3-a238-b94a30a9beae
Provider Image: cd4dcd93-52f4-4d6f-9db7-c14f03904524     Status: PUSHING
[root@qeblade30 ~]# 



[root@qeblade30 ~]# cat /root/RHEL57.tpl 
<template>
  <name>RHEL5-Basic</name>
  <os>    
    <name>RHEL-5</name>    
    <version>U7</version>
    <arch>x86_64</arch>
    <rootpw>redhat</rootpw>
    <install type="url">
      <url>http://download.devel.redhat.com/released/RHEL-5-Server/U7/x86_64/os/</url>
    </install>
  </os>
  <description>RHEL57 x86_64 </description>
</template>
[root@qeblade30 ~]# 


I performed a manual install on a vsphere guest using the same install URL.. and it works fine.. I'm also able to import the hand build image/template into vsphere

I think that may narrow it down to imagefactory
Comment 2 Ian McLeod 2012-01-03 14:51:16 UTC 
This appears to be a long standing problem with building RHEL5 for vsphere.

The resulting guest image does not contain the necessary mpt SCSI module in its initrd and, as a result, is never bootable within the vsphere guest container that we create during the import.

To be clear, this means it's likely that RHEL5 factory builds never worked on vsphere.

The following change adds the required module to the initrd at the time the JEOS build is created and in a way that should persist if the kernel is updated during the customized step:

https://github.com/aeolusproject/imagefactory/commit/95daa50d8f8b9a9125e2cdd4e31ee9a665dbcc21

This still allows for further modification of the initrd and grub details during customization.

I have tested this end to end with 5.7 and the resulting VM template in vsphere can be cloned and launched successfully.

This change has been brewed and is in available in brew as imagefactory version 1.0.0rc2.

Changing to ON_QA.
Comment 3 Martin Kočí 2012-01-12 11:52:10 UTC 
Verified on 
# rpm -qa|grep 'aeolus\|imagefactory-\|oz-\|iwhd'
rubygem-imagefactory-console-0.5.0-4.20110824113238gitd9debef.el6.noarch
aeolus-configure-2.6.0-0.20120111093533gitf3d033e.el6.noarch
aeolus-conductor-daemons-0.9.0-0.20120111153517gite55da85.el6.noarch
aeolus-conductor-doc-0.9.0-0.20120111153517gite55da85.el6.noarch
imagefactory-jeosconf-ec2-rhel-1.0.0rc2.1-1.el6.noarch
rubygem-aeolus-image-0.4.0-0.20120111093551git67fdf6f.el6.noarch
rubygem-arel-2.0.10-0.aeolus.el6.noarch
rubygem-ZenTest-4.3.3-2.aeolus.el6.noarch
oz-0.8.0-0.20111219203204git5775e9d.el6.noarch
iwhd-1.2-3.el6.x86_64
imagefactory-jeosconf-ec2-fedora-1.0.0rc2.1-1.el6.noarch
rubygem-aeolus-cli-0.4.0-0.20120111093540git5ec8dc7.el6.noarch
imagefactory-1.0.0rc2.1-1.el6.noarch
aeolus-conductor-0.9.0-0.20120111153517gite55da85.el6.noarch
aeolus-all-0.9.0-0.20120111153517gite55da85.el6.noarch

Vsphere 4.01.

Successfully reproduced kernel panic on :
# rpm -qa|grep 'aeolus\|imagefactory-\|oz-\|iwhd'
aeolus-conductor-daemons-0.9.0-0.20120111153517gite55da85.fc15.noarch
rubygem-imagefactory-console-0.5.0-4.20110824113238gitd9debef.fc15.noarch
rubygem-aeolus-image-0.4.0-0.20120111093551git67fdf6f.fc15.noarch
aeolus-all-0.9.0-0.20120111153517gite55da85.fc15.noarch
aeolus-conductor-doc-0.9.0-0.20120111153517gite55da85.fc15.noarch
imagefactory-jeosconf-ec2-rhel-1.0.0rc1-1.fc15.noarch
aeolus-configure-2.6.0-0.20120111093533gitf3d033e.fc15.noarch
imagefactory-jeosconf-ec2-fedora-1.0.0rc1-1.fc15.noarch
oz-0.8.0-0.20111219203204git5775e9d.fc15.noarch
aeolus-conductor-0.9.0-0.20120111153517gite55da85.fc15.noarch
iwhd-1.1-1.fc15.x86_64
rubygem-aeolus-cli-0.4.0-0.20120111093540git5ec8dc7.fc15.noarch
imagefactory-1.0.0rc1-1.fc15.noarch

I would dare to move the bug to VERIFIED.
Comment 4 wes hayutin 2012-01-12 16:17:39 UTC 
bugs in verified or on_qa moving off tracker
Comment 6 errata-xmlrpc 2012-05-15 20:21:26 UTC 
Since the problem described in this bug report should be
resolved in a recent advisory, it has been closed with a
resolution of ERRATA.

For information on the advisory, and where to find the updated
files, follow the link below.

If the solution does not work for you, open a new bug report.

http://rhn.redhat.com/errata/RHEA-2012-0588.html