Build failed in Jenkins: precise-server-i386_lamp-reboot #682

Jenkins Notification devnull at canonical.com
Thu May 22 10:14:13 UTC 2014 

See <http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_lamp-reboot/682/>

------------------------------------------
[...truncated 141 lines...]
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:08:42 debconf: --> DATA debconf-apt-progress/info description Preparing libusb-1.0-0
May 22 10:08:42 debconf: <-- 0 OK
May 22 10:08:42 in-target: debconf (developer): <---- 0 OK
May 22 10:08:42 in-target: debconf (developer): ----> PROGRESS INFO debconf-apt-progress/info
May 22 10:08:42 debconf: --> PROGRESS INFO debconf-apt-progress/info
May 22 10:08:42 debconf: <-- 0 OK
May 22 10:08:42 in-target: debconf (developer): <---- 0 OK
May 22 10:08:42 in-target: debconf (developer): --> 0 OK
May 22 10:08:42 in-target: debconf (developer): <-- SUBST debconf-apt-progress/info DESCRIPTION Unpacking libusb-1.0-0
May 22 10:08:42 in-target: debconf (developer): --> 0
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:09:11 debconf: --> PROGRESS SET 1100
May 22 10:09:11 debconf: <-- 0 OK
May 22 10:09:11 debconf: --> GET mirror/protocol
May 22 10:09:11 debconf: <-- 0 http
May 22 10:09:11 debconf: --> GET mirror/http/proxy
May 22 10:09:11 debconf: <-- 0 http://192.168.123.1:3142
May 22 10:09:11 debconf: --> GET debconf/priority
May 22 10:09:11 debconf: <-- 0 critical
May 22 10:09:11 debconf: --> GET debian-installer/locale
May 22 10:09:11 debconf: <-- 0 en_US.UTF-8
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:09:35 in-target: debconf (developer): <-- PROGRESS SET 150
May 22 10:09:35 in-target: debconf (developer): ----> PROGRESS SET 150
May 22 10:09:35 debconf: --> PROGRESS SET 150
May 22 10:09:35 debconf: <-- 0 OK
May 22 10:09:35 in-target: debconf (developer): <---- 0 OK
May 22 10:09:35 in-target: debconf (developer): --> 0 OK
May 22 10:09:35 in-target: debconf (developer): <-- SUBST debconf-apt-progress/info DESCRIPTION Retrieving file 80 of 169
May 22 10:09:35 in-target: debconf (developer): --> 0
May 22 10:09:35 in-target: debconf (developer): <-- PROGRESS INFO debconf-apt-progress/info
May 22 10:09:35 in-target: de
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:09:59 in-target: debconf (developer): <---- 0 OK
May 22 10:09:59 in-target: debconf (developer): --> 0 OK
May 22 10:09:59 in-target: debconf (developer): <-- SUBST debconf-apt-progress/info DESCRIPTION Unpacking irqbalance
May 22 10:09:59 in-target: debconf (developer): --> 0
May 22 10:09:59 debconf: --> DATA debconf-apt-progress/info type text
May 22 10:09:59 in-target: debconf (developer): <-- PROGRESS INFO debconf-apt-progress/info
May 22 10:09:59 in-target: debconf (developer): ----> DATA debconf-apt-progress/info type text
May 22 10:09:59 debconf: <-- 0 OK
May 22 10:09:59 in-target: debconf (developer): <---- 0 OK
May 22 10:09:59 in-target: debconf (developer): ----> DATA debconf-apt-progress/info description Unpacking irqbalance
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:10:36 in-target: debconf (developer): <-- GO 
May 22 10:10:36 in-target: debconf (developer): --> 0 ok
May 22 10:10:36 in-target: debconf (developer): starting /var/lib/dpkg/info/man-db.postinst configure 
May 22 10:10:36 in-target: debconf (developer): <-- VERSION 2.0
May 22 10:10:36 in-target: debconf (developer): --> 0 2.0
May 22 10:10:36 in-target: debconf (developer): <-- GET man-db/install-setuid
May 22 10:10:36 in-target: debconf (developer): --> 0 false
May 22 10:10:37 in-target: Building database of manual pages ...
May 22 10:10:37 in-target: debconf (developer): <-- GET man-db/auto-update
May 22 10:10:37 in-target: debconf (developer): --> 0 true
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:11:06 debconf: <-- 0 OK
May 22 10:11:06 in-target: debconf (developer): <---- 0 OK
May 22 10:11:06 in-target: debconf (developer): --> 0 OK
May 22 10:11:06 in-target: debconf (developer): <-- SUBST debconf-apt-progress/info DESCRIPTION Unpacking libpixman-1-0
May 22 10:11:06 in-target: debconf (developer): --> 0
May 22 10:11:06 debconf: --> DATA debconf-apt-progress/info type text
May 22 10:11:06 in-target: debconf (developer): <-- PROGRESS INFO debconf-apt-progress/info
May 22 10:11:06 in-target: debconf (developer): ----> DATA debconf-apt-progress/info type text
May 22 10:11:06 debconf: <-- 0 OK
May 22 10:11:06 in-ta
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:11:38 in-target: done
May 22 10:11:38 in-target:   en_IE.UTF-8... 
May 22 10:11:39 in-target: done
May 22 10:11:39 in-target:   en_IN.UTF-8... 
May 22 10:11:40 in-target: done
May 22 10:11:40 in-target:   en_NG.UTF-8... 
May 22 10:11:41 in-target: done
May 22 10:11:41 in-target:   en_NZ.UTF-8... 
May 22 10:11:42 in-target: done
May 22 10:11:42 in-target:   en_PH.UTF-8...
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:12:10 in-target: debconf (developer): frontend running, package name is 
May 22 10:12:10 in-target: debconf (developer): starting /usr/bin/debconf-apt-progress --no-progress --logstderr -- apt-get -q -y --no-remove install grub-pc
May 22 10:12:10 in-target: debconf (developer): <-- GET debconf/priority
May 22 10:12:10 in-target: debconf (developer): --> 0 high
May 22 10:12:10 in-target: Reading package lists...
May 22 10:12:11 in-target: 
May 22 10:12:11 in-target: Building dependency tree...
May 22 10:12:11 in-target: 
May 22 10:12:11 in-target: Reading state information...
May 22 10:12:11 in-target:
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 finish-install: info: Running /usr/lib/finish-install.d/90console
May 22 10:12:29 debconf: --> GET finish-install/keep-consoles
May 22 10:12:29 debconf: <-- 0 false
May 22 10:12:29 debconf: --> PROGRESS STEP 1
May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 debconf: --> PROGRESS INFO finish-install/progress/save-logs
May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 finish-install: info: Running /usr/lib/finish-install.d/94save-logs
May 22 10:12:29 debconf: --> X_SAVE
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 finish-install: info: Running /usr/lib/finish-install.d/90console
May 22 10:12:29 debconf: --> GET finish-install/keep-consoles
May 22 10:12:29 debconf: <-- 0 false
May 22 10:12:29 debconf: --> PROGRESS STEP 1
May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 debconf: --> PROGRESS INFO finish-install/progress/save-logs
May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 finish-install: info: Running /usr/lib/finish-install.d/94save-logs
May 22 10:12:29 debconf: --> X_SAVE
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 finish-install: info: Running /usr/lib/finish-install.d/90console
May 22 10:12:29 debconf: --> GET finish-install/keep-consoles
May 22 10:12:29 debconf: <-- 0 false
May 22 10:12:29 debconf: --> PROGRESS STEP 1
May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 debconf: --> PROGRESS INFO finish-install/progress/save-logs
May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 finish-install: info: Running /usr/lib/finish-install.d/94save-logs
May 22 10:12:29 debconf: --> X_SAVE
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:running
DEBUG:root:Capturing current d-i syslog for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 finish-install: info: Running /usr/lib/finish-install.d/90console
May 22 10:12:29 debconf: --> GET finish-install/keep-consoles
May 22 10:12:29 debconf: <-- 0 false
May 22 10:12:29 debconf: --> PROGRESS STEP 1
May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 debconf: --> PROGRESS INFO finish-install/progress/save-logs
May 22 10:12:29 debconf: <-- 0 OK
May 22 10:12:29 finish-install: info: Running /usr/lib/finish-install.d/94save-logs
May 22 10:12:29 debconf: --> X_SAVE
DEBUG:root:Checking VM state for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'domstate', '7e969443-5684-479a-ba56-d1630cc114d1']
DEBUG:root:shut off
DEBUG:root:VM powered off for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:test[iso_url]=/var/lib/ubuntu-iso-testing/isos/ubuntu-server/precise-server-i386.iso
DEBUG:root:test[post-reboot-results]={'lamp-reboot': {'started': '2014-05-22T10:13:54.740095', 'script_stdout': '<testsuite errors="0" failures="0" name="" tests="1" time="0.046">\n<testcase classname="test.DefaultTest" name="test_recorded_state" time="0.042"/>\n</testsuite>\n', 'finished': '2014-05-22T10:13:55.067930', 'returncode': 0, 'script_stderr': u''}}
DEBUG:root:test[_rev]=22-9b6addf93e1fcc2150172e7626482f5c
DEBUG:root:test[disks]=[{'bus': 'virtio', 'size': '2G', 'target': 'vda', 'format': 'qcow2'}]
DEBUG:root:test[results]={'lamp-reboot': {'started': '2014-05-22T10:13:11.734074', 'script_stdout': 'error: setUpClass (test.LampRebootTest) [\nTraceback (most recent call last):\n  File "test.py", line 37, in setUpClass\n    subprocess.check_call([\'tasksel\',\'install\',\'lamp-server\'],env=env)\n  File "/usr/lib/python2.7/subprocess.py", line 511, in check_call\n    raise CalledProcessError(retcode, cmd)\nCalledProcessError: Command \'[\'tasksel\', \'install\', \'lamp-server\']\' returned non-zero exit status 1\n]\n<testsuite errors="0" failures="0" name="" tests="0" time="4.541">\n</testsuite>\n', 'finished': '2014-05-22T10:13:16.577359', 'returncode': 0, 'script_stderr': 'tasksel: aptitude failed (100)\n'}}
DEBUG:root:test[_attachments]={'pxe/pxelinux.cfg/52:54:00:86:ce:67': {'stub': True, 'length': 1108, 'digest': 'md5-s4QmJJ5oAtg7SyNE1sEKAA==', 'revpos': 7, 'content_type': u''}, 'pxe/kernel': {'stub': True, 'length': 5967360, 'digest': 'md5-LuKuMGflUpfWt2C3uHIbEA==', 'revpos': 6, 'content_type': u''}, 'tests/lamp-reboot': {'stub': True, 'length': 3094, 'digest': 'md5-yg8o6cvz1/duHxbwe3Bmfw==', 'revpos': 8, 'content_type': u''}, 'post-reboot-tests/lamp-reboot': {'stub': True, 'length': 1458, 'digest': 'md5-cWfzL+xCNII6ijRKLvoI2w==', 'revpos': 9, 'content_type': u''}, 'libvirt.xml': {'stub': True, 'length': 2031, 'digest': 'md5-YxqlUmrTofIhxFp9EA0W1g==', 'revpos': 12, 'content_type': 'application/xml'}, 'preseed': {'stub': True, 'length': 13166, 'digest': 'md5-Nndbya+jUNQlW63DPOAusA==', 'revpos': 2, 'content_type': u''}, 'pxe/initrd': {'stub': True, 'length': 6643826, 'digest': 'md5-xAINikOYMC+jBb3TstQxWA==', 'revpos': 5, 'content_type': u''}, 'media_info': {'stub': True, 'length': 70, 'digest': 'md5-ggOF+Vsf4u2fo77Qvuj4RA==', 'revpos': 3, 'content_type': u''}, 'run_test': {'stub': True, 'length': 6943, 'digest': 'md5-ZbbgRpEcHSeMP9A+cvAv1Q==', 'revpos': 4, 'content_type': u''}}
DEBUG:root:test[states]={'rebooted': '2014-05-22T10:13:16.675408', 'creating': '2014-05-22T10:05:34.598019', 'created': '2014-05-22T10:05:40.343836', 'started': '2014-05-22T10:05:41.687322', 'configured': '2014-05-22T10:05:40.679859', 'testing': '2014-05-22T10:13:54.689719', 'tested': '2014-05-22T10:13:55.124343'}
DEBUG:root:test[mac]=52:54:00:86:ce:67
DEBUG:root:test[_id]=7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:test[test_case]=lamp-reboot
DEBUG:root:Tests completed for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Storing results for test lamp-reboot
DEBUG:root:Reboot tests completed for test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Storing results for test lamp-reboot
DEBUG:root:Undefine VM for  test case 7e969443-5684-479a-ba56-d1630cc114d1
DEBUG:root:Cmd: ['virsh', 'undefine', '7e969443-5684-479a-ba56-d1630cc114d1']
Domain 7e969443-5684-479a-ba56-d1630cc114d1 has been undefined

