Build failed in Jenkins: precise-alternate-i386_oem #563

[Jenkins Notification]

See <http://10.189.74.2:8080/job/precise-alternate-i386_oem/563/>

------------------------------------------
[...truncated 937 lines...]
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:48:50 in-target: debconf (developer): <---- 0 OK
Mar 25 09:48:50 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Configuring libgeoip1
Mar 25 09:48:50 debconf: --> DATA debconf-apt-progress/info description Configuring libgeoip1
Mar 25 09:48:50 debconf: <-- 0 OK
Mar 25 09:48:50 in-target: debconf (developer): <---- 0 OK
Mar 25 09:48:50 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:48:50 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:48:50 debconf: <-- 0 OK
Mar 25 09:48:50 in-target: debconf (developer): <---- 0 OK
Mar 25 09:48:50 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:49:18 in-target: debconf (developer): <---- 0 OK
Mar 25 09:49:18 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Configuring update-manager-core
Mar 25 09:49:18 debconf: --> DATA debconf-apt-progress/info description Configuring update-manager-core
Mar 25 09:49:18 debconf: <-- 0 OK
Mar 25 09:49:18 in-target: debconf (developer): <---- 0 OK
Mar 25 09:49:18 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:49:18 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:49:18 debconf: <-- 0 OK
Mar 25 09:49:18 in-target: debconf (developer): <---- 0 OK
Mar 25 09:49:18 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:49:51 in-target: debconf (developer): <---- 0 OK
Mar 25 09:49:51 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Configuring python-wadllib
Mar 25 09:49:51 debconf: --> DATA debconf-apt-progress/info description Configuring python-wadllib
Mar 25 09:49:51 debconf: <-- 0 OK
Mar 25 09:49:51 in-target: debconf (developer): <---- 0 OK
Mar 25 09:49:51 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:49:51 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:49:51 debconf: <-- 0 OK
Mar 25 09:49:51 in-target: debconf (developer): <---- 0 OK
Mar 25 09:49:51 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:50:22 in-target: debconf (developer): <---- 0 OK
Mar 25 09:50:22 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Installed libprotobuf7
Mar 25 09:50:22 debconf: --> DATA debconf-apt-progress/info description Installed libprotobuf7
Mar 25 09:50:22 debconf: <-- 0 OK
Mar 25 09:50:22 in-target: debconf (developer): <---- 0 OK
Mar 25 09:50:22 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:50:22 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:50:22 debconf: <-- 0 OK
Mar 25 09:50:22 in-target: debconf (developer): <---- 0 OK
Mar 25 09:50:22 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:50:52 in-target: debconf (developer): <---- 0 OK
Mar 25 09:50:52 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Installed gcalctool
Mar 25 09:50:52 debconf: --> DATA debconf-apt-progress/info description Installed gcalctool
Mar 25 09:50:52 debconf: <-- 0 OK
Mar 25 09:50:52 in-target: debconf (developer): <---- 0 OK
Mar 25 09:50:52 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:50:52 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:50:52 debconf: <-- 0 OK
Mar 25 09:50:52 in-target: debconf (developer): <---- 0 OK
Mar 25 09:50:52 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:51:21 in-target: debconf (developer): <---- 0 OK
Mar 25 09:51:21 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Configuring gnome-orca
Mar 25 09:51:21 debconf: --> DATA debconf-apt-progress/info description Configuring gnome-orca
Mar 25 09:51:21 debconf: <-- 0 OK
Mar 25 09:51:21 in-target: debconf (developer): <---- 0 OK
Mar 25 09:51:21 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:51:21 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:51:21 debconf: <-- 0 OK
Mar 25 09:51:21 in-target: debconf (developer): <---- 0 OK
Mar 25 09:51:21 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:51:53 in-target: debconf (developer): <---- 0 OK
Mar 25 09:51:53 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Configuring ibus-gtk
Mar 25 09:51:53 debconf: --> DATA debconf-apt-progress/info description Configuring ibus-gtk
Mar 25 09:51:53 debconf: <-- 0 OK
Mar 25 09:51:53 in-target: debconf (developer): <---- 0 OK
Mar 25 09:51:53 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:51:53 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:51:53 debconf: <-- 0 OK
Mar 25 09:51:53 in-target: debconf (developer): <---- 0 OK
Mar 25 09:51:53 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:52:20 in-target: debconf (developer): <---- 0 OK
Mar 25 09:52:20 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Installed libfile-mimeinfo-perl
Mar 25 09:52:20 debconf: --> DATA debconf-apt-progress/info description Installed libfile-mimeinfo-perl
Mar 25 09:52:20 debconf: <-- 0 OK
Mar 25 09:52:20 in-target: debconf (developer): <---- 0 OK
Mar 25 09:52:20 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:52:20 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:52:20 debconf: <-- 0 OK
Mar 25 09:52:20 in-target: debconf (developer): <---- 0 OK
Mar 25 09:52:20 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:52:53 in-target: debconf (developer): <---- 0 OK
Mar 25 09:52:53 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Configuring modemmanager
Mar 25 09:52:53 debconf: --> DATA debconf-apt-progress/info description Configuring modemmanager
Mar 25 09:52:53 debconf: <-- 0 OK
Mar 25 09:52:53 in-target: debconf (developer): <---- 0 OK
Mar 25 09:52:53 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:52:53 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:52:53 debconf: <-- 0 OK
Mar 25 09:52:53 in-target: debconf (developer): <---- 0 OK
Mar 25 09:52:53 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:53:23 in-target: debconf (developer): starting /var/lib/dpkg/info/sane-utils.postinst configure 
Mar 25 09:53:23 in-target: debconf (developer): <-- GET sane-utils/saned_run
Mar 25 09:53:23 in-target: debconf (developer): --> 0 false
Mar 25 09:53:23 in-target: debconf (developer): <-- STOP
Mar 25 09:53:23 in-target: Adding saned group and user...
Mar 25 05:53:23 groupadd[8735]: group added to /etc/group: name=saned, GID=123
Mar 25 05:53:23 groupadd[8735]: group added to /etc/gshadow: name=saned
Mar 25 05:53:23 groupadd[8735]: new group: name=saned, GID=123
Mar 25 05:53:23 useradd[8739]: new user: name=saned, UID=112, GID=123, home=/home/saned, shell=/bin/false
Mar 25 05:53:23 usermod[8744]: change user 'saned' password
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:53:54 in-target: debconf (developer): <---- 0 OK
Mar 25 09:53:54 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Installed x11-session-utils
Mar 25 09:53:54 debconf: --> DATA debconf-apt-progress/info description Installed x11-session-utils
Mar 25 09:53:54 debconf: <-- 0 OK
Mar 25 09:53:54 in-target: debconf (developer): <---- 0 OK
Mar 25 09:53:54 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:53:54 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:53:54 debconf: <-- 0 OK
Mar 25 09:53:54 in-target: debconf (developer): <---- 0 OK
Mar 25 09:53:54 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:54:24 in-target: debconf (developer): <---- 0 OK
Mar 25 09:54:24 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:54:24 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:54:24 debconf: <-- 0 OK
Mar 25 09:54:24 in-target: debconf (developer): <---- 0 OK
Mar 25 09:54:24 in-target: debconf (developer): --> 0 OK
Mar 25 09:54:24 in-target: debconf (developer): <-- PROGRESS SET 766
Mar 25 09:54:24 in-target: debconf (developer): ----> PROGRESS SET 766
Mar 25 09:54:24 debconf: --> PROGRESS SET 766
M
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:54:54 in-target: debconf (developer): <---- 0 OK
Mar 25 09:54:54 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Installed libgnome-media-profiles-3.0-0
Mar 25 09:54:54 debconf: --> DATA debconf-apt-progress/info description Installed libgnome-media-profiles-3.0-0
Mar 25 09:54:54 debconf: <-- 0 OK
Mar 25 09:54:54 in-target: debconf (developer): <---- 0 OK
Mar 25 09:54:54 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:54:54 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:54:54 debconf: <-- 0 OK
Mar 25 09:54:54 in-target: debconf (developer): <---- 0 OK
Mar 25 09:54:54 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:55:25 in-target: debconf (developer): <---- 0 OK
Mar 25 09:55:25 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Installed libgksu2-0
Mar 25 09:55:25 debconf: --> DATA debconf-apt-progress/info description Installed libgksu2-0
Mar 25 09:55:25 debconf: <-- 0 OK
Mar 25 09:55:25 in-target: debconf (developer): <---- 0 OK
Mar 25 09:55:25 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:55:25 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:55:25 debconf: <-- 0 OK
Mar 25 09:55:25 in-target: debconf (developer): <---- 0 OK
Mar 25 09:55:25 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:55:55 in-target: debconf (developer): <---- 0 OK
Mar 25 09:55:55 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Configuring unity-2d-shell
Mar 25 09:55:55 debconf: --> DATA debconf-apt-progress/info description Configuring unity-2d-shell
Mar 25 09:55:55 debconf: <-- 0 OK
Mar 25 09:55:55 in-target: debconf (developer): <---- 0 OK
Mar 25 09:55:55 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:55:55 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:55:55 debconf: <-- 0 OK
Mar 25 09:55:55 in-target: debconf (developer): <---- 0 OK
Mar 25 09:55:55 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Mar 25 09:56:20 debconf: --> DATA debconf-apt-progress/info description Configuring software-center
Mar 25 09:56:20 debconf: <-- 0 OK
Mar 25 09:56:20 in-target: debconf (developer): <---- 0 OK
Mar 25 09:56:20 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:56:20 debconf: --> PROGRESS INFO debconf-apt-progress/info
Mar 25 09:56:20 debconf: <-- 0 OK
Mar 25 09:56:20 in-target: debconf (developer): <---- 0 OK
Mar 25 09:56:20 in-target: debconf (developer): --> 0 OK
Mar 25 09:56:22 in-target: WARNING:softwarecenter.db.update:Failed to setup dbus (ignoring)
Mar 25 09:56:22 in-target: INFO:softwarecenter.db.pkginfo_impl.aptcache:aptcache.open()
DEBUG:root:Checking VM state for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'domstate', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
DEBUG:root:running
DEBUG:root:Test 5ebe322d-f294-49d9-9b18-f851f0c86c8e failed to execute within 40 minutes
DEBUG:root:Terminating test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'destroy', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
Domain 5ebe322d-f294-49d9-9b18-f851f0c86c8e destroyed

