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

Fri Jul 4 09:01:37 UTC 2014

See <http://d-jenkins.ubuntu-ci:8080/job/precise-alternate-i386_default/1185/>

------------------------------------------
Started due to content change in http://cdimage.ubuntu.com/precise/daily/current/SHA256SUMS
Building remotely on wazn in workspace <http://d-jenkins.ubuntu-ci:8080/job/precise-alternate-i386_default/ws/>
[precise-alternate-i386_default] $ /bin/bash /tmp/hudson6761930319193951765.sh
ln: failed to create 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/precise/daily
INFO:root:Remote file not available. Retrying in 15 minutes
INFO:root:Downloading ISO...

-------------------- 0.0%
-------------------- 1.8% 26.6 kBps 0:55 ETA  
####---------------- 23.9% 335.9 kBps 0:03 ETA  
#################### 100.0% 145.0 kBps DONE    

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

#################--- 89.5%
#################--- 89.5% 44.4 kBps 33:02 ETA  
#################--- 89.6% 276.6 kBps 4:50 ETA  
#################--- 89.7% 860.4 kBps 1:33 ETA  
##################-- 90.0% 2565.6 kBps 0:30 ETA  
##################-- 90.7% 5733.8 kBps 0:12 ETA  
##################-- 91.6% 6511.7 kBps 0:10 ETA  
##################-- 92.4% 6343.7 kBps 0:09 ETA  
##################-- 93.2% 6036.7 kBps 0:08 ETA  
##################-- 93.9% 5495.4 kBps 0:08 ETA  
##################-- 94.8% 6954.2 kBps 0:05 ETA  
###################- 95.8% 8014.7 kBps 0:04 ETA  
###################- 97.1% 10033.7 kBps 0:02 ETA  
###################- 98.6% 11469.1 kBps 0:00 ETA  
#################### 100.0% 5210.4 kBps DONE    

