Build failed in Jenkins: precise-server-i386_default #904

Fri Jul 4 09:52:24 UTC 2014

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

------------------------------------------
Started due to content change in http://cdimages.ubuntu.com/ubuntu-server/precise/daily/current/SHA256SUMS
Building remotely on wazn in workspace <http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_default/ws/>
[precise-server-i386_default] $ /bin/bash /tmp/hudson5706835231412003796.sh
INFO:root:Checking/Downloading current build for variant server from http://cdimage.ubuntu.com/ubuntu-server/precise/daily
INFO:root:Remote file not available. Retrying in 15 minutes
INFO:root:Downloading ISO...

-------------------- 0.0%
-------------------- 3.5% 48.1 kBps 0:27 ETA  
######-------------- 32.1% 394.2 kBps 0:02 ETA  
#################### 100.0% 176.9 kBps DONE    

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

#################--- 88.7%
#################--- 88.7% 8.4 kBps 324:31 ETA  
#################--- 88.7% 133.2 kBps 9:48 ETA  
#################--- 88.8% 543.0 kBps 2:26 ETA  
#################--- 89.0% 1238.0 kBps 1:02 ETA  
#################--- 89.5% 3717.3 kBps 0:19 ETA  
##################-- 90.2% 4625.3 kBps 0:15 ETA  
##################-- 90.8% 4495.1 kBps 0:14 ETA  
##################-- 91.5% 4671.0 kBps 0:12 ETA  
##################-- 92.2% 5234.5 kBps 0:10 ETA  
##################-- 93.0% 5406.8 kBps 0:09 ETA  
##################-- 93.8% 6027.8 kBps 0:07 ETA  
##################-- 94.8% 6875.1 kBps 0:05 ETA  
###################- 95.9% 7684.8 kBps 0:03 ETA  
###################- 97.0% 8020.5 kBps 0:02 ETA  
###################- 98.2% 8222.9 kBps 0:01 ETA  
###################- 99.4% 8356.7 kBps 0:00 ETA  
#################### 100.0% 4561.2 kBps DONE    