DEBUG:root:Collating output for test case 7e969443-5684-479a-ba56-d1630cc114d1
Archiving artifacts
Recording test results
ERROR: Failed to archive test reports
hudson.util.IOException2: remote file operation failed: <http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_lamp-reboot/ws/> at hudson.remoting.Channel at 6574a4ad:wazn
	at hudson.FilePath.act(FilePath.java:848)
	at hudson.FilePath.act(FilePath.java:834)
	at hudson.tasks.junit.JUnitParser.parse(JUnitParser.java:87)
	at hudson.tasks.junit.JUnitResultArchiver.parse(JUnitResultArchiver.java:122)
	at hudson.tasks.junit.JUnitResultArchiver.perform(JUnitResultArchiver.java:134)
	at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:19)
	at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:718)
	at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:693)
	at hudson.model.Build$BuildExecution.post2(Build.java:183)
	at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:640)
	at hudson.model.Run.execute(Run.java:1527)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46)
	at hudson.model.ResourceController.execute(ResourceController.java:88)
	at hudson.model.Executor.run(Executor.java:237)
Caused by: hudson.util.IOException2: Failed to read <http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_lamp-reboot/682/artifact/682/test-results/TEST-lamp-reboot.xml>
	at hudson.tasks.junit.TestResult.parse(TestResult.java:244)
	at hudson.tasks.junit.TestResult.parse(TestResult.java:163)
	at hudson.tasks.junit.TestResult.parse(TestResult.java:140)
	at hudson.tasks.junit.TestResult.<init>(TestResult.java:116)
	at hudson.tasks.junit.JUnitParser$ParseResultCallable.invoke(JUnitParser.java:117)
	at hudson.tasks.junit.JUnitParser$ParseResultCallable.invoke(JUnitParser.java:90)
	at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2246)
	at hudson.remoting.UserRequest.perform(UserRequest.java:118)
	at hudson.remoting.UserRequest.perform(UserRequest.java:48)
	at hudson.remoting.Request$2.run(Request.java:326)
	at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at hudson.remoting.Engine$1$1.run(Engine.java:58)
	at java.lang.Thread.run(Thread.java:744)