verifying download...checksum matches OK
used 694685696 local, fetched 81266598
Syncing precise ubuntu alternate i386
Verifying ubuntu/precise-alternate-i386.iso
Verification succeeded
[precise-alternate-i386_default] $ /bin/bash /tmp/hudson3893776255200460243.sh
You have not informed bzr of your Launchpad ID, and you must do this to
write to Launchpad or access private data.  See "bzr help launchpad-login".
Branched 1 revision.
DEBUG:root:Options: {'isoroot': '/var/lib/ubuntu-iso-testing/isos', 'isoname': False, 'test_dir': '<http://d-jenkins.ubuntu-ci:8080/job/precise-alternate-i386_default/1185/artifact/tests',> 'variant': 'alternate', 'release': 'precise', 'debug': False, 'flavor': 'ubuntu', 'arch': 'i386'}
DEBUG:root:Arguments: ['default']
INFO:root:Sleeping for 9 seconds (LP: #961217)
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-JCvUcm', 'install/vmlinuz', 'install/initrd.gz']
INFO:root:Generating default configuration
DEBUG:root:Loading test configuration file: '<http://d-jenkins.ubuntu-ci:8080/job/precise-alternate-i386_default/1185/artifact/tests/test_cases/default/config'>
DEBUG:root:Couch Document UUID: '718b82d3-e0de-45f1-bdea-9d02a92a909a'
DEBUG:root:Generate preseed file
DEBUG:root:will preseed /tmp/precise-alternate-i386.iso-JCvUcm/default-3hDB7V/preseed
INFO:root:Uncompressing initrd
DEBUG:root:Initrd file: /tmp/precise-alternate-i386.iso-JCvUcm/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.4 LTS "Precise Pangolin" - Release i386 (20140704)
DEBUG:root:Copying preseed to tftp root
INFO:root:Copying <http://d-jenkins.ubuntu-ci:8080/job/precise-alternate-i386_default/1185/artifact/tests/run_test> -> /tmp/precise-alternate-i386.iso-JCvUcm/default-3hDB7V/initrd-XHKGTP
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:8e:f2:b2', 'uuid': '718b82d3-e0de-45f1-bdea-9d02a92a909a', 'kernel_boot_args': ''}
DEBUG:root:Attaching pxelinux config
DEBUG:root:Adding test script to test case document
DEBUG:root:Test script: <http://d-jenkins.ubuntu-ci:8080/job/precise-alternate-i386_default/1185/artifact/tests/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 <http://d-jenkins.ubuntu-ci:8080/job/precise-alternate-i386_default/1185/artifact/tests/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: 718b82d3-e0de-45f1-bdea-9d02a92a909a
DEBUG:root:Retrieving iso file
DEBUG:root:Generating disks
DEBUG:root:Cmd: ['qemu-img', 'create', '-f', 'qcow2', '/var/lib/ubuntu-iso-testing/tests/718b82d3-e0de-45f1-bdea-9d02a92a909a/disk1.qcow2', '6G']
Formatting '/var/lib/ubuntu-iso-testing/tests/718b82d3-e0de-45f1-bdea-9d02a92a909a/disk1.qcow2', fmt=qcow2 size=6442450944 encryption=off cluster_size=65536 lazy_refcounts=off 
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:8e:f2:b2', 'disks': [{'source': '/var/lib/ubuntu-iso-testing/tests/718b82d3-e0de-45f1-bdea-9d02a92a909a/disk1.qcow2', 'bus': 'virtio', 'size': '6G', 'target': 'vda', 'format': 'qcow2'}], 'name': '718b82d3-e0de-45f1-bdea-9d02a92a909a', 'uuid': '718b82d3-e0de-45f1-bdea-9d02a92a909a'}
DEBUG:root:Cmd: ['virsh', 'define', '/var/lib/ubuntu-iso-testing/tests/718b82d3-e0de-45f1-bdea-9d02a92a909a/libvirt.xml']
Domain 718b82d3-e0de-45f1-bdea-9d02a92a909a defined from /var/lib/ubuntu-iso-testing/tests/718b82d3-e0de-45f1-bdea-9d02a92a909a/libvirt.xml

DEBUG:root:Starting test case 718b82d3-e0de-45f1-bdea-9d02a92a909a
DEBUG:root:Cmd: ['virsh', 'start', '718b82d3-e0de-45f1-bdea-9d02a92a909a']
Domain 718b82d3-e0de-45f1-bdea-9d02a92a909a started

DEBUG:root:Cmd: ['sudo', 'chown', 'usit', '/tmp/718b82d3-e0de-45f1-bdea-9d02a92a909a.syslog.log']
DEBUG:root:Checking VM state for test case 718b82d3-e0de-45f1-bdea-9d02a92a909a
DEBUG:root:Cmd: ['virsh', 'domstate', '718b82d3-e0de-45f1-bdea-9d02a92a909a']
DEBUG:root:running
DEBUG:root:test start: Jul 04 2014 09:01:04, Jul  4 09:01:12 wazn dnsmasq-dhcp[4833]: DHCPREQUEST(virbr999) 192.168.123.91 52:54:00:8e:f2:b2 
DEBUG:root:Got IP address of 192.168.123.91 for 718b82d3-e0de-45f1-bdea-9d02a92a909a
DEBUG:root:Capturing current d-i syslog for test case 718b82d3-e0de-45f1-bdea-9d02a92a909a
DEBUG:root:Jul  4 09:01:27 debconf: --> SET anna/retriever cdrom-retriever
Jul  4 09:01:27 debconf: <-- 0 value set
Jul  4 09:01:27 debconf: --> GET cdrom/codename
Jul  4 09:01:27 debconf: <-- 0 precise
Jul  4 09:01:27 cdrom-retriever: warning: File /cdrom/dists/precise/main/debian-installer/binary-i386/Packages does not exist.
Jul  4 09:01:27 cdrom-retriever: warning: File /cdrom/dists/precise/restricted/debian-installer/binary-i386/Packages does not exist.
Jul  4 09:01:27 anna[7325]: WARNING **: no packages matching running kernel 3.11.0-24-generic in archive
Jul  4 09:01:27 debconf: --> INPUT critical anna/no_kernel_modules
Jul  4 09:01:27 debconf: <-- 0 question will be asked
Jul  4 09:01:27 debconf: --> GO
INFO:root:Test 718b82d3-e0de-45f1-bdea-9d02a92a909a: debian-installer reports error
DEBUG:root:Terminating test case 718b82d3-e0de-45f1-bdea-9d02a92a909a
DEBUG:root:Cmd: ['virsh', 'destroy', '718b82d3-e0de-45f1-bdea-9d02a92a909a']
Domain 718b82d3-e0de-45f1-bdea-9d02a92a909a destroyed

DEBUG:root:test[iso_url]=/var/lib/ubuntu-iso-testing/isos/ubuntu/precise-alternate-i386.iso
DEBUG:root:test[_rev]=13-e36e58d065fb8ed7135f93cdb3d85762
DEBUG:root:test[disks]=[{'bus': 'virtio', 'size': '6G', 'target': 'vda', 'format': 'qcow2'}]
DEBUG:root:test[_attachments]={'preseed.cfg': {'stub': True, 'length': 13280, 'digest': 'md5-HIgvjbf0D28lu3H1pgZBTQ==', 'revpos': 2, 'content_type': u''}, 'pxe/pxelinux.cfg/52:54:00:8e:f2:b2': {'stub': True, 'length': 1094, 'digest': 'md5-KeKBuafr5mkHeHmS7Pq8Gg==', 'revpos': 7, 'content_type': u''}, 'tests/default': {'stub': True, 'length': 1216, 'digest': 'md5-T7/n+REEivXcleszSgepJQ==', 'revpos': 8, 'content_type': u''}, 'libvirt.xml': {'stub': True, 'length': 2184, 'digest': 'md5-BFFqJR9j8961CFH+EIk1Dw==', 'revpos': 11, 'content_type': 'application/xml'}, 'pxe/initrd': {'stub': True, 'length': 7657953, 'digest': 'md5-1xFAiDgaIKEhBHrKYJXVQQ==', 'revpos': 5, 'content_type': u''}, 'media_info': {'stub': True, 'length': 63, 'digest': 'md5-DYNy+7VYnmQo1pHbga50qA==', 'revpos': 3, 'content_type': u''}, 'run_test': {'stub': True, 'length': 5966, 'digest': 'md5-7e5ps+6K5ch/HY3jJBE1Hg==', 'revpos': 4, 'content_type': u''}, 'pxe/kernel': {'stub': True, 'length': 5968064, 'digest': 'md5-N4t8YEfBM509dp8q3ZRhxQ==', 'revpos': 6, 'content_type': u''}}
DEBUG:root:test[states]={'started': '2014-07-04T09:01:06.348471', 'configured': '2014-07-04T09:01:05.108672', 'creating': '2014-07-04T09:00:58.254618', 'created': '2014-07-04T09:01:04.520647'}
DEBUG:root:test[mac]=52:54:00:8e:f2:b2
DEBUG:root:test[_id]=718b82d3-e0de-45f1-bdea-9d02a92a909a
DEBUG:root:test[test_case]=default
ERROR:root:VM for test case 718b82d3-e0de-45f1-bdea-9d02a92a909a powered off but tests not completed
DEBUG:root:Undefine VM for  test case 718b82d3-e0de-45f1-bdea-9d02a92a909a
DEBUG:root:Cmd: ['virsh', 'undefine', '718b82d3-e0de-45f1-bdea-9d02a92a909a']
Domain 718b82d3-e0de-45f1-bdea-9d02a92a909a has been undefined

DEBUG:root:Collating output for test case 718b82d3-e0de-45f1-bdea-9d02a92a909a
Archiving artifacts
Recording test results
No test report files were found. Configuration error?
Build step 'Publish JUnit test result report' changed build result to FAILURE
Description set: 20140704