maas-builds team mailing list archive

[Jenkins Notification <devnull@xxxxxxxxxxxxx>]

See http://d-jenkins.ubuntu-ci:8080/job/trusty-adt-maas-daily/57/

[...truncated 7113 lines...]
Cleaning up...
maas-integration.TestMAASIntegration.test_create_admin ... ok
maas-integration.TestMAASIntegration.test_restart_dbus_avahi ... SKIP: Avahi/DBUS are not used anymore
maas-integration.TestMAASIntegration.test_update_maas_url ... ok
maas-integration.TestMAASIntegration.test_restart_provisioning_server ... ok
maas-integration.TestMAASIntegration.test_check_initial_services ... ok
maas-integration.TestMAASIntegration.test_update_pxe_config ... ok
maas-integration.TestMAASIntegration.test_import_pxe_files ... ok
maas-integration.TestMAASIntegration.test_update_preseed_arm ... ok
maas-integration.TestMAASIntegration.test_login_api ... ok
maas-integration.TestMAASIntegration.test_set_http_proxy ... SKIP: Not testing proxy.
maas-integration.TestMAASIntegration.test_cluster_connected ... ok
maas-integration.TestMAASIntegration.test_set_up_dhcp_region ... ok
maas-integration.TestMAASIntegration.test_check_dhcp_service ... ok
maas-integration.TestMAASIntegration.test_set_up_dhcp_cluster ... SKIP: Not testing cluster controller
maas-integration.TestMAASIntegration.test_update_dns_config ... ok
maas-integration.TestMAASIntegration.test_boot_nodes_enlist ... ok
maas-integration.TestMAASIntegration.test_check_nodes_declared ... ok
maas-integration.TestMAASIntegration.test_set_nodes_ipmi_config ... ok
maas-integration.TestMAASIntegration.test_commission_nodes ... ok
maas-integration.TestMAASIntegration.test_check_nodes_ready ... ok
maas-integration.TestMAASIntegration.test_apply_tag_to_all_nodes ... ok
maas-integration.TestMAASIntegration.test_check_tag_applied_to_all_nodes ... ok
maas-integration.TestMAASIntegration.test_configure_juju ... ok
maas-integration.TestMAASIntegration.test_juju_bootstrap ... ERROR
SKIP: Not testing Cluster controller