DEBUG:root:test[iso_url]=/var/lib/ubuntu-iso-testing/isos/ubuntu/precise-alternate-i386.iso
DEBUG:root:test[_rev]=13-27c0025f3d60ed53a5bd33525a023388
DEBUG:root:test[disks]=[{'bus': 'virtio', 'size': '6G', 'target': 'vda', 'format': 'qcow2'}]
DEBUG:root:test[_attachments]={'preseed.cfg': {'stub': True, 'length': 13346, 'revpos': 2, 'content_type': ''}, 'tests/oem': {'stub': True, 'length': 2635, 'revpos': 8, 'content_type': ''}, 'libvirt.xml': {'stub': True, 'length': 2184, 'revpos': 11, 'content_type': 'application/xml'}, 'pxe/pxelinux.cfg/52:54:00:a8:6b:80': {'stub': True, 'length': 1116, 'revpos': 7, 'content_type': ''}, 'pxe/initrd': {'stub': True, 'length': 6455648, 'revpos': 5, 'content_type': ''}, 'media_info': {'stub': True, 'length': 63, 'revpos': 3, 'content_type': ''}, 'run_test': {'stub': True, 'length': 5966, 'revpos': 4, 'content_type': ''}, 'pxe/kernel': {'stub': True, 'length': 5237968, 'revpos': 6, 'content_type': ''}}
DEBUG:root:test[states]={'started': '2013-03-25T09:16:26.344481', 'configured': '2013-03-25T09:16:23.231065', 'creating': '2013-03-25T09:16:16.263329', 'created': '2013-03-25T09:16:21.833018'}
DEBUG:root:test[mac]=52:54:00:a8:6b:80
DEBUG:root:test[_id]=5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:test[test_case]=oem
ERROR:root:VM for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e powered off but tests not completed
DEBUG:root:Undefine VM for  test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
DEBUG:root:Cmd: ['virsh', 'undefine', '5ebe322d-f294-49d9-9b18-f851f0c86c8e']
Domain 5ebe322d-f294-49d9-9b18-f851f0c86c8e has been undefined

DEBUG:root:Collating output for test case 5ebe322d-f294-49d9-9b18-f851f0c86c8e
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: 20130325