Build failed in Jenkins: precise-server-i386_samba-server #707

Tue Jan 7 10:14:42 UTC 2014

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

------------------------------------------
Started by upstream project "precise-server-i386_default" build number 744
[EnvInject] - Loading node environment variables.
Building remotely on wazn in workspace <http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_samba-server/ws/>
[precise-server-i386_samba-server] $ /bin/bash /tmp/hudson6696275937526827029.sh
INFO:root:Checking/Downloading current build for variant server from http://cdimage.ubuntu.com/ubuntu-server/precise/daily
INFO:root:Required ISO version 'precise-server-i386.iso' already in cache
[precise-server-i386_samba-server] $ /bin/bash /tmp/hudson4571751105655201190.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_samba-server/707/artifact/tests',> 'variant': 'server', 'release': 'precise', 'debug': False, 'flavor': 'ubuntu-server', 'arch': 'i386'}
DEBUG:root:Arguments: ['samba-server']
INFO:root:Sleeping for 46 seconds (LP: #961217)
INFO:root:Preseed: samba-server
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-vN_ewG', 'install/vmlinuz', 'install/initrd.gz']
INFO:root:Generating samba-server configuration
DEBUG:root:Loading test configuration file: '<http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_samba-server/707/artifact/tests/test_cases/samba-server/config'>
DEBUG:root:Couch Document UUID: 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81'
DEBUG:root:Generate preseed file
DEBUG:root:will preseed /tmp/precise-server-i386.iso-vN_ewG/samba-server-el0oEW/preseed
INFO:root:Uncompressing initrd
DEBUG:root:Initrd file: /tmp/precise-server-i386.iso-vN_ewG/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.3 LTS "Precise Pangolin" - Release i386 (20140107)
DEBUG:root:Copying preseed to tftp root
INFO:root:Copying <http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_samba-server/707/artifact/tests/run_test> -> /tmp/precise-server-i386.iso-vN_ewG/samba-server-el0oEW/initrd-T4NmI4
INFO:root:Copying <http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_samba-server/707/artifact/tests/boottests.py> -> /tmp/precise-server-i386.iso-vN_ewG/samba-server-el0oEW/initrd-T4NmI4
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:27:46:ed', 'uuid': 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81', '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_samba-server/707/artifact/tests/test_cases/samba-server/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_samba-server/707/artifact/tests/test_cases/samba-server>
DEBUG:root:Generating disk information
DEBUG:root:Setting state to created
DEBUG:root:Loading test case to run
INFO:root:Configuring test case: d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Retrieving iso file
DEBUG:root:Generating disks
DEBUG:root:Cmd: ['qemu-img', 'create', '-f', 'qcow2', '/var/lib/ubuntu-iso-testing/tests/d9eb2633-e67a-4d02-82e8-bdc7a4c35a81/disk1.qcow2', '2G']
Formatting '/var/lib/ubuntu-iso-testing/tests/d9eb2633-e67a-4d02-82e8-bdc7a4c35a81/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:27:46:ed', 'disks': [{'source': '/var/lib/ubuntu-iso-testing/tests/d9eb2633-e67a-4d02-82e8-bdc7a4c35a81/disk1.qcow2', 'bus': 'virtio', 'size': '2G', 'target': 'vda', 'format': 'qcow2'}], 'name': 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81', 'uuid': 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81'}
DEBUG:root:Cmd: ['virsh', 'define', '/var/lib/ubuntu-iso-testing/tests/d9eb2633-e67a-4d02-82e8-bdc7a4c35a81/libvirt.xml']
Domain d9eb2633-e67a-4d02-82e8-bdc7a4c35a81 defined from /var/lib/ubuntu-iso-testing/tests/d9eb2633-e67a-4d02-82e8-bdc7a4c35a81/libvirt.xml