======================================================================
ERROR: maas-integration.TestMAASIntegration.test_juju_bootstrap
----------------------------------------------------------------------
_StringException: juju --debug bootstrap --upload-tools: {{{
2014-01-22 11:50:21 DEBUG juju.environs.configstore disk.go:77 Making /root/.juju/environments
2014-01-22 11:50:21 DEBUG juju.environs.configstore disk.go:67 Making /root/.juju/environments owned by 1000:1000
2014-01-22 11:50:21 DEBUG juju.environs.configstore disk.go:67 Making /root/.juju/environments/maas.jenv owned by 1000:1000
2014-01-22 11:50:21 DEBUG juju.provider.maas environprovider.go:33 opening environment "maas".
2014-01-22 11:50:21 DEBUG juju.environs.configstore disk.go:67 Making /root/.juju/environments/maas.jenv owned by 1000:1000
2014-01-22 11:50:21 DEBUG juju.environs.sync sync.go:211 Uploading tools for [trusty precise]
2014-01-22 11:50:21 DEBUG juju.environs.tools build.go:115 looking for: juju
2014-01-22 11:50:21 DEBUG juju.environs.tools build.go:156 checking: /usr/bin/jujud
2014-01-22 11:50:21 INFO juju.environs.tools build.go:162 found existing jujud
2014-01-22 11:50:21 INFO juju.environs.tools build.go:172 target: /tmp/adt-run.ZgWKfz/ubtree0t-maas-package-test-testtmp/tmpdir/juju-tools226245321/jujud
2014-01-22 11:50:21 DEBUG juju.environs.tools build.go:223 forcing version to 1.17.0.1
2014-01-22 11:50:21 DEBUG juju.environs.tools build.go:39 adding entry: &tar.Header{Name:"FORCE-VERSION", Mode:420, Uid:0, Gid:0, Size:8, ModTime:time.Time{sec:63525988221, nsec:0x2d2a511f, loc:(*time.Location)(0x1701340)}, Typeflag:0x30, Linkname:"", Uname:"ubuntu", Gname:"ubuntu", Devmajor:0, Devminor:0, AccessTime:time.Time{sec:63525988221, nsec:0x2d2a511f, loc:(*time.Location)(0x1701340)}, ChangeTime:time.Time{sec:63525988221, nsec:0x2d2a511f, loc:(*time.Location)(0x1701340)}}
2014-01-22 11:50:21 DEBUG juju.environs.tools build.go:39 adding entry: &tar.Header{Name:"jujud", Mode:493, Uid:0, Gid:0, Size:32749104, ModTime:time.Time{sec:63525988221, nsec:0x2ced481f, loc:(*time.Location)(0x1701340)}, Typeflag:0x30, Linkname:"", Uname:"ubuntu", Gname:"ubuntu", Devmajor:0, Devminor:0, AccessTime:time.Time{sec:63525988221, nsec:0x2ced481f, loc:(*time.Location)(0x1701340)}, ChangeTime:time.Time{sec:63525988221, nsec:0x2ced481f, loc:(*time.Location)(0x1701340)}}
2014-01-22 11:50:25 INFO juju.environs.sync sync.go:230 built 1.17.0.1-trusty-amd64 (6562kB)
2014-01-22 11:50:25 INFO juju.environs.sync sync.go:71 listing available tools
2014-01-22 11:50:25 DEBUG juju.environs.tools storage.go:35 reading v1.* tools
2014-01-22 11:50:25 DEBUG juju.environs.tools storage.go:62 found 1.17.0.1-precise-amd64
2014-01-22 11:50:25 DEBUG juju.environs.tools storage.go:62 found 1.17.0.1-trusty-amd64
2014-01-22 11:50:25 INFO juju.environs.sync sync.go:95 found 2 tools
2014-01-22 11:50:25 DEBUG juju.environs.sync sync.go:102 found source tool: &{1.17.0.1-precise-amd64 file:///tmp/adt-run.ZgWKfz/ubtree0t-maas-package-test-testtmp/tmpdir/727429012/tools/releases/juju-1.17.0.1-precise-amd64.tgz  0}
2014-01-22 11:50:25 DEBUG juju.environs.sync sync.go:102 found source tool: &{1.17.0.1-trusty-amd64 file:///tmp/adt-run.ZgWKfz/ubtree0t-maas-package-test-testtmp/tmpdir/727429012/tools/releases/juju-1.17.0.1-trusty-amd64.tgz  0}
2014-01-22 11:50:25 INFO juju.environs.sync sync.go:105 listing target bucket
2014-01-22 11:50:25 DEBUG juju.environs.tools storage.go:35 reading v1.* tools
2014-01-22 11:50:25 INFO juju.environs.sync sync.go:118 found 0 tools in target; 2 tools to be copied
2014-01-22 11:50:25 INFO juju.environs.sync sync.go:156 copying 1.17.0.1-precise-amd64 from file:///tmp/adt-run.ZgWKfz/ubtree0t-maas-package-test-testtmp/tmpdir/727429012/tools/releases/juju-1.17.0.1-precise-amd64.tgz
2014-01-22 11:50:25 INFO juju.environs.sync sync.go:170 copying tools/releases/juju-1.17.0.1-precise-amd64.tgz
2014-01-22 11:50:25 INFO juju.environs.sync sync.go:184 downloaded tools/releases/juju-1.17.0.1-precise-amd64.tgz (6562kB), uploading
2014-01-22 11:50:25 INFO juju.environs.sync sync.go:185 download 6562kB, uploading
2014-01-22 11:50:26 INFO juju.environs.sync sync.go:156 copying 1.17.0.1-trusty-amd64 from file:///tmp/adt-run.ZgWKfz/ubtree0t-maas-package-test-testtmp/tmpdir/727429012/tools/releases/juju-1.17.0.1-trusty-amd64.tgz
2014-01-22 11:50:26 INFO juju.environs.sync sync.go:170 copying tools/releases/juju-1.17.0.1-trusty-amd64.tgz
2014-01-22 11:50:26 INFO juju.environs.sync sync.go:184 downloaded tools/releases/juju-1.17.0.1-trusty-amd64.tgz (6562kB), uploading
2014-01-22 11:50:26 INFO juju.environs.sync sync.go:185 download 6562kB, uploading
2014-01-22 11:50:27 INFO juju.environs.sync sync.go:123 copied 2 tools
2014-01-22 11:50:27 INFO juju.environs.sync sync.go:125 generating tools metadata
2014-01-22 11:50:27 DEBUG juju.environs.tools tools.go:44 no architecture specified when finding tools, looking for any
2014-01-22 11:50:27 DEBUG juju.environs.tools tools.go:55 no series specified when finding tools, looking for any
2014-01-22 11:50:27 DEBUG juju.environs.simplestreams simplestreams.go:481 fetchData failed for "tools/streams/v1/index.sjson": file '9533b3f5-c707-4a01-80f5-50d66566bcf9-tools/streams/v1/index.sjson' not found not found
2014-01-22 11:50:27 DEBUG juju.environs.simplestreams simplestreams.go:458 cannot load index "streams/v1/index.sjson": invalid URL "tools/streams/v1/index.sjson" not found
2014-01-22 11:50:27 DEBUG juju.environs.simplestreams simplestreams.go:481 fetchData failed for "tools/streams/v1/index.json": file '9533b3f5-c707-4a01-80f5-50d66566bcf9-tools/streams/v1/index.json' not found not found
2014-01-22 11:50:27 DEBUG juju.environs.simplestreams simplestreams.go:458 cannot load index "streams/v1/index.json": invalid URL "tools/streams/v1/index.json" not found
2014-01-22 11:50:27 INFO juju.environs.tools simplestreams.go:357 Writing tools/streams/v1/index.json
2014-01-22 11:50:27 INFO juju.environs.tools simplestreams.go:357 Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
2014-01-22 11:50:27 INFO juju.environs.sync sync.go:137 tools metadata written
2014-01-22 11:50:29 INFO juju.environs.bootstrap bootstrap.go:46 bootstrapping environment "maas"
2014-01-22 11:50:29 DEBUG juju.environs.bootstrap synctools.go:91 looking for bootstrap tools: series="precise", arch=<nil>, version=1.17.0.1
2014-01-22 11:50:29 INFO juju.environs.tools tools.go:85 reading tools with major.minor version 1.17
2014-01-22 11:50:29 INFO juju.environs.tools tools.go:93 filtering tools by version: 1.17.0.1
2014-01-22 11:50:29 INFO juju.environs.tools tools.go:96 filtering tools by series: precise
2014-01-22 11:50:29 DEBUG juju.environs.tools tools.go:44 no architecture specified when finding tools, looking for any
2014-01-22 11:50:29 DEBUG juju.environs.simplestreams simplestreams.go:481 fetchData failed for "tools/streams/v1/index.sjson": file '9533b3f5-c707-4a01-80f5-50d66566bcf9-tools/streams/v1/index.sjson' not found not found
2014-01-22 11:50:29 DEBUG juju.environs.simplestreams simplestreams.go:458 cannot load index "streams/v1/index.sjson": invalid URL "tools/streams/v1/index.sjson" not found
2014-01-22 11:50:29 DEBUG juju.environs.simplestreams simplestreams.go:481 fetchData failed for "tools/streams/v1/mirrors.json": file '9533b3f5-c707-4a01-80f5-50d66566bcf9-tools/streams/v1/mirrors.json' not found not found
2014-01-22 11:50:29 DEBUG juju.environs.simplestreams simplestreams.go:557 no mirror index file found
2014-01-22 11:50:29 DEBUG juju.environs.simplestreams simplestreams.go:538 no mirror information available for { }: mirror data for "com.ubuntu.juju:released:tools" not found
2014-01-22 11:50:29 DEBUG juju.environs.simplestreams simplestreams.go:462 read metadata index at "http://192.168.21.5:80/MAAS/api/1.0/files/?key=62c22268-835b-11e3-a9c9-525400123456&op=get_by_key";
2014-01-22 11:50:29 DEBUG juju.environs.simplestreams simplestreams.go:625 candidate matches for products ["com.ubuntu.juju:12.04:amd64" "com.ubuntu.juju:12.04:i386" "com.ubuntu.juju:12.04:arm"] are [{Wed, 22 Jan 2014 06:50:27 -0500 products:1.0 content-download  [] streams/v1/com.ubuntu.juju:released:tools.json [com.ubuntu.juju:12.04:amd64 com.ubuntu.juju:14.04:amd64]}]
2014-01-22 11:50:29 DEBUG juju.environs.simplestreams simplestreams.go:937 finding products at path "streams/v1/com.ubuntu.juju:released:tools.json"
2014-01-22 11:50:29 DEBUG juju.environs.simplestreams simplestreams.go:974 metadata: &{map[com.ubuntu.juju:12.04:amd64:{ 1.17.0.1 amd64   map[20140122:0xc212cf7a20]} com.ubuntu.juju:14.04:amd64:{ 1.17.0.1 amd64   map[20140122:0xc212cf7b40]}] map[] Wed, 22 Jan 2014 06:50:27 -0500 products:1.0 com.ubuntu.juju:released:tools}
2014-01-22 11:50:31 INFO juju.environs.bootstrap bootstrap.go:58 picked newest version: 1.17.0.1
Launching instance
2014-01-22 11:50:31 WARNING juju.provider.maas environ.go:193 picked arbitrary tools &{"1.17.0.1-precise-amd64" "http://192.168.21.5:80/MAAS/api/1.0/files/?key=61eaa9dc-835b-11e3-a9c9-525400123456&op=get_by_key"; "0b11612e312cb11e3c31e28609e500de52436ced9d70101b506253285aaf3ae6" %!q(int64=6719590)}
2014-01-22 11:50:31 DEBUG juju.provider.maas environ.go:279 maas user data; 716 bytes
2014-01-22 11:50:31 DEBUG juju.provider.maas environ.go:285 started instance "/MAAS/api/1.0/nodes/node-d3163640-835a-11e3-8852-525400123456/"
 - /MAAS/api/1.0/nodes/node-d3163640-835a-11e3-8852-525400123456/
Waiting for address
Attempting to connect to 764nr.master:22
Attempting to connect to 192.168.21.10:22
2014-01-22 12:00:31 ERROR juju.provider.common bootstrap.go:85 bootstrap failed: waited for 10m0s without being able to connect: ssh: connect to host 192.168.21.10 port 22: Connection refused
Stopping instance...
2014-01-22 12:00:31 ERROR juju.cmd supercommand.go:294 waited for 10m0s without being able to connect: ssh: connect to host 192.168.21.10 port 22: Connection refused
}}}

Traceback (most recent call last):
  File "/tmp/adt-run.ZgWKfz/ubtree0-build/real-tree/debian/tests/utils.py", line 69, in wrapper
    result = func(*args, **kwargs)
  File "/tmp/adt-run.ZgWKfz/ubtree0-build/real-tree/debian/tests/maas-integration.py", line 618, in test_juju_bootstrap
    self._wait_machines_running(1)
  File "/tmp/adt-run.ZgWKfz/ubtree0-build/real-tree/debian/tests/maas-integration.py", line 623, in _wait_machines_running
    status = self.get_juju_status()
  File "/tmp/adt-run.ZgWKfz/ubtree0-build/real-tree/debian/tests/maas-integration.py", line 603, in get_juju_status
    status_output = self._run_juju_command(["status"])
  File "/tmp/adt-run.ZgWKfz/ubtree0-build/real-tree/debian/tests/maas-integration.py", line 587, in _run_juju_command
    retcode, output, err = run_command(command)
  File "/tmp/adt-run.ZgWKfz/ubtree0-build/real-tree/debian/tests/utils.py", line 81, in run_command
    process = Popen(args, stdout=PIPE, stderr=PIPE, stdin=PIPE, env=env)
  File "/usr/lib/python2.7/subprocess.py", line 709, in __init__
    errread, errwrite)
  File "/usr/lib/python2.7/subprocess.py", line 1326, in _execute_child
    raise child_exception
OSError: [Errno 2] No such file or directory


maas-integration.TestMAASIntegration.test_update_pxe_config: 0.0006s
maas-integration.TestMAASIntegration.test_check_dhcp_service: 0.0311s
maas-integration.TestMAASIntegration.test_check_initial_services: 0.0422s
maas-integration.TestMAASIntegration.test_update_preseed_arm: 0.0532s
maas-integration.TestMAASIntegration.test_restart_provisioning_server: 0.0708s
maas-integration.TestMAASIntegration.test_create_admin: 0.1162s
maas-integration.TestMAASIntegration.test_apply_tag_to_all_nodes: 0.2267s
maas-integration.TestMAASIntegration.test_cluster_connected: 0.2411s
maas-integration.TestMAASIntegration.test_check_tag_applied_to_all_nodes: 0.2540s
maas-integration.TestMAASIntegration.test_commission_nodes: 0.4450s
maas-integration.TestMAASIntegration.test_update_dns_config: 0.4654s
maas-integration.TestMAASIntegration.test_boot_nodes_enlist: 0.5363s
maas-integration.TestMAASIntegration.test_update_maas_url: 2.2487s
maas-integration.TestMAASIntegration.test_set_up_dhcp_region: 2.5682s
maas-integration.TestMAASIntegration.test_set_nodes_ipmi_config: 2.7712s
maas-integration.TestMAASIntegration.test_login_api: 2.8277s
maas-integration.TestMAASIntegration.test_configure_juju: 5.7740s
maas-integration.TestMAASIntegration.test_check_nodes_declared: 167.6397s
maas-integration.TestMAASIntegration.test_check_nodes_ready: 194.4548s
maas-integration.TestMAASIntegration.test_juju_bootstrap: 641.0026s
maas-integration.TestMAASIntegration.test_import_pxe_files: 952.4534s
----------------------------------------------------------------------
Ran 24 tests in 1974.431s

FAILED (SKIP=4, errors=1)
adt-run1: testbed executing test finished with exit status 1
adt-run: & ubtree0t-maas-package-test: ----------------------------------------]
adt-run: & ubtree0t-maas-package-test:  - - - - - - - - - - results - - - - - - - - - -
ubtree0t-maas-package-test FAIL non-zero exit status 1
adt-run1: ** needs_reset, previously=False
adt-run: @@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@ tests done.
adt-run1: ** stop
adt-run1: ** close, scratch=/tmp/adt-run.ZgWKfz
+ RC=4
+ [ 4 -eq 20 ]
+ [ 0 -eq 1 ]
+ [ -x /home/ubuntu/adt-export-result ]
+ RES=PASS
+ [ 4 -gt 0 ]
+ RES=FAIL
+ /home/ubuntu/adt-export-result -D /root/adt-log maas FAIL
+ chown -R ubuntu /root/adt-log /var/tmp/testresults
+ chmod og+r /var/log/syslog
+ ls /var/crash/
+ [ -n  ]
+ exit 4
Connection to localhost closed.
+ RET=4
+ [ 0 -eq 1 ]
+ [ 4 -gt 0 ]
+ log_failure_msg adt-run exited with status 4.
+ log_msg Failure: adt-run exited with status 4.\n
+ date +%F %X
+ printf 2014-01-22 07:00:34: Failure: adt-run exited with status 4.\n
2014-01-22 07:00:34: Failure: adt-run exited with status 4.
+ [ 0 -eq 0 ]
+ mkdir -p /home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results
+ ssh -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o CheckHostIP=no -i /var/tmp/adt/disks/adtkey -p 54323 -tt -o BatchMode=yes -l ubuntu localhost sudo chown -R ubuntu /root/adt-log; find /root/adt-log -type f -empty | xargs rm 2>/dev/null
Warning: Permanently added '[localhost]:54323' (ECDSA) to the list of known hosts.
find: `/root/adt-log': Permission denied
Connection to localhost closed.
+ true
+ scp -r -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o CheckHostIP=no -i /var/tmp/adt/disks/adtkey -P 54323 ubuntu@localhost:/root/adt-log/* /var/crash/*crash /var/log/syslog /var/tmp/testresults /home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results
+ true
+ log_info_msg Test artifacts copied to /home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results
+ log_msg Info: Test artifacts copied to /home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results\n
+ date +%F %X
+ printf 2014-01-22 07:00:37: Info: Test artifacts copied to /home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results\n
2014-01-22 07:00:37: Info: Test artifacts copied to /home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results
+ [ -f /home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results/summary.log ]
+ [ -n 2014-01-22_11-19-30 ]
+ ls -tr /home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results/*.result
+ tail -1
+ resfile=
+ [ -n  ]
+ log_failure_msg Test didn't end normally. Generating error file
+ log_msg Failure: Test didn't end normally. Generating error file\n
+ date +%F %X
+ printf 2014-01-22 07:00:38: Failure: Test didn't end normally. Generating error file\n
2014-01-22 07:00:38: Failure: Test didn't end normally. Generating error file
+ date +%Y%m%d-%H%M%S
+ errfile=/home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results/trusty_amd64_maas_20140122-070038.error
+ echo trusty amd64 maas
+ rsync -a /home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results/trusty_amd64_maas_20140122-070038.error /trusty/tmp/
rsync: mkdir "/trusty/tmp" failed: No such file or directory (2)
rsync error: error in file IO (code 11) at main.c(674) [Receiver=3.1.0]
+ true
+ [ 0 -eq 0 ]
+ ssh -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o CheckHostIP=no -i /var/tmp/adt/disks/adtkey -p 54323 -tt -o BatchMode=yes -l ubuntu localhost sudo poweroff
Warning: Permanently added '[localhost]:54323' (ECDSA) to the list of known hosts.


Broadcast message from ubuntu@autopkgtest

	(/dev/pts/0) at 7:00 ...




The system is going down for power off NOW!

Connection to localhost closed.
+ exit 4
+ on_exit
+ log_info_msg Cleaning up
+ log_msg Info: Cleaning up\n
+ date +%F %X
+ printf 2014-01-22 07:00:38: Info: Cleaning up\n
2014-01-22 07:00:38: Info: Cleaning up
+ [ -f /var/tmp/adt/disks/run/trusty-amd64-maas-20140122_062002.FALggO.img.pid ]
+ cat /var/tmp/adt/disks/run/trusty-amd64-maas-20140122_062002.FALggO.img.pid
+ kill -9 4764
+ rm -f /var/tmp/adt/disks/run/trusty-amd64-maas-20140122_062002.FALggO.img.pid
+ rm -f /var/tmp/adt/disks/run/trusty-amd64-maas-20140122_062002.FALggO.img
+ rm -f /var/tmp/adt/disks/run/trusty-amd64-maas-20140122_062002.FALggO.img.monitor /var/tmp/adt/disks/run/trusty-amd64-maas-20140122_062002.FALggO.img.serial
+ rm -f /var/lock/adt/ssh.54323.lock
+ rm -f /var/lock/adt/vnc.5911.lock
+ [ -d /tmp/adt-amd64.iwNbJH ]
+ rm -Rf /tmp/adt-amd64.iwNbJH
+ rm -f /var/tmp/adt/disks/run/trusty-amd64-maas-*.img*
+ find /var/lock/adt -name *.lock -mtime +1
+ exit 4
Build step 'Execute shell' marked build as failure
Archiving artifacts
Email was triggered for: Failure
Sending email for trigger: Failure