Caused by: org.dom4j.DocumentException: Error on line 1 of document file://<http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_lamp-reboot/682/artifact/682/test-results/TEST-lamp-reboot.xml> : Content is not allowed in prolog. Nested exception: Content is not allowed in prolog.
	at org.dom4j.io.SAXReader.read(SAXReader.java:482)
	at org.dom4j.io.SAXReader.read(SAXReader.java:264)
	at hudson.tasks.junit.SuiteResult.parse(SuiteResult.java:116)
	at hudson.tasks.junit.TestResult.parse(TestResult.java:227)
	... 15 more
Caused by: org.xml.sax.SAXParseException; systemId: file://<http://d-jenkins.ubuntu-ci:8080/job/precise-server-i386_lamp-reboot/682/artifact/682/test-results/TEST-lamp-reboot.xml;> lineNumber: 1; columnNumber: 1; Content is not allowed in prolog.
	at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:198)
	at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.fatalError(ErrorHandlerWrapper.java:177)
	at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:441)
	at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:368)
	at com.sun.org.apache.xerces.internal.impl.XMLScanner.reportFatalError(XMLScanner.java:1436)
	at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl$PrologDriver.next(XMLDocumentScannerImpl.java:999)
	at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.next(XMLDocumentScannerImpl.java:606)
	at com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.next(XMLNSDocumentScannerImpl.java:117)
	at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanDocument(XMLDocumentFragmentScannerImpl.java:510)
	at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:848)
	at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:777)
	at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(XMLParser.java:141)
	at com.sun.org.apache.xerces.internal.parsers.AbstractSAXParser.parse(AbstractSAXParser.java:1213)
	at com.sun.org.apache.xerces.internal.jaxp.SAXParserImpl$JAXPSAXParser.parse(SAXParserImpl.java:649)
	at org.dom4j.io.SAXReader.read(SAXReader.java:465)
	... 18 more
Build step 'Publish JUnit test result report' changed build result to FAILURE
Description set: 20140522

More information about the ubuntu-testing-notifications mailing list