DEBUG:root:Starting test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Cmd: ['virsh', 'start', 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81']
Domain d9eb2633-e67a-4d02-82e8-bdc7a4c35a81 started

DEBUG:root:Cmd: ['sudo', 'chown', 'usit', '/tmp/d9eb2633-e67a-4d02-82e8-bdc7a4c35a81.syslog.log']
DEBUG:root:Checking VM state for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Cmd: ['virsh', 'domstate', 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81']
DEBUG:root:running
DEBUG:root:test start: Jan 07 2014 10:10:39, Jan  7 10:10:47 wazn dnsmasq-dhcp[6594]: DHCPREQUEST(virbr999) 192.168.123.189 52:54:00:27:46:ed 
DEBUG:root:Got IP address of 192.168.123.189 for d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Capturing current d-i syslog for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Jan  7 10:11:08 debconf: <-- 0 OK
Jan  7 10:11:08 anna[7384]: DEBUG: retrieving partman-ext3 67ubuntu1.1
Jan  7 10:11:08 debconf: --> SUBST anna/progress_step_retr PACKAGE partman-ext3
Jan  7 10:11:08 debconf: Adding [PACKAGE] -> [partman-ext3]
Jan  7 10:11:08 debconf: <-- 0
Jan  7 10:11:08 debconf: --> PROGRESS INFO anna/progress_step_retr
Jan  7 10:11:08 debconf: <-- 0 OK
Jan  7 10:11:08 debconf: --> X_LOADTEMPLATEFILE /var/lib/dpkg/info/partman-ext3.templates partman-ext3
Jan  7 10:11:08 debconf: <-- 0 OK
Jan  7 10:11:08 debconf: --> X_SAVE
DEBUG:root:Checking VM state for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Cmd: ['virsh', 'domstate', 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Jan  7 10:11:39 debconf: --> PROGRESS INFO partman/progress/init/fallback
Jan  7 10:11:39 debconf: <-- 0 OK
Jan  7 10:11:39 debconf: --> PROGRESS STEP 1
Jan  7 10:11:39 debconf: <-- 0 OK
Jan  7 10:11:39 debconf: --> PROGRESS INFO partman/progress/init/md-devices
Jan  7 10:11:39 debconf: <-- 10 partman/progress/init/md-devices does not exist
Jan  7 10:11:39 debconf: --> PROGRESS INFO partman/progress/init/fallback
Jan  7 10:11:39 debconf: <-- 0 OK
Jan  7 10:11:39 debconf: --> REGISTER partman-md/confirm partman-md/confirm_nooverwrite
Jan  7 10:11:39 debconf: <-- 0
DEBUG:root:Checking VM state for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Cmd: ['virsh', 'domstate', 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Jan  7 10:12:09 debconf: <-- 0
Jan  7 10:12:09 debconf: --> PROGRESS INFO base-installer/debootstrap/info/configuring
Jan  7 10:12:09 debconf: <-- 0 OK
Jan  7 10:12:09 debconf: --> METAGET base-installer/debootstrap/info/unpackbase description
Jan  7 10:12:09 debconf: <-- 0 Unpacking the base system...
Jan  7 10:12:09 debconf: --> SUBST base-installer/debootstrap/info/unpackbase SECTION Configuring required packages
Jan  7 10:12:09 debconf: Adding [SECTION] -> [Configuring required packages]
Jan  7 10:12:09 debconf: <-- 0
Jan  7 10:12:09 debconf: --> PROGRESS INFO base-installer/debootstrap/info/unpackbase
Jan  7 10:12:09 debconf: <-- 0 OK
DEBUG:root:Checking VM state for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Cmd: ['virsh', 'domstate', 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Jan  7 10:12:40 in-target: debconf (developer): <---- 0 OK
Jan  7 10:12:40 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Preparing linux-headers-3.8.0-35
Jan  7 10:12:40 debconf: --> DATA debconf-apt-progress/info description Preparing linux-headers-3.8.0-35
Jan  7 10:12:40 debconf: <-- 0 OK
Jan  7 10:12:40 in-target: debconf (developer): <---- 0 OK
Jan  7 10:12:40 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Jan  7 10:12:40 debconf: --> PROGRESS INFO debconf-apt-progress/info
Jan  7 10:12:40 debconf: <-- 0 OK
Jan  7 10:12:40 in-target: debconf (developer): <---- 0 OK
Jan  7 10:12:40 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Cmd: ['virsh', 'domstate', 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Jan  7 10:13:10 in-target: debconf (developer): --> 0 OK
Jan  7 10:13:10 in-target: debconf (developer): <-- PROGRESS SET 10
Jan  7 10:13:10 debconf: --> PROGRESS SET 10
Jan  7 10:13:10 debconf: <-- 0 OK
Jan  7 10:13:10 in-target: debconf (developer): ----> PROGRESS SET 10
Jan  7 10:13:10 in-target: debconf (developer): <---- 0 OK
Jan  7 10:13:10 in-target: debconf (developer): --> 0 OK
Jan  7 10:13:10 in-target: debconf (developer): <-- SUBST debconf-apt-progress/info DESCRIPTION Retrieving file 2 of 28
Jan  7 10:13:10 in-target: debconf (developer): --> 0
Jan  7 10:13:10 in-target: debconf (developer): <-- PROGRESS INFO debconf-apt-progress/info
DEBUG:root:Checking VM state for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Cmd: ['virsh', 'domstate', 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Jan  7 10:13:38 debconf: <-- 0 OK
Jan  7 10:13:38 in-target: debconf (developer): <---- 0 OK
Jan  7 10:13:38 in-target: debconf (developer): --> 0 OK
Jan  7 10:13:38 in-target: debconf (developer): <-- SUBST debconf-apt-progress/info DESCRIPTION Preparing to configure libp11-kit0
Jan  7 10:13:38 in-target: debconf (developer): --> 0
Jan  7 10:13:38 in-target: debconf (developer): <-- PROGRESS INFO debconf-apt-progress/info
Jan  7 10:13:38 in-target: debconf (developer): ----> DATA debconf-apt-progress/info type text
Jan  7 10:13:38 debconf: --> DATA debconf-apt-progress/info type text
Jan  7 10:13:38 debconf: <-- 0 OK
Jan  7 10:13:38 in-target: debconf (developer): <---- 0 OK
DEBUG:root:Checking VM state for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Cmd: ['virsh', 'domstate', 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Jan  7 10:14:10 debconf: <-- 0 OK
Jan  7 10:14:10 in-target: debconf (developer): <---- 0 OK
Jan  7 10:14:10 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Configuring libxext6
Jan  7 10:14:10 debconf: --> DATA debconf-apt-progress/info description Configuring libxext6
Jan  7 10:14:10 debconf: <-- 0 OK
Jan  7 10:14:10 in-target: debconf (developer): <---- 0 OK
Jan  7 10:14:10 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Jan  7 10:14:10 debconf: --> PROGRESS INFO debconf-apt-progress/info
Jan  7 10:14:10 debconf: <-- 0 OK
Jan  7 10:14:10 in-target: debconf (developer): <---- 0 OK
DEBUG:root:Checking VM state for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Cmd: ['virsh', 'domstate', 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Jan  7 10:14:34 debconf: --> CAPB
Jan  7 10:14:34 debconf: <-- 0 multiselect backup progresscancel align plugin-terminal plugin-detect-keyboard
Jan  7 10:14:34 debconf: --> METAGET debian-installer/pkgsel/title Description
Jan  7 10:14:34 debconf: <-- 0 Select and install software
Jan  7 10:14:34 debconf: --> SUBST debian-installer/main-menu/item-failure ITEM Select and install software
Jan  7 10:14:34 debconf: Adding [ITEM] -> [Select and install software]
Jan  7 10:14:34 debconf: <-- 0
Jan  7 10:14:34 debconf: --> INPUT critical debian-installer/main-menu/item-failure
Jan  7 10:14:34 debconf: <-- 0 question will be asked
Jan  7 10:14:34 debconf: --> GO
INFO:root:Test d9eb2633-e67a-4d02-82e8-bdc7a4c35a81: debian-installer reports error
DEBUG:root:Terminating test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Cmd: ['virsh', 'destroy', 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81']
Domain d9eb2633-e67a-4d02-82e8-bdc7a4c35a81 destroyed

DEBUG:root:test[iso_url]=/var/lib/ubuntu-iso-testing/isos/ubuntu-server/precise-server-i386.iso
DEBUG:root:test[_rev]=13-ed3d330f395131e4b47dc4fe59906562
DEBUG:root:test[disks]=[{'bus': 'virtio', 'size': '2G', 'target': 'vda', 'format': 'qcow2'}]
DEBUG:root:test[_attachments]={'pxe/kernel': {'stub': True, 'length': 5469504, 'digest': 'md5-4ALfly9/MXhvIzcpALyLWA==', 'revpos': 6, 'content_type': u''}, 'pxe/pxelinux.cfg/52:54:00:27:46:ed': {'stub': True, 'length': 1108, 'digest': 'md5-fvCgtYRrmUjtHZLOiIR82g==', 'revpos': 7, 'content_type': u''}, 'tests/samba-server': {'stub': True, 'length': 2780, 'digest': 'md5-eBDYeE0VQshtFTQYMKleiA==', 'revpos': 8, 'content_type': u''}, 'libvirt.xml': {'stub': True, 'length': 2031, 'digest': 'md5-Fv4BqI4Ar0SeZh3B32V6bQ==', 'revpos': 11, 'content_type': 'application/xml'}, 'preseed': {'stub': True, 'length': 13185, 'digest': 'md5-FF6u1K8smaxbkQLInGA6EA==', 'revpos': 2, 'content_type': u''}, 'pxe/initrd': {'stub': True, 'length': 6579968, 'digest': 'md5-DJk5AvModndS4tAepslp2A==', 'revpos': 5, 'content_type': u''}, 'media_info': {'stub': True, 'length': 70, 'digest': 'md5-K2VXrXY1uCxkdWwSqfhYpQ==', '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-01-07T10:10:40.486152', 'configured': '2014-01-07T10:10:39.205557', 'creating': '2014-01-07T10:10:33.624331', 'created': '2014-01-07T10:10:38.909557'}
DEBUG:root:test[mac]=52:54:00:27:46:ed
DEBUG:root:test[_id]=d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:test[test_case]=samba-server
ERROR:root:VM for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81 powered off but tests not completed
WARNING:root:Could not move syslog ([Errno 13] Permission denied: '/tmp/d9eb2633-e67a-4d02-82e8-bdc7a4c35a81.syslog.log')
DEBUG:root:Undefine VM for  test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
DEBUG:root:Cmd: ['virsh', 'undefine', 'd9eb2633-e67a-4d02-82e8-bdc7a4c35a81']
Domain d9eb2633-e67a-4d02-82e8-bdc7a4c35a81 has been undefined

DEBUG:root:Collating output for test case d9eb2633-e67a-4d02-82e8-bdc7a4c35a81
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: 20140107