Build failed in Jenkins: precise-alternate-i386_default #264

Wed Dec 21 08:01:17 UTC 2011

See <http://10.189.74.2:8080/job/precise-alternate-i386_default/264/>

------------------------------------------
Started due to content change in http://cdimage.ubuntu.com/daily/current/SHA256SUMS
Building remotely on wazn
[precise-alternate-i386_default] $ /bin/bash /tmp/hudson4588458620078654744.sh
ln: creating symbolic link `/var/lib/ubuntu-server-iso-testing/isos/ubuntu-alternate/ubuntu': File exists
INFO:root:Checking/Downloading current build for variant alternate from http://cdimage.ubuntu.com/daily
INFO:root:Remote file not available. Retrying in 15 minutes
INFO:root:Downloading ISO...

-------------------- 0.0%
-------------------- 0.7% 10.2 kBps 2:24 ETA  
####---------------- 24.8% 359.4 kBps 0:03 ETA  
#################### 100.0% 147.9 kBps DONE    

reading seed file ubuntu/precise-alternate-i386.iso: *****************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************************
Read ubuntu/precise-alternate-i386.iso. Target 97.2% complete.      
downloading from http://cdimage.ubuntu.com//daily/current/precise-alternate-i386.iso:

###################- 97.2%
###################- 97.2% 138.5 kBps 2:35 ETA  
###################- 97.3% 730.0 kBps 0:27 ETA  
###################- 97.7% 2441.3 kBps 0:07 ETA  
###################- 98.7% 7945.3 kBps 0:01 ETA  
#################### 100.0% 2501.1 kBps DONE    

verifying download...checksum matches OK
used 740401152 local, fetched 21183785
Syncing precise ubuntu alternate i386
Verifying ubuntu/precise-alternate-i386.iso
Verification succeeded
[precise-alternate-i386_default] $ /bin/bash /tmp/hudson8863151342202282172.sh
DEBUG:root:Options: {'isoroot': '/var/lib/ubuntu-iso-testing/isos', 'isoname': False, 'test_dir': None, 'variant': 'alternate', 'release': 'precise', 'debug': False, 'flavor': 'ubuntu', 'arch': 'i386'}
DEBUG:root:Arguments: ['default']
INFO:root:Preseed: default
INFO:root:Extracting kernel and initrd from /var/lib/ubuntu-iso-testing/isos/ubuntu/precise-alternate-i386.iso
DEBUG:root:Cmd: ['unbsdtar-safelink', '-xf', '/var/lib/ubuntu-iso-testing/isos/ubuntu/precise-alternate-i386.iso', '-C', '/tmp/precise-alternate-i386.iso-e1MZx7', 'install/vmlinuz', 'install/initrd.gz']
INFO:root:Generating default configuration
DEBUG:root:Loading test configuration file: '/usr/share/ubuntu-iso-testing/templates.alternate/test_cases/default/config'
DEBUG:root:Couch Document UUID: 'eb95044f-45d3-433c-9877-c063ac5fc5b0'
DEBUG:root:Generate preseed file
DEBUG:root:will preseed /tmp/precise-alternate-i386.iso-e1MZx7/default-tUp1ky/preseed
INFO:root:Uncompressing initrd
DEBUG:root:Initrd file: /tmp/precise-alternate-i386.iso-e1MZx7/install/initrd.gz
DEBUG:root:Copying preseed to initrd and test case document
DEBUG:root:Extracting media info from ISO
DEBUG:root:Cmd: ['bsdtar', '-xf', '/var/lib/ubuntu-iso-testing/isos/ubuntu/precise-alternate-i386.iso', '-O', '.disk/info']
DEBUG:root:Media Info: Ubuntu 12.04 LTS "Precise Pangolin" - Alpha i386 (20111221)
DEBUG:root:Copying preseed to tftp root
INFO:root:Copying /usr/share/ubuntu-iso-testing/templates.alternate/run_test -> /tmp/precise-alternate-i386.iso-e1MZx7/default-tUp1ky/initrd-8n6CTA
DEBUG:root:Updating inittab
INFO:root:Compressing initrd
DEBUG:root:Attaching initrd
DEBUG:root:Copying initrd to tftp root
DEBUG:root:Attaching kernel
DEBUG:root:Copying kernel to tftp root
DEBUG:root:Copying pxelinux config to tftp root
DEBUG:root:Loading configuration option: 'pxelinux/kernel_boot_args'
INFO:root:Section doesn't exists: 'pxelinux'
DEBUG:root:Context: {'mac': '52:54:00:f9:a4:8d', 'uuid': 'eb95044f-45d3-433c-9877-c063ac5fc5b0', 'kernel_boot_args': ''}
DEBUG:root:Attaching pxelinux config
DEBUG:root:Adding test script to test case document
DEBUG:root:Test script: /usr/share/ubuntu-iso-testing/templates.alternate/test_cases/default/test
DEBUG:root:Loading configuration option: 'vm/disk_size'
INFO:root:Section doesn't exists: 'vm'
DEBUG:root:Loading configuration option: 'vm/disk_number'
INFO:root:Section doesn't exists: 'vm'
DEBUG:root:Generating libvirt information for /usr/share/ubuntu-iso-testing/templates.alternate/test_cases/default
DEBUG:root:Generating disk information
DEBUG:root:Setting state to created
DEBUG:root:Loading test case to run
INFO:root:Configuring test case: eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Retrieving iso file
DEBUG:root:Generating disks
DEBUG:root:Cmd: ['qemu-img', 'create', '-f', 'qcow2', '/var/lib/ubuntu-iso-testing/tests/eb95044f-45d3-433c-9877-c063ac5fc5b0/disk1.qcow2', '6G']
Formatting '/var/lib/ubuntu-iso-testing/tests/eb95044f-45d3-433c-9877-c063ac5fc5b0/disk1.qcow2', fmt=qcow2 size=6442450944 encryption=off cluster_size=0 
DEBUG:root:Generating libvirt configuration
DEBUG:root:Context: {'iso_file': '/var/lib/ubuntu-iso-testing/isos/ubuntu/precise-alternate-i386.iso', 'mac': '52:54:00:f9:a4:8d', 'disks': [{'source': '/var/lib/ubuntu-iso-testing/tests/eb95044f-45d3-433c-9877-c063ac5fc5b0/disk1.qcow2', 'bus': 'virtio', 'size': '6G', 'target': 'vda', 'format': 'qcow2'}], 'name': 'eb95044f-45d3-433c-9877-c063ac5fc5b0', 'uuid': 'eb95044f-45d3-433c-9877-c063ac5fc5b0'}
DEBUG:root:Cmd: ['virsh', 'define', '/var/lib/ubuntu-iso-testing/tests/eb95044f-45d3-433c-9877-c063ac5fc5b0/libvirt.xml']
Domain eb95044f-45d3-433c-9877-c063ac5fc5b0 defined from /var/lib/ubuntu-iso-testing/tests/eb95044f-45d3-433c-9877-c063ac5fc5b0/libvirt.xml

DEBUG:root:Starting test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'start', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
Domain eb95044f-45d3-433c-9877-c063ac5fc5b0 started

DEBUG:root:Cmd: ['sudo', 'chown', 'usit', '/tmp/eb95044f-45d3-433c-9877-c063ac5fc5b0.syslog.log']
DEBUG:root:Checking VM state for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'domstate', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
DEBUG:root:running
DEBUG:root:test start: Dec 21 2011 02:56:43, Dec 21 02:57:00 wazn dnsmasq-dhcp[2444]: DHCPREQUEST(virbr999) 192.168.123.57 52:54:00:f9:a4:8d 
DEBUG:root:Got IP address of 192.168.123.57 for eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Capturing current d-i syslog for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Dec 21 07:57:13 anna[7343]: DEBUG: retrieving apt-cdrom-setup 1:0.55ubuntu1
Dec 21 07:57:13 debconf: --> SUBST anna/progress_step_retr PACKAGE apt-cdrom-setup
Dec 21 07:57:13 debconf: Adding [PACKAGE] -> [apt-cdrom-setup]
Dec 21 07:57:13 debconf: <-- 0
Dec 21 07:57:13 debconf: --> PROGRESS INFO anna/progress_step_retr
Dec 21 07:57:13 debconf: <-- 0 OK
Dec 21 07:57:13 debconf: --> X_LOADTEMPLATEFILE /var/lib/dpkg/info/apt-cdrom-setup.templates apt-cdrom-setup
Dec 21 07:57:13 debconf: <-- 0 OK
Dec 21 07:57:13 debconf: --> X_SAVE
Dec 21 07:57:13 debconf: Question database /var/lib/cdebconf/passwords.dat clean; not saving
DEBUG:root:Checking VM state for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'domstate', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Dec 21 07:57:42 netcfg[10658]: DEBUG: rdisc6 line: No response.
Dec 21 07:57:42 netcfg[10658]: DEBUG: rdisc6 parsing finished
Dec 21 07:57:42 debconf: --> PROGRESS STEP 1
Dec 21 07:57:42 debconf: <-- 0 OK
Dec 21 07:57:43 netcfg[10658]: DEBUG: rdisc6 line: Soliciting ff02::2 (ff02::2) on eth0...
Dec 21 07:57:43 netcfg[10658]: DEBUG: rdisc6 line: Timed out.
Dec 21 07:57:43 netcfg[10658]: DEBUG: rdisc6 line: No response.
Dec 21 07:57:43 netcfg[10658]: DEBUG: rdisc6 parsing finished
Dec 21 07:57:43 debconf: --> PROGRESS STEP 1
Dec 21 07:57:43 debconf: <-- 0 OK
DEBUG:root:Checking VM state for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'domstate', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Dec 21 07:58:15 debconf: --> METAGET base-installer/debootstrap/info/extracting description
Dec 21 07:58:15 debconf: <-- 0 Extracting sensible-utils...
Dec 21 07:58:15 debconf: --> SUBST base-installer/debootstrap/info/extracting SUBST0 login
Dec 21 07:58:15 debconf: Adding [SUBST0] -> [login]
Dec 21 07:58:15 debconf: <-- 0
Dec 21 07:58:15 debconf: --> SUBST base-installer/debootstrap/info/extracting SECTION Extracting packages
Dec 21 07:58:15 debconf: Adding [SECTION] -> [Extracting packages]
Dec 21 07:58:15 debconf: <-- 0
Dec 21 07:58:15 debconf: --> PROGRESS INFO base-installer/debootstrap/info/extracting
Dec 21 07:58:15 debconf: <-- 0 OK
DEBUG:root:Checking VM state for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'domstate', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Dec 21 07:58:44 debconf: --> METAGET base-installer/debootstrap/info/configuring description
Dec 21 07:58:44 debconf: <-- 0 Configuring logrotate...
Dec 21 07:58:44 debconf: --> SUBST base-installer/debootstrap/info/configuring SUBST0 python3.2
Dec 21 07:58:44 debconf: Adding [SUBST0] -> [python3.2]
Dec 21 07:58:44 debconf: <-- 0
Dec 21 07:58:44 debconf: --> SUBST base-installer/debootstrap/info/configuring SECTION Configuring the base system
Dec 21 07:58:44 debconf: Adding [SECTION] -> [Configuring the base system]
Dec 21 07:58:44 debconf: <-- 0
Dec 21 07:58:44 debconf: --> PROGRESS INFO base-installer/debootstrap/info/configuring
Dec 21 07:58:44 debconf: <-- 0 OK
DEBUG:root:Checking VM state for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'domstate', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Dec 21 07:59:12 in-target: debconf (developer): <---- 0 OK
Dec 21 07:59:12 in-target: debconf (developer): --> 0 OK
Dec 21 07:59:12 in-target: Running depmod.
Dec 21 07:59:13 in-target: update-initramfs: deferring update (hook will be called later)
Dec 21 07:59:13 in-target: Examining /etc/kernel/postinst.d.
Dec 21 07:59:13 in-target: run-parts: executing /etc/kernel/postinst.d/initramfs-tools
Dec 21 07:59:13 in-target:  3.2.0-6-generic-pae
Dec 21 07:59:13 in-target:  /boot/vmlinuz-3.2.0-6-generic-pae
Dec 21 07:59:13 in-target: 
Dec 21 07:59:13 in-target: update-initramfs: Generating /boot/initrd.img-3.2.0-6-generic-pae
DEBUG:root:Checking VM state for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'domstate', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Dec 21 07:59:44 in-target: debconf (developer): <---- 0 OK
Dec 21 07:59:44 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Retrieving file 57 of 57
Dec 21 07:59:44 debconf: --> DATA debconf-apt-progress/info description Retrieving file 57 of 57
Dec 21 07:59:44 debconf: <-- 0 OK
Dec 21 07:59:44 in-target: debconf (developer): <---- 0 OK
Dec 21 07:59:44 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Dec 21 07:59:44 debconf: --> PROGRESS INFO debconf-apt-progress/info
Dec 21 07:59:44 debconf: <-- 0 OK
Dec 21 07:59:44 in-target: debconf (developer): <---- 0 OK
Dec 21 07:59:44 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'domstate', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Dec 21 08:00:11 in-target: done
Dec 21 08:00:11 in-target:   en_AU.UTF-8... 
Dec 21 08:00:12 in-target: done
Dec 21 08:00:12 in-target:   en_BW.UTF-8... 
Dec 21 08:00:13 in-target: done
Dec 21 08:00:13 in-target:   en_CA.UTF-8... 
Dec 21 08:00:13 in-target: done
Dec 21 08:00:13 in-target:   en_DK.UTF-8... 
Dec 21 08:00:14 in-target: done
Dec 21 08:00:14 in-target:   en_GB.UTF-8...
DEBUG:root:Checking VM state for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'domstate', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Dec 21 08:00:42 debconf: --> DATA debconf-apt-progress/info type text
Dec 21 08:00:42 debconf: <-- 0 OK
Dec 21 08:00:42 in-target: debconf (developer): <---- 0 OK
Dec 21 08:00:42 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Configuring xserver-xorg-video-nouveau
Dec 21 08:00:42 debconf: --> DATA debconf-apt-progress/info description Configuring xserver-xorg-video-nouveau
Dec 21 08:00:42 debconf: <-- 0 OK
Dec 21 08:00:42 in-target: debconf (developer): <---- 0 OK
Dec 21 08:00:42 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Dec 21 08:00:42 debconf: --> PROGRESS INFO debconf-apt-progress/info
Dec 21 08:00:42 debconf: <-
DEBUG:root:Checking VM state for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'domstate', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Dec 21 08:00:44 debconf: --> CAPB
Dec 21 08:00:44 debconf: <-- 0 multiselect backup progresscancel align plugin-terminal plugin-detect-keyboard
Dec 21 08:00:44 debconf: --> METAGET debian-installer/pkgsel/title Description
Dec 21 08:00:44 debconf: <-- 0 Select and install software
Dec 21 08:00:44 debconf: --> SUBST debian-installer/main-menu/item-failure ITEM Select and install software
Dec 21 08:00:44 debconf: Adding [ITEM] -> [Select and install software]
Dec 21 08:00:44 debconf: <-- 0
Dec 21 08:00:44 debconf: --> INPUT critical debian-installer/main-menu/item-failure
Dec 21 08:00:44 debconf: <-- 0 question will be asked
Dec 21 08:00:44 debconf: --> GO
INFO:root:Test eb95044f-45d3-433c-9877-c063ac5fc5b0: debian-installer reports error
DEBUG:root:Terminating test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'destroy', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
Domain eb95044f-45d3-433c-9877-c063ac5fc5b0 destroyed

DEBUG:root:test[iso_url]=/var/lib/ubuntu-iso-testing/isos/ubuntu/precise-alternate-i386.iso
DEBUG:root:test[_rev]=13-6922c5b796d449762b01f7dc2bb08b11
DEBUG:root:test[disks]=[{'bus': 'virtio', 'size': '6G', 'target': 'vda', 'format': 'qcow2'}]
DEBUG:root:test[_attachments]={'preseed.cfg': {'stub': True, 'length': 13280, 'revpos': 2, 'content_type': ''}, 'pxe/kernel': {'stub': True, 'length': 5006912, 'revpos': 6, 'content_type': ''}, 'pxe/initrd': {'stub': True, 'length': 6247846, 'revpos': 5, 'content_type': ''}, 'tests/default': {'stub': True, 'length': 1216, 'revpos': 8, 'content_type': ''}, 'libvirt.xml': {'stub': True, 'length': 2184, 'revpos': 11, 'content_type': 'application/xml'}, 'pxe/pxelinux.cfg/52:54:00:f9:a4:8d': {'stub': True, 'length': 1094, 'revpos': 7, 'content_type': ''}, 'media_info': {'stub': True, 'length': 59, 'revpos': 3, 'content_type': ''}, 'run_test': {'stub': True, 'length': 5944, 'revpos': 4, 'content_type': ''}}
DEBUG:root:test[states]={'started': '2011-12-21T07:56:45.513456', 'configured': '2011-12-21T07:56:43.631446', 'creating': '2011-12-21T07:56:37.984889', 'created': '2011-12-21T07:56:42.978997'}
DEBUG:root:test[mac]=52:54:00:f9:a4:8d
DEBUG:root:test[_id]=eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:test[test_case]=default
DEBUG:root:VM for test case eb95044f-45d3-433c-9877-c063ac5fc5b0 powered off but tests not completed
DEBUG:root:Undefine VM for  test case eb95044f-45d3-433c-9877-c063ac5fc5b0
DEBUG:root:Cmd: ['virsh', 'undefine', 'eb95044f-45d3-433c-9877-c063ac5fc5b0']
Domain eb95044f-45d3-433c-9877-c063ac5fc5b0 has been undefined

DEBUG:root:Collating output for test case eb95044f-45d3-433c-9877-c063ac5fc5b0
Archiving artifacts
Recording test results
No test report files were found. Configuration error?