verifying download...checksum matches OK
used 626012160 local, fetched 79685643
Syncing precise ubuntu-server server i386
Verifying ubuntu-server/precise-server-i386.iso
Verification succeeded
[precise-server-i386_default] $ /bin/bash /tmp/hudson2049854347431314494.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 270 revisions.
DEBUG:root:Options: {'isoroot': '/var/lib/ubuntu-iso-testing/isos', 'isoname': False, 'test_dir': '<http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_default/904/artifact/tests',> 'variant': 'server', 'release': 'precise', 'debug': False, 'flavor': 'ubuntu-server', 'arch': 'i386'}
DEBUG:root:Arguments: ['default']
INFO:root:Sleeping for 46 seconds (LP: #961217)
INFO:root:Preseed: default
INFO:root:Extracting kernel and initrd from /var/lib/ubuntu-iso-testing/isos/ubuntu-server/precise-server-i386.iso
DEBUG:root:Cmd: ['unbsdtar-safelink', '-xf', '/var/lib/ubuntu-iso-testing/isos/ubuntu-server/precise-server-i386.iso', '-C', '/tmp/precise-server-i386.iso-m5AJn0', 'install/vmlinuz', 'install/initrd.gz']
INFO:root:Generating default configuration
DEBUG:root:Loading test configuration file: '<http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_default/904/artifact/tests/test_cases/default/config'>
DEBUG:root:Couch Document UUID: '867ab4aa-e655-42dc-ade8-4be921678a9f'
DEBUG:root:Generate preseed file
DEBUG:root:will preseed /tmp/precise-server-i386.iso-m5AJn0/default-t77Buq/preseed
INFO:root:Uncompressing initrd
DEBUG:root:Initrd file: /tmp/precise-server-i386.iso-m5AJn0/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-server/precise-server-i386.iso', '-O', '.disk/info']
DEBUG:root:Media Info: Ubuntu-Server 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-server-i386_default/904/artifact/tests/run_test> -> /tmp/precise-server-i386.iso-m5AJn0/default-t77Buq/initrd-PQAknd
INFO:root:Copying <http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_default/904/artifact/tests/boottests.py> -> /tmp/precise-server-i386.iso-m5AJn0/default-t77Buq/initrd-PQAknd
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:24:30:e2', 'uuid': '867ab4aa-e655-42dc-ade8-4be921678a9f', '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-server-i386_default/904/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-server-i386_default/904/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: 867ab4aa-e655-42dc-ade8-4be921678a9f
DEBUG:root:Retrieving iso file
DEBUG:root:Generating disks
DEBUG:root:Cmd: ['qemu-img', 'create', '-f', 'qcow2', '/var/lib/ubuntu-iso-testing/tests/867ab4aa-e655-42dc-ade8-4be921678a9f/disk1.qcow2', '2G']
Formatting '/var/lib/ubuntu-iso-testing/tests/867ab4aa-e655-42dc-ade8-4be921678a9f/disk1.qcow2', fmt=qcow2 size=2147483648 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-server/precise-server-i386.iso', 'mac': '52:54:00:24:30:e2', 'disks': [{'source': '/var/lib/ubuntu-iso-testing/tests/867ab4aa-e655-42dc-ade8-4be921678a9f/disk1.qcow2', 'bus': 'virtio', 'size': '2G', 'target': 'vda', 'format': 'qcow2'}], 'name': '867ab4aa-e655-42dc-ade8-4be921678a9f', 'uuid': '867ab4aa-e655-42dc-ade8-4be921678a9f'}
DEBUG:root:Cmd: ['virsh', 'define', '/var/lib/ubuntu-iso-testing/tests/867ab4aa-e655-42dc-ade8-4be921678a9f/libvirt.xml']
Domain 867ab4aa-e655-42dc-ade8-4be921678a9f defined from /var/lib/ubuntu-iso-testing/tests/867ab4aa-e655-42dc-ade8-4be921678a9f/libvirt.xml

DEBUG:root:Starting test case 867ab4aa-e655-42dc-ade8-4be921678a9f
DEBUG:root:Cmd: ['virsh', 'start', '867ab4aa-e655-42dc-ade8-4be921678a9f']
Domain 867ab4aa-e655-42dc-ade8-4be921678a9f started

DEBUG:root:Cmd: ['sudo', 'chown', 'usit', '/tmp/867ab4aa-e655-42dc-ade8-4be921678a9f.syslog.log']
DEBUG:root:Checking VM state for test case 867ab4aa-e655-42dc-ade8-4be921678a9f
DEBUG:root:Cmd: ['virsh', 'domstate', '867ab4aa-e655-42dc-ade8-4be921678a9f']
DEBUG:root:running
DEBUG:root:test start: Jul 04 2014 09:51:51, Jul  4 09:51:59 wazn dnsmasq-dhcp[4833]: DHCPREQUEST(virbr999) 192.168.123.32 52:54:00:24:30:e2 
DEBUG:root:Got IP address of 192.168.123.32 for 867ab4aa-e655-42dc-ade8-4be921678a9f
DEBUG:root:Capturing current d-i syslog for test case 867ab4aa-e655-42dc-ade8-4be921678a9f
DEBUG:root:Jul  4 09:52:13 debconf: --> SET anna/retriever cdrom-retriever
Jul  4 09:52:13 debconf: <-- 0 value set
Jul  4 09:52:13 debconf: --> GET cdrom/codename
Jul  4 09:52:13 debconf: <-- 0 precise
Jul  4 09:52:13 cdrom-retriever: warning: File /cdrom/dists/precise/main/debian-installer/binary-i386/Packages does not exist.
Jul  4 09:52:13 cdrom-retriever: warning: File /cdrom/dists/precise/restricted/debian-installer/binary-i386/Packages does not exist.
Jul  4 09:52:13 anna[7381]: WARNING **: no packages matching running kernel 3.11.0-24-generic in archive
Jul  4 09:52:13 debconf: --> INPUT critical anna/no_kernel_modules
Jul  4 09:52:13 debconf: <-- 0 question will be asked
Jul  4 09:52:13 debconf: --> GO
INFO:root:Test 867ab4aa-e655-42dc-ade8-4be921678a9f: debian-installer reports error
DEBUG:root:Terminating test case 867ab4aa-e655-42dc-ade8-4be921678a9f
DEBUG:root:Cmd: ['virsh', 'destroy', '867ab4aa-e655-42dc-ade8-4be921678a9f']
Domain 867ab4aa-e655-42dc-ade8-4be921678a9f destroyed

DEBUG:root:test[iso_url]=/var/lib/ubuntu-iso-testing/isos/ubuntu-server/precise-server-i386.iso
DEBUG:root:test[_rev]=13-41b41c0d7f49c34dc0cd1a8a92ece83a
DEBUG:root:test[disks]=[{'bus': 'virtio', 'size': '2G', 'target': 'vda', 'format': 'qcow2'}]
DEBUG:root:test[_attachments]={'pxe/kernel': {'stub': True, 'length': 5968064, 'digest': 'md5-N4t8YEfBM509dp8q3ZRhxQ==', 'revpos': 6, 'content_type': u''}, 'tests/default': {'stub': True, 'length': 1216, 'digest': 'md5-T7/n+REEivXcleszSgepJQ==', 'revpos': 8, 'content_type': u''}, 'pxe/pxelinux.cfg/52:54:00:24:30:e2': {'stub': True, 'length': 1108, 'digest': 'md5-eMvaYsAkvAzlbmoq+GjZ5A==', 'revpos': 7, 'content_type': u''}, 'libvirt.xml': {'stub': True, 'length': 2031, 'digest': 'md5-yYShc1ZyJlbsBh/xkIX0Cg==', 'revpos': 11, 'content_type': 'application/xml'}, 'preseed': {'stub': True, 'length': 13166, 'digest': 'md5-BFcjMs2QbIbTYGZt8Shivg==', 'revpos': 2, 'content_type': u''}, 'pxe/initrd': {'stub': True, 'length': 7655302, 'digest': 'md5-jNRu4t9fajJKPlnoDSHK4Q==', 'revpos': 5, 'content_type': u''}, 'media_info': {'stub': True, 'length': 70, 'digest': 'md5-O6vF0u9LQq1al8U3YxzCVg==', 'revpos': 3, 'content_type': u''}, 'run_test': {'stub': True, 'length': 6943, 'digest': 'md5-ZbbgRpEcHSeMP9A+cvAv1Q==', 'revpos': 4, 'content_type': u''}}
DEBUG:root:test[states]={'started': '2014-07-04T09:51:52.985909', 'configured': '2014-07-04T09:51:51.932778', 'creating': '2014-07-04T09:51:45.387609', 'created': '2014-07-04T09:51:51.612691'}
DEBUG:root:test[mac]=52:54:00:24:30:e2
DEBUG:root:test[_id]=867ab4aa-e655-42dc-ade8-4be921678a9f
DEBUG:root:test[test_case]=default
ERROR:root:VM for test case 867ab4aa-e655-42dc-ade8-4be921678a9f powered off but tests not completed
DEBUG:root:Undefine VM for  test case 867ab4aa-e655-42dc-ade8-4be921678a9f
DEBUG:root:Cmd: ['virsh', 'undefine', '867ab4aa-e655-42dc-ade8-4be921678a9f']
Domain 867ab4aa-e655-42dc-ade8-4be921678a9f has been undefined

DEBUG:root:Collating output for test case 867ab4aa-e655-42dc-ade8-4be921678a9f
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