Build failed in Jenkins: precise-server-amd64_raid1 #362
Jenkins Notification
devnull at canonical.com
Thu Nov 29 10:49:30 UTC 2012
See <http://10.189.74.2:8080/job/precise-server-amd64_raid1/362/>
------------------------------------------
[...truncated 968 lines...]
DEBUG:root:Nov 29 10:39:35 in-target: debconf (developer): <---- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Preparing linux-firmware
Nov 29 10:39:35 debconf: --> DATA debconf-apt-progress/info description Preparing linux-firmware
Nov 29 10:39:35 debconf: <-- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): <---- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:39:35 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:39:35 debconf: <-- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): <---- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:39:35 in-target: debconf (developer): <---- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Preparing linux-firmware
Nov 29 10:39:35 debconf: --> DATA debconf-apt-progress/info description Preparing linux-firmware
Nov 29 10:39:35 debconf: <-- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): <---- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:39:35 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:39:35 debconf: <-- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): <---- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:39:35 in-target: debconf (developer): <---- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Preparing linux-firmware
Nov 29 10:39:35 debconf: --> DATA debconf-apt-progress/info description Preparing linux-firmware
Nov 29 10:39:35 debconf: <-- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): <---- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:39:35 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:39:35 debconf: <-- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): <---- 0 OK
Nov 29 10:39:35 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:43:08 in-target: debconf (developer): <---- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Preparing linux-headers-3.5.0-19
Nov 29 10:43:08 debconf: --> DATA debconf-apt-progress/info description Preparing linux-headers-3.5.0-19
Nov 29 10:43:08 debconf: <-- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): <---- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:43:08 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:43:08 debconf: <-- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): <---- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:43:08 in-target: debconf (developer): <---- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Preparing linux-headers-3.5.0-19
Nov 29 10:43:08 debconf: --> DATA debconf-apt-progress/info description Preparing linux-headers-3.5.0-19
Nov 29 10:43:08 debconf: <-- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): <---- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:43:08 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:43:08 debconf: <-- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): <---- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:43:08 in-target: debconf (developer): <---- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Preparing linux-headers-3.5.0-19
Nov 29 10:43:08 debconf: --> DATA debconf-apt-progress/info description Preparing linux-headers-3.5.0-19
Nov 29 10:43:08 debconf: <-- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): <---- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:43:08 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:43:08 debconf: <-- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): <---- 0 OK
Nov 29 10:43:08 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:44:45 kernel: [ 2109.672684] md: md0: resync done.
Nov 29 10:44:45 kernel: [ 2109.687647] md: delaying resync of md1 until md2 has finished (they share one or more physical units)
Nov 29 10:44:45 kernel: [ 2109.687653] md: resync of RAID array md2
Nov 29 10:44:45 kernel: [ 2109.687655] md: minimum _guaranteed_ speed: 1000 KB/sec/disk.
Nov 29 10:44:45 kernel: [ 2109.687656] md: using maximum available idle IO bandwidth (but not more than 200000 KB/sec) for resync.
Nov 29 10:44:45 kernel: [ 2109.687658] md: using 128k window, over a total of 2317248k.
Nov 29 10:44:45 kernel: [ 2109.703273] RAID1 conf printout:
Nov 29 10:44:45 kernel: [ 2109.703275] --- wd:2 rd:2
Nov 29 10:44:45 kernel: [ 2109.703278] disk 0, wo:0, o:1, dev:vda1
Nov 29 10:44:45 kernel: [ 2109.703279] disk 1, wo:0, o:1, dev:vdb1
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:44:45 kernel: [ 2109.672684] md: md0: resync done.
Nov 29 10:44:45 kernel: [ 2109.687647] md: delaying resync of md1 until md2 has finished (they share one or more physical units)
Nov 29 10:44:45 kernel: [ 2109.687653] md: resync of RAID array md2
Nov 29 10:44:45 kernel: [ 2109.687655] md: minimum _guaranteed_ speed: 1000 KB/sec/disk.
Nov 29 10:44:45 kernel: [ 2109.687656] md: using maximum available idle IO bandwidth (but not more than 200000 KB/sec) for resync.
Nov 29 10:44:45 kernel: [ 2109.687658] md: using 128k window, over a total of 2317248k.
Nov 29 10:44:45 kernel: [ 2109.703273] RAID1 conf printout:
Nov 29 10:44:45 kernel: [ 2109.703275] --- wd:2 rd:2
Nov 29 10:44:45 kernel: [ 2109.703278] disk 0, wo:0, o:1, dev:vda1
Nov 29 10:44:45 kernel: [ 2109.703279] disk 1, wo:0, o:1, dev:vdb1
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:44:45 kernel: [ 2109.672684] md: md0: resync done.
Nov 29 10:44:45 kernel: [ 2109.687647] md: delaying resync of md1 until md2 has finished (they share one or more physical units)
Nov 29 10:44:45 kernel: [ 2109.687653] md: resync of RAID array md2
Nov 29 10:44:45 kernel: [ 2109.687655] md: minimum _guaranteed_ speed: 1000 KB/sec/disk.
Nov 29 10:44:45 kernel: [ 2109.687656] md: using maximum available idle IO bandwidth (but not more than 200000 KB/sec) for resync.
Nov 29 10:44:45 kernel: [ 2109.687658] md: using 128k window, over a total of 2317248k.
Nov 29 10:44:45 kernel: [ 2109.703273] RAID1 conf printout:
Nov 29 10:44:45 kernel: [ 2109.703275] --- wd:2 rd:2
Nov 29 10:44:45 kernel: [ 2109.703278] disk 0, wo:0, o:1, dev:vda1
Nov 29 10:44:45 kernel: [ 2109.703279] disk 1, wo:0, o:1, dev:vdb1
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:46:21 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Configuring linux-image-3.5.0-19-generic
Nov 29 10:46:21 debconf: --> DATA debconf-apt-progress/info description Configuring linux-image-3.5.0-19-generic
Nov 29 10:46:21 debconf: <-- 0 OK
Nov 29 10:46:21 in-target: debconf (developer): <---- 0 OK
Nov 29 10:46:21 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:46:21 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:46:21 debconf: <-- 0 OK
Nov 29 10:46:21 in-target: debconf (developer): <---- 0 OK
Nov 29 10:46:21 in-target: debconf (developer): --> 0 OK
Nov 29 10:46:21 in-target: Running depmod.
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:46:21 in-target: debconf (developer): <---- 0 OK
Nov 29 10:46:21 in-target: debconf (developer): --> 0 OK
Nov 29 10:46:21 in-target: Running depmod.
Nov 29 10:46:24 in-target: update-initramfs: deferring update (hook will be called later)
Nov 29 10:46:24 in-target: Examining /etc/kernel/postinst.d.
Nov 29 10:46:24 in-target: run-parts: executing /etc/kernel/postinst.d/initramfs-tools
Nov 29 10:46:24 in-target: 3.5.0-19-generic
Nov 29 10:46:24 in-target: /boot/vmlinuz-3.5.0-19-generic
Nov 29 10:46:24 in-target:
Nov 29 10:46:24 in-target: update-initramfs: Generating /boot/initrd.img-3.5.0-19-generic
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:47:24 in-target: debconf (developer): <---- 0 OK
Nov 29 10:47:24 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Retrieving file 12 of 57
Nov 29 10:47:24 debconf: --> DATA debconf-apt-progress/info description Retrieving file 12 of 57
Nov 29 10:47:24 debconf: <-- 0 OK
Nov 29 10:47:24 in-target: debconf (developer): <---- 0 OK
Nov 29 10:47:24 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:47:24 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:47:24 debconf: <-- 0 OK
Nov 29 10:47:24 in-target: debconf (developer): <---- 0 OK
Nov 29 10:47:24 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:47:42 in-target: debconf (developer): <---- 0 OK
Nov 29 10:47:42 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Retrieving file 69 of 69
Nov 29 10:47:42 debconf: --> DATA debconf-apt-progress/info description Retrieving file 69 of 69
Nov 29 10:47:42 debconf: <-- 0 OK
Nov 29 10:47:42 in-target: debconf (developer): <---- 0 OK
Nov 29 10:47:42 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:47:42 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:47:42 debconf: <-- 0 OK
Nov 29 10:47:42 in-target: debconf (developer): <---- 0 OK
Nov 29 10:47:42 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:48:24 in-target: debconf (developer): <---- 0 OK
Nov 29 10:48:24 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Preparing python-apt
Nov 29 10:48:24 debconf: --> DATA debconf-apt-progress/info description Preparing python-apt
Nov 29 10:48:24 debconf: <-- 0 OK
Nov 29 10:48:24 in-target: debconf (developer): <---- 0 OK
Nov 29 10:48:24 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:48:24 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:48:24 debconf: <-- 0 OK
Nov 29 10:48:24 in-target: debconf (developer): <---- 0 OK
Nov 29 10:48:24 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:48:48 in-target: debconf (developer): <---- 0 OK
Nov 29 10:48:48 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Preparing perl
Nov 29 10:48:48 debconf: --> DATA debconf-apt-progress/info description Preparing perl
Nov 29 10:48:48 debconf: <-- 0 OK
Nov 29 10:48:48 in-target: debconf (developer): <---- 0 OK
Nov 29 10:48:48 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:48:48 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:48:48 debconf: <-- 0 OK
Nov 29 10:48:48 in-target: debconf (developer): <---- 0 OK
Nov 29 10:48:48 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Nov 29 10:49:24 in-target: debconf (developer): <---- 0 OK
Nov 29 10:49:24 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Configuring apt-xapian-index
Nov 29 10:49:24 debconf: --> DATA debconf-apt-progress/info description Configuring apt-xapian-index
Nov 29 10:49:24 debconf: <-- 0 OK
Nov 29 10:49:24 in-target: debconf (developer): <---- 0 OK
Nov 29 10:49:24 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:49:24 debconf: --> PROGRESS INFO debconf-apt-progress/info
Nov 29 10:49:24 debconf: <-- 0 OK
Nov 29 10:49:24 in-target: debconf (developer): <---- 0 OK
Nov 29 10:49:24 in-target: debconf (developer): --> 0 OK
DEBUG:root:Checking VM state for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'domstate', '692130a2-0d05-4538-8c4a-83044e25cea5']
error: failed to get domain '692130a2-0d05-4538-8c4a-83044e25cea5'
error: Cannot write data: Broken pipe
error: Reconnected to the hypervisor
DEBUG:root:
DEBUG:root:Test 692130a2-0d05-4538-8c4a-83044e25cea5 failed to execute within 40 minutes
DEBUG:root:Terminating test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'destroy', '692130a2-0d05-4538-8c4a-83044e25cea5']
Domain 692130a2-0d05-4538-8c4a-83044e25cea5 destroyed
DEBUG:root:test[iso_url]=/var/lib/ubuntu-iso-testing/isos/ubuntu-server/precise-server-amd64.iso
DEBUG:root:test[_rev]=13-d268d940c80c794dbc860c45381e885f
DEBUG:root:test[disks]=[{'bus': 'virtio', 'size': '4G', 'target': 'vda', 'format': 'qcow2'}, {'bus': 'virtio', 'size': '4G', 'target': 'vdb', 'format': 'qcow2'}]
DEBUG:root:test[_attachments]={'pxe/kernel': {'stub': True, 'length': 5190168, 'revpos': 6, 'content_type': ''}, 'tests/raid1': {'stub': True, 'length': 3793, 'revpos': 8, 'content_type': ''}, 'pxe/pxelinux.cfg/52:54:00:94:d9:b8': {'stub': True, 'length': 1108, 'revpos': 7, 'content_type': ''}, 'preseed': {'stub': True, 'length': 14928, 'revpos': 2, 'content_type': ''}, 'libvirt.xml': {'stub': True, 'length': 2261, 'revpos': 11, 'content_type': 'application/xml'}, 'pxe/initrd': {'stub': True, 'length': 7815122, 'revpos': 5, 'content_type': ''}, 'media_info': {'stub': True, 'length': 71, 'revpos': 3, 'content_type': ''}, 'run_test': {'stub': True, 'length': 6943, 'revpos': 4, 'content_type': ''}}
DEBUG:root:test[states]={'started': '2012-11-29T10:09:19.249625', 'configured': '2012-11-29T10:09:16.160285', 'creating': '2012-11-29T10:09:03.909272', 'created': '2012-11-29T10:09:15.063153'}
DEBUG:root:test[mac]=52:54:00:94:d9:b8
DEBUG:root:test[_id]=692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:test[test_case]=raid1
ERROR:root:VM for test case 692130a2-0d05-4538-8c4a-83044e25cea5 powered off but tests not completed
DEBUG:root:Undefine VM for test case 692130a2-0d05-4538-8c4a-83044e25cea5
DEBUG:root:Cmd: ['virsh', 'undefine', '692130a2-0d05-4538-8c4a-83044e25cea5']
Domain 692130a2-0d05-4538-8c4a-83044e25cea5 has been undefined
DEBUG:root:Collating output for test case 692130a2-0d05-4538-8c4a-83044e25cea5
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
More information about the ubuntu-testing-notifications
mailing list