maas-builds team mailing list archive

[Jenkins Notification <devnull@xxxxxxxxxxxxx>]

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

[...truncated 7182 lines...]
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-20 16:25:02 DEBUG juju.environs.configstore disk.go:77 Making /root/.juju/environments
2014-01-20 16:25:02 DEBUG juju.environs.configstore disk.go:67 Making /root/.juju/environments owned by 1000:1000
2014-01-20 16:25:02 DEBUG juju.environs.configstore disk.go:67 Making /root/.juju/environments/maas.jenv owned by 1000:1000
2014-01-20 16:25:02 DEBUG juju.provider.maas environprovider.go:33 opening environment "maas".
2014-01-20 16:25:03 DEBUG juju.environs.configstore disk.go:67 Making /root/.juju/environments/maas.jenv owned by 1000:1000
2014-01-20 16:25:03 DEBUG juju.environs.sync sync.go:211 Uploading tools for [trusty precise]
2014-01-20 16:25:03 DEBUG juju.environs.tools build.go:115 looking for: juju
2014-01-20 16:25:03 DEBUG juju.environs.tools build.go:156 checking: /usr/bin/jujud
2014-01-20 16:25:03 INFO juju.environs.tools build.go:162 found existing jujud
2014-01-20 16:25:03 INFO juju.environs.tools build.go:172 target: /tmp/adt-run.uGaJFu/ubtree0t-maas-package-test-testtmp/tmpdir/juju-tools083280307/jujud
2014-01-20 16:25:03 DEBUG juju.environs.tools build.go:223 forcing version to 1.17.0.1
2014-01-20 16:25:03 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:63525831903, nsec:0x11562d1f, loc:(*time.Location)(0x1701340)}, Typeflag:0x30, Linkname:"", Uname:"ubuntu", Gname:"ubuntu", Devmajor:0, Devminor:0, AccessTime:time.Time{sec:63525831903, nsec:0x11562d1f, loc:(*time.Location)(0x1701340)}, ChangeTime:time.Time{sec:63525831903, nsec:0x11562d1f, loc:(*time.Location)(0x1701340)}}
2014-01-20 16:25:03 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:63525831903, nsec:0x11562d1f, loc:(*time.Location)(0x1701340)}, Typeflag:0x30, Linkname:"", Uname:"ubuntu", Gname:"ubuntu", Devmajor:0, Devminor:0, AccessTime:time.Time{sec:63525831903, nsec:0x11562d1f, loc:(*time.Location)(0x1701340)}, ChangeTime:time.Time{sec:63525831903, nsec:0x11562d1f, loc:(*time.Location)(0x1701340)}}
2014-01-20 16:25:07 INFO juju.environs.sync sync.go:230 built 1.17.0.1-trusty-amd64 (6562kB)
2014-01-20 16:25:07 INFO juju.environs.sync sync.go:71 listing available tools
2014-01-20 16:25:07 DEBUG juju.environs.tools storage.go:35 reading v1.* tools
2014-01-20 16:25:07 DEBUG juju.environs.tools storage.go:62 found 1.17.0.1-precise-amd64
2014-01-20 16:25:07 DEBUG juju.environs.tools storage.go:62 found 1.17.0.1-trusty-amd64
2014-01-20 16:25:07 INFO juju.environs.sync sync.go:95 found 2 tools
2014-01-20 16:25:07 DEBUG juju.environs.sync sync.go:102 found source tool: &{1.17.0.1-precise-amd64 file:///tmp/adt-run.uGaJFu/ubtree0t-maas-package-test-testtmp/tmpdir/097434998/tools/releases/juju-1.17.0.1-precise-amd64.tgz  0}
2014-01-20 16:25:07 DEBUG juju.environs.sync sync.go:102 found source tool: &{1.17.0.1-trusty-amd64 file:///tmp/adt-run.uGaJFu/ubtree0t-maas-package-test-testtmp/tmpdir/097434998/tools/releases/juju-1.17.0.1-trusty-amd64.tgz  0}
2014-01-20 16:25:07 INFO juju.environs.sync sync.go:105 listing target bucket
2014-01-20 16:25:07 DEBUG juju.environs.tools storage.go:35 reading v1.* tools
2014-01-20 16:25:07 INFO juju.environs.sync sync.go:118 found 0 tools in target; 2 tools to be copied
2014-01-20 16:25:07 INFO juju.environs.sync sync.go:156 copying 1.17.0.1-precise-amd64 from file:///tmp/adt-run.uGaJFu/ubtree0t-maas-package-test-testtmp/tmpdir/097434998/tools/releases/juju-1.17.0.1-precise-amd64.tgz
2014-01-20 16:25:07 INFO juju.environs.sync sync.go:170 copying tools/releases/juju-1.17.0.1-precise-amd64.tgz
2014-01-20 16:25:07 INFO juju.environs.sync sync.go:184 downloaded tools/releases/juju-1.17.0.1-precise-amd64.tgz (6562kB), uploading
2014-01-20 16:25:07 INFO juju.environs.sync sync.go:185 download 6562kB, uploading
2014-01-20 16:25:08 INFO juju.environs.sync sync.go:156 copying 1.17.0.1-trusty-amd64 from file:///tmp/adt-run.uGaJFu/ubtree0t-maas-package-test-testtmp/tmpdir/097434998/tools/releases/juju-1.17.0.1-trusty-amd64.tgz
2014-01-20 16:25:08 INFO juju.environs.sync sync.go:170 copying tools/releases/juju-1.17.0.1-trusty-amd64.tgz
2014-01-20 16:25:08 INFO juju.environs.sync sync.go:184 downloaded tools/releases/juju-1.17.0.1-trusty-amd64.tgz (6562kB), uploading
2014-01-20 16:25:08 INFO juju.environs.sync sync.go:185 download 6562kB, uploading
2014-01-20 16:25:08 INFO juju.environs.sync sync.go:123 copied 2 tools
2014-01-20 16:25:08 INFO juju.environs.sync sync.go:125 generating tools metadata
2014-01-20 16:25:08 DEBUG juju.environs.tools tools.go:44 no architecture specified when finding tools, looking for any
2014-01-20 16:25:08 DEBUG juju.environs.tools tools.go:55 no series specified when finding tools, looking for any
2014-01-20 16:25:08 DEBUG juju.environs.simplestreams simplestreams.go:481 fetchData failed for "tools/streams/v1/index.sjson": file '4c9eada8-467a-4b91-82de-6da0bbd2de2b-tools/streams/v1/index.sjson' not found not found
2014-01-20 16:25:08 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-20 16:25:08 DEBUG juju.environs.simplestreams simplestreams.go:481 fetchData failed for "tools/streams/v1/index.json": file '4c9eada8-467a-4b91-82de-6da0bbd2de2b-tools/streams/v1/index.json' not found not found
2014-01-20 16:25:08 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-20 16:25:08 INFO juju.environs.tools simplestreams.go:357 Writing tools/streams/v1/index.json
2014-01-20 16:25:08 INFO juju.environs.tools simplestreams.go:357 Writing tools/streams/v1/com.ubuntu.juju:released:tools.json
2014-01-20 16:25:08 INFO juju.environs.sync sync.go:137 tools metadata written
2014-01-20 16:25:10 INFO juju.environs.bootstrap bootstrap.go:46 bootstrapping environment "maas"
2014-01-20 16:25:10 DEBUG juju.environs.bootstrap synctools.go:91 looking for bootstrap tools: series="precise", arch=<nil>, version=1.17.0.1
2014-01-20 16:25:10 INFO juju.environs.tools tools.go:85 reading tools with major.minor version 1.17
2014-01-20 16:25:10 INFO juju.environs.tools tools.go:93 filtering tools by version: 1.17.0.1
2014-01-20 16:25:10 INFO juju.environs.tools tools.go:96 filtering tools by series: precise
2014-01-20 16:25:10 DEBUG juju.environs.tools tools.go:44 no architecture specified when finding tools, looking for any
2014-01-20 16:25:10 DEBUG juju.environs.simplestreams simplestreams.go:481 fetchData failed for "tools/streams/v1/index.sjson": file '4c9eada8-467a-4b91-82de-6da0bbd2de2b-tools/streams/v1/index.sjson' not found not found
2014-01-20 16:25:10 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-20 16:25:11 DEBUG juju.environs.simplestreams simplestreams.go:481 fetchData failed for "tools/streams/v1/mirrors.json": file '4c9eada8-467a-4b91-82de-6da0bbd2de2b-tools/streams/v1/mirrors.json' not found not found
2014-01-20 16:25:11 DEBUG juju.environs.simplestreams simplestreams.go:557 no mirror index file found
2014-01-20 16:25:11 DEBUG juju.environs.simplestreams simplestreams.go:538 no mirror information available for { }: mirror data for "com.ubuntu.juju:released:tools" not found
2014-01-20 16:25:11 DEBUG juju.environs.simplestreams simplestreams.go:462 read metadata index at "http://192.168.21.5:80/MAAS/api/1.0/files/?key=6db2a764-81ef-11e3-b787-525400123456&op=get_by_key";
2014-01-20 16:25:11 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 [{Mon, 20 Jan 2014 11:25:08 -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-20 16:25:11 DEBUG juju.environs.simplestreams simplestreams.go:937 finding products at path "streams/v1/com.ubuntu.juju:released:tools.json"
2014-01-20 16:25:11 DEBUG juju.environs.simplestreams simplestreams.go:974 metadata: &{map[com.ubuntu.juju:12.04:amd64:{ 1.17.0.1 amd64   map[20140120:0xc212d04840]} com.ubuntu.juju:14.04:amd64:{ 1.17.0.1 amd64   map[20140120:0xc212d04960]}] map[] Mon, 20 Jan 2014 11:25:08 -0500 products:1.0 com.ubuntu.juju:released:tools}
2014-01-20 16:25:12 INFO juju.environs.bootstrap bootstrap.go:58 picked newest version: 1.17.0.1
Launching instance
2014-01-20 16:25:12 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=6cdefb8a-81ef-11e3-b787-525400123456&op=get_by_key"; "f011e2ce4f7b2110a8d88bdf70e676f54d91d312fc8d5d0542f19798e9026d28" %!q(int64=6719588)}
2014-01-20 16:25:12 DEBUG juju.provider.maas environ.go:279 maas user data; 714 bytes
2014-01-20 16:25:13 DEBUG juju.provider.maas environ.go:285 started instance "/MAAS/api/1.0/nodes/node-dbfe13f8-81ee-11e3-90ba-525400123456/"
 - /MAAS/api/1.0/nodes/node-dbfe13f8-81ee-11e3-90ba-525400123456/
Waiting for address
Attempting to connect to ybrrx.master:22
Attempting to connect to 192.168.21.13:22
2014-01-20 16:35:13 ERROR juju.provider.common bootstrap.go:85 bootstrap failed: waited for 10m0s without being able to connect: ssh: connect to host 192.168.21.13 port 22: Connection refused
Stopping instance...
2014-01-20 16:35:13 ERROR juju.cmd supercommand.go:294 waited for 10m0s without being able to connect: ssh: connect to host 192.168.21.13 port 22: Connection refused
}}}

juju --debug status: {{{
2014-01-20 17:14:26 DEBUG juju.provider.maas environprovider.go:33 opening environment "maas".
2014-01-20 17:14:27 WARNING juju api.go:185 discarding API open error: <nil>
2014-01-20 17:14:27 ERROR juju.cmd supercommand.go:294 Unable to connect to environment "".
Please check your credentials or use 'juju bootstrap' to create a new environment.

Error details:
environment is not bootstrapped
}}}

Traceback (most recent call last):
  File "/tmp/adt-run.uGaJFu/ubtree0-build/real-tree/debian/tests/utils.py", line 67, in wrapper
    result = func(*args, **kwargs)
  File "/tmp/adt-run.uGaJFu/ubtree0-build/real-tree/debian/tests/maas-integration.py", line 615, in test_juju_bootstrap
    self._wait_machines_running(1)
  File "/tmp/adt-run.uGaJFu/ubtree0-build/real-tree/debian/tests/maas-integration.py", line 629, in _wait_machines_running
    sleep(20)
  File "/tmp/adt-run.uGaJFu/ubtree0-build/real-tree/debian/tests/utils.py", line 61, in _handle_timeout
    raise TimeoutError(error_message)
TimeoutError: Timer expired


maas-integration.TestMAASIntegration.test_update_pxe_config: 0.0006s
maas-integration.TestMAASIntegration.test_check_dhcp_service: 0.0243s
maas-integration.TestMAASIntegration.test_check_initial_services: 0.0415s
maas-integration.TestMAASIntegration.test_restart_provisioning_server: 0.0658s
maas-integration.TestMAASIntegration.test_update_preseed_arm: 0.0889s
maas-integration.TestMAASIntegration.test_create_admin: 0.1223s
maas-integration.TestMAASIntegration.test_restart_dbus_avahi: 0.1614s
maas-integration.TestMAASIntegration.test_cluster_connected: 0.2121s
maas-integration.TestMAASIntegration.test_apply_tag_to_all_nodes: 0.2327s
maas-integration.TestMAASIntegration.test_check_tag_applied_to_all_nodes: 0.2418s
maas-integration.TestMAASIntegration.test_commission_nodes: 0.3965s
maas-integration.TestMAASIntegration.test_boot_nodes_enlist: 0.5434s
maas-integration.TestMAASIntegration.test_login_api: 1.1979s
maas-integration.TestMAASIntegration.test_update_dns_config: 1.3607s
maas-integration.TestMAASIntegration.test_update_maas_url: 2.2424s
maas-integration.TestMAASIntegration.test_set_up_dhcp_region: 2.5208s
maas-integration.TestMAASIntegration.test_set_nodes_ipmi_config: 2.7291s
maas-integration.TestMAASIntegration.test_configure_juju: 6.0480s
maas-integration.TestMAASIntegration.test_check_nodes_declared: 167.7250s
maas-integration.TestMAASIntegration.test_check_nodes_ready: 194.4577s
maas-integration.TestMAASIntegration.test_import_pxe_files: 947.7728s
maas-integration.TestMAASIntegration.test_juju_bootstrap: 3000.0341s
----------------------------------------------------------------------
Ran 24 tests in 4328.482s

FAILED (SKIP=3, 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.uGaJFu
+ 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-20 12:14:36: Failure: adt-run exited with status 4.\n
2014-01-20 12:14:36: 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-20 12:14:40: Info: Test artifacts copied to /home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results\n
2014-01-20 12:14:40: 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-20_15-54-01 ]
+ 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-20 12:14:40: Failure: Test didn't end normally. Generating error file\n
2014-01-20 12:14:40: 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_20140120-121440.error
+ echo trusty amd64 maas
+ rsync -a /home/ubuntu/jenkins-jobs/workspace/trusty-adt-maas-daily/results/trusty_amd64_maas_20140120-121440.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 12:14 ...




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-20 12:14:40: Info: Cleaning up\n
2014-01-20 12:14:40: Info: Cleaning up
+ [ -f /var/tmp/adt/disks/run/trusty-amd64-maas-20140120_105432.HCi94U.img.pid ]
+ cat /var/tmp/adt/disks/run/trusty-amd64-maas-20140120_105432.HCi94U.img.pid
+ kill -9 16510
+ rm -f /var/tmp/adt/disks/run/trusty-amd64-maas-20140120_105432.HCi94U.img.pid
+ rm -f /var/tmp/adt/disks/run/trusty-amd64-maas-20140120_105432.HCi94U.img
+ rm -f /var/tmp/adt/disks/run/trusty-amd64-maas-20140120_105432.HCi94U.img.monitor /var/tmp/adt/disks/run/trusty-amd64-maas-20140120_105432.HCi94U.img.serial
+ rm -f /var/lock/adt/ssh.54323.lock
+ rm -f /var/lock/adt/vnc.5911.lock
+ [ -d /tmp/adt-amd64.WOoTZY ]
+ rm -Rf /tmp/adt-amd64.WOoTZY
+ rm -f /var/tmp/adt/disks/run/trusty-amd64-maas-20140120_062937.vPROQM.img /var/tmp/adt/disks/run/trusty-amd64-maas-20140120_062937.vPROQM.img.monitor /var/tmp/adt/disks/run/trusty-amd64-maas-20140120_062937.vPROQM.img.pid /var/tmp/adt/disks/run/trusty-amd64-maas-20140120_062937.vPROQM.img.serial
+ 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