maas-builds team mailing list archive

[MAAS Jenkins <devnull@xxxxxxxxxxxxx>]

Built with lp:maas (revno: 3717) and lp:~maas-maintainers/maas/packaging (revno: 368)

See http://162.213.35.104:8080/job/maas-utopic-trunk/188/

[...truncated 11449 lines...]
tar: ./src/provisioningserver/pserv_services/tests/test_node_power_monitor_service.py: time stamp 2015-03-25 14:01:08 is 13428.593350054 s in the future
tar: ./src/provisioningserver/pserv_services/tests/__init__.py: time stamp 2015-03-25 14:01:08 is 13428.592859349 s in the future
tar: ./src/provisioningserver/pserv_services/tests/test_dhcp_probe_service.py: time stamp 2015-03-25 14:01:08 is 13428.592325178 s in the future
tar: ./src/provisioningserver/pserv_services/tests: time stamp 2015-03-25 14:01:19 is 13439.591804761 s in the future
tar: ./src/provisioningserver/pserv_services/tftp.py: time stamp 2015-03-25 14:01:08 is 13428.591216624 s in the future
tar: ./src/provisioningserver/pserv_services/image_download_service.py: time stamp 2015-03-25 14:01:08 is 13428.590783805 s in the future
tar: ./src/provisioningserver/pserv_services/__init__.py: time stamp 2015-03-25 14:01:08 is 13428.590397046 s in the future
tar: ./src/provisioningserver/pserv_services/lease_upload_service.py: time stamp 2015-03-25 14:01:08 is 13428.589978316 s in the future
tar: ./src/provisioningserver/pserv_services: time stamp 2015-03-25 14:01:19 is 13439.589628969 s in the future
tar: ./src/provisioningserver/auth.py: time stamp 2015-03-25 14:01:08 is 13428.589241499 s in the future
tar: ./src/provisioningserver/tags.py: time stamp 2015-03-25 14:01:08 is 13428.588808797 s in the future
tar: ./src/provisioningserver/plugin.py: time stamp 2015-03-25 14:01:08 is 13428.588380187 s in the future
tar: ./src/provisioningserver/udev.py: time stamp 2015-03-25 14:01:08 is 13428.587948105 s in the future
tar: ./src/provisioningserver/cluster_config.py: time stamp 2015-03-25 14:01:08 is 13428.587532129 s in the future
tar: ./src/provisioningserver/config.py: time stamp 2015-03-25 14:01:08 is 13428.587056731 s in the future
tar: ./src/provisioningserver/network.py: time stamp 2015-03-25 14:01:08 is 13428.586614532 s in the future
tar: ./src/provisioningserver/logger/tests/__init__.py: time stamp 2015-03-25 14:01:08 is 13428.586135684 s in the future
tar: ./src/provisioningserver/logger/tests/test_logger.py: time stamp 2015-03-25 14:01:08 is 13428.585713696 s in the future
tar: ./src/provisioningserver/logger/tests: time stamp 2015-03-25 14:01:11 is 13431.585325095 s in the future
tar: ./src/provisioningserver/logger/__init__.py: time stamp 2015-03-25 14:01:08 is 13428.584792567 s in the future
tar: ./src/provisioningserver/logger/log.py: time stamp 2015-03-25 14:01:08 is 13428.584298906 s in the future
tar: ./src/provisioningserver/logger: time stamp 2015-03-25 14:01:16 is 13436.583779092 s in the future
tar: ./src/provisioningserver/events.py: time stamp 2015-03-25 14:01:08 is 13428.583237363 s in the future
tar: ./src/provisioningserver/diskless.py: time stamp 2015-03-25 14:01:08 is 13428.58286144 s in the future
tar: ./src/provisioningserver: time stamp 2015-03-25 14:01:19 is 13439.58249892 s in the future
tar: ./required-packages/dev: time stamp 2015-03-25 14:01:08 is 13428.582101194 s in the future
tar: ./required-packages/doc: time stamp 2015-03-25 14:01:08 is 13428.581736315 s in the future
tar: ./required-packages/build: time stamp 2015-03-25 14:01:08 is 13428.581370145 s in the future
tar: ./required-packages/optional: time stamp 2015-03-25 14:01:08 is 13428.581008763 s in the future
tar: ./required-packages/base: time stamp 2015-03-25 14:01:08 is 13428.580608817 s in the future
tar: ./required-packages/forbidden: time stamp 2015-03-25 14:01:08 is 13428.580249713 s in the future
tar: ./required-packages: time stamp 2015-03-25 14:01:19 is 13439.579910534 s in the future
tar: ./README: time stamp 2015-03-25 14:01:08 is 13428.579540171 s in the future
tar: ./utilities/normalize-spelling: time stamp 2015-03-25 14:01:08 is 13428.579063207 s in the future
tar: ./utilities/rewrite-future-imports: time stamp 2015-03-25 14:01:08 is 13428.578618782 s in the future
tar: ./utilities/find-imported-module-files: time stamp 2015-03-25 14:01:08 is 13428.578129867 s in the future
tar: ./utilities/format-new-and-modified-imports: time stamp 2015-03-25 14:01:08 is 13428.577582124 s in the future
tar: ./utilities/python_standard_libs.py: time stamp 2015-03-25 14:01:08 is 13428.577032483 s in the future
tar: ./utilities/doc-lint: time stamp 2015-03-25 14:01:08 is 13428.576571301 s in the future
tar: ./utilities/generate-and-upload-docs: time stamp 2015-03-25 14:01:08 is 13428.576024666 s in the future
tar: ./utilities/format-imports: time stamp 2015-03-25 14:01:08 is 13428.575528458 s in the future
tar: ./utilities/find-imported-modules: time stamp 2015-03-25 14:01:08 is 13428.574972047 s in the future
tar: ./utilities/check-maaslog-exception: time stamp 2015-03-25 14:01:08 is 13428.57440143 s in the future
tar: ./utilities: time stamp 2015-03-25 14:01:18 is 13438.573959768 s in the future
tar: ./LICENSE: time stamp 2015-03-25 14:01:08 is 13428.573274342 s in the future
tar: ./contrib/maas_local_settings.py: time stamp 2015-03-25 14:01:08 is 13428.572679943 s in the future
tar: ./contrib/maas-rsyslog.conf: time stamp 2015-03-25 14:01:08 is 13428.572139899 s in the future
tar: ./contrib/maas-http.conf: time stamp 2015-03-25 14:01:08 is 13428.571594813 s in the future
tar: ./contrib/tgt.conf: time stamp 2015-03-25 14:01:08 is 13428.57112533 s in the future
tar: ./contrib/preseeds_v2/preseed_master: time stamp 2015-03-25 14:01:08 is 13428.570612618 s in the future
tar: ./contrib/preseeds_v2/commissioning: time stamp 2015-03-25 14:01:08 is 13428.570098623 s in the future
tar: ./contrib/preseeds_v2/generic: time stamp 2015-03-25 14:01:08 is 13428.569498239 s in the future
tar: ./contrib/preseeds_v2/preseed_master_windows_amd64_generic_win2012: time stamp 2015-03-25 14:01:08 is 13428.568943806 s in the future
tar: ./contrib/preseeds_v2/curtin: time stamp 2015-03-25 14:01:08 is 13428.568417972 s in the future
tar: ./contrib/preseeds_v2/enlist_userdata: time stamp 2015-03-25 14:01:08 is 13428.567951941 s in the future
tar: ./contrib/preseeds_v2/preseed_master_windows_amd64_generic_win2012hv: time stamp 2015-03-25 14:01:08 is 13428.567360641 s in the future
tar: ./contrib/preseeds_v2/enlist: time stamp 2015-03-25 14:01:08 is 13428.566709947 s in the future
tar: ./contrib/preseeds_v2/curtin_userdata: time stamp 2015-03-25 14:01:08 is 13428.566262092 s in the future
tar: ./contrib/preseeds_v2/curtin_userdata_centos: time stamp 2015-03-25 14:01:08 is 13428.565811576 s in the future
tar: ./contrib/preseeds_v2/curtin_userdata_custom: time stamp 2015-03-25 14:01:08 is 13428.565334767 s in the future
tar: ./contrib/preseeds_v2/preseed_master_windows_amd64_generic_win2012r2: time stamp 2015-03-25 14:01:08 is 13428.564795194 s in the future
tar: ./contrib/preseeds_v2/curtin_userdata_suse: time stamp 2015-03-25 14:01:08 is 13428.564208392 s in the future
tar: ./contrib/preseeds_v2/curtin_userdata_windows: time stamp 2015-03-25 14:01:08 is 13428.563675308 s in the future
tar: ./contrib/preseeds_v2/preseed_master_windows_amd64_generic_win2012hvr2: time stamp 2015-03-25 14:01:08 is 13428.563059749 s in the future
tar: ./contrib/preseeds_v2: time stamp 2015-03-25 14:01:19 is 13439.562642152 s in the future
tar: ./templates/model.py: time stamp 2015-03-25 14:01:08 is 13428.562167846 s in the future
tar: ./templates/test_module.js: time stamp 2015-03-25 14:01:08 is 13428.561617987 s in the future
tar: ./templates/module.py: time stamp 2015-03-25 14:01:08 is 13428.561156336 s in the future
tar: ./templates/script.py: time stamp 2015-03-25 14:01:08 is 13428.56068398 s in the future
tar: ./templates/test_module.py: time stamp 2015-03-25 14:01:08 is 13428.560241483 s in the future
tar: ./templates/management_command.py: time stamp 2015-03-25 14:01:08 is 13428.559774769 s in the future
tar: ./templates/module.js: time stamp 2015-03-25 14:01:08 is 13428.559250985 s in the future
tar: ./templates/doc.txt: time stamp 2015-03-25 14:01:08 is 13428.558793031 s in the future
tar: ./templates/test_module.html: time stamp 2015-03-25 14:01:08 is 13428.558285799 s in the future
tar: ./templates/script.sh: time stamp 2015-03-25 14:01:08 is 13428.557828245 s in the future
tar: ./templates/README: time stamp 2015-03-25 14:01:08 is 13428.557325028 s in the future
tar: ./templates: time stamp 2015-03-25 14:01:14 is 13434.55690047 s in the future
tar: ./versions.cfg: time stamp 2015-03-25 14:01:08 is 13428.556373373 s in the future
tar: ./INSTALL.txt: time stamp 2015-03-25 14:01:08 is 13428.555805858 s in the future
tar: ./src/metadataserver/deployment/maas_configure_interfaces.py: time stamp 2015-03-25 14:01:07 is 13427.555208407 s in the future
tar: ./docs/hacking.rst: time stamp 2015-03-25 14:01:07 is 13427.554623797 s in the future
tar: ./docs/install.rst: time stamp 2015-03-25 14:01:07 is 13427.554137109 s in the future
tar: ./services/regiond2/run: time stamp 2015-03-25 14:01:07 is 13427.553612878 s in the future
tar: ./src/metadataserver/deployment: time stamp 2015-03-25 14:01:18 is 13438.553110158 s in the future
tar: ./src/metadataserver: time stamp 2015-03-25 14:01:19 is 13439.552682033 s in the future
tar: ./docs: time stamp 2015-03-25 14:01:19 is 13439.552037445 s in the future
tar: ./services/regiond2: time stamp 2015-03-25 14:01:16 is 13436.551533953 s in the future
tar: ./services: time stamp 2015-03-25 14:01:19 is 13439.550999057 s in the future
adt-run: DBG: got reply from testbed: ok
adt-run: DBG: testbed command ['chown', '-R', 'ubuntu', '--', '/tmp/adt-run.lheI4v/build.DiB/real-tree'], kind short, sout raw, serr pipe, env ['LANG=C.UTF-8']
adt-run: DBG: testbed command exited with code 0
adt-run [14:17:20]: test maas-package-test: [-----------------------
adt-run: DBG: testbed command ['su', '-s', '/bin/bash', 'root', '-c', 'set -e; export USER=`id -nu`; . /etc/profile >/dev/null 2>&1 || true;  . ~/.profile >/dev/null 2>&1 || true; buildtree="/tmp/adt-run.lheI4v/build.DiB/real-tree"; mkdir -p -m 1777 -- "/tmp/adt-run.lheI4v/maas-package-test-artifacts"; export ADT_ARTIFACTS="/tmp/adt-run.lheI4v/maas-package-test-artifacts"; export ADTTMP=$(mktemp -d --tmpdir adttmp.XXXXXX); rm -f /tmp/adt_test_script_pid; set -C; echo $$ > /tmp/adt_test_script_pid; set +C; trap "rm -rf $ADTTMP /tmp/adt_test_script_pid" EXIT INT QUIT PIPE; chmod 755 $ADTTMP; cd "$buildtree"; export LANG=C.UTF-8; unset LANGUAGE LC_CTYPE LC_NUMERIC LC_TIME LC_COLLATE LC_MONETARY LC_MESSAGES LC_PAPER LC_NAME LC_ADDRESS LC_TELEPHONE LC_MEASUREMENT LC_IDENTIFICATION LC_ALL;chmod +x /tmp/adt-run.lheI4v/build.DiB/real-tree/debian/tests/maas-package-test; touch /tmp/adt-run.lheI4v/maas-package-test-stdout /tmp/adt-run.lheI4v/maas-package-test-stderr; /tmp/adt-run.lheI4v/build.DiB/real-tree/debian/tests/maas-package-test 2> >(tee -a /tmp/adt-run.lheI4v/maas-package-test-stderr >&2) > >(tee -a /tmp/adt-run.lheI4v/maas-package-test-stdout); '], kind test, sout raw, serr raw, env ['LANG=C.UTF-8']
Ignoring indexes: https://pypi.python.org/simple/
Downloading/unpacking nose-timer
  Running setup.py (path:/tmp/pip_build_root/nose-timer/setup.py) egg_info for package nose-timer
    
Installing collected packages: nose-timer
  Running setup.py install for nose-timer
    
Successfully installed nose-timer
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_preseed_arm ... ok
maas-integration.TestMAASIntegration.test_login_api ... ok
maas-integration.TestMAASIntegration.test_set_http_proxy ... ok
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_add_new_zones ... ok
maas-integration.TestMAASIntegration.test_list_zones ... ok
maas-integration.TestMAASIntegration.test_delete_zone ... ok
maas-integration.TestMAASIntegration.test_import_boot_resources ... ok
maas-integration.TestMAASIntegration.test_imported_boot_resources ... ERROR
SKIP: Not testing Cluster controller

======================================================================
ERROR: maas-integration.TestMAASIntegration.test_imported_boot_resources
----------------------------------------------------------------------
_StringException: Empty attachments:
  stderr for maas maas ['boot-resource', 'read', '1']
  stderr for maas maas ['boot-resources', 'read']

Waiting for region to import boot resources.: {{{[]}}}
retcode for maas maas ['boot-resource', 'read', '1']: {{{0}}}
retcode for maas maas ['boot-resources', 'read']: {{{0}}}
stdout for maas maas ['boot-resource', 'read', '1']: {{{
{
    "name": "ubuntu/trusty", 
    "subarches": "generic,hwe-p,hwe-q,hwe-r,hwe-s,hwe-t", 
    "kflavor": "generic", 
    "architecture": "amd64/hwe-t", 
    "sets": {
        "20140904": {
            "files": {
                "root-image.gz": {
                    "complete": false, 
                    "filetype": "root-image.gz", 
                    "filename": "root-image.gz", 
                    "progress": 0, 
                    "sha256": "6ff7ae2389224763c785146794ee4b357dcf9e5f44597d6273282281b3262da9", 
                    "size": 341135891
                }, 
                "boot-kernel": {
                    "filename": "boot-kernel", 
                    "filetype": "boot-kernel", 
                    "sha256": "b146783134b20619cd92c998e567c959d6ca2687b7609fb952f5740b3348e907", 
                    "complete": true, 
                    "size": 5806368
                }, 
                "di-kernel": {
                    "filename": "di-kernel", 
                    "filetype": "di-kernel", 
                    "sha256": "d4fc2ba26cad96f4360cb36f04c26b2f50dceee9413c206431148b87e4958909", 
                    "complete": true, 
                    "size": 5800024
                }, 
                "boot-initrd": {
                    "filename": "boot-initrd", 
                    "filetype": "boot-initrd", 
                    "sha256": "d9f59b43a593b4b7bb04dc1329e29c9dfca86dd0d8f9f06ce0966bc184dfe763", 
                    "complete": true, 
                    "size": 24887599
                }, 
                "di-initrd": {
                    "filename": "di-initrd", 
                    "filetype": "di-initrd", 
                    "sha256": "71fb5916ad1ee63a1de85e2ed623400201be76566704b7a94503b46637412f44", 
                    "complete": true, 
                    "size": 21268557
                }
            }, 
            "complete": false, 
            "label": "release", 
            "version": "20140904", 
            "progress": 14.480514926256706, 
            "size": 398898439
        }
    }, 
    "type": "Synced", 
    "id": 1, 
    "resource_uri": "/MAAS/api/1.0/boot-resources/1/"
}
}}}

stdout for maas maas ['boot-resources', 'read']: {{{[]}}}

Traceback (most recent call last):
  File "/tmp/adt-run.lheI4v/build.DiB/real-tree/debian/tests/timeout.py", line 22, in wrapper
    result = func(*args, **kwargs)
  File "/tmp/adt-run.lheI4v/build.DiB/real-tree/debian/tests/maas-integration.py", line 622, in test_imported_boot_resources
    sleep(5)
  File "/tmp/adt-run.lheI4v/build.DiB/real-tree/debian/tests/timeout.py", line 16, in _handle_timeout
    raise TimeoutError(error_message)
TimeoutError: Timer expired


maas-integration.TestMAASIntegration.test_update_preseed_arm: 0.0003s
maas-integration.TestMAASIntegration.test_check_dhcp_service: 0.0114s
maas-integration.TestMAASIntegration.test_check_initial_services: 0.0238s
maas-integration.TestMAASIntegration.test_restart_provisioning_server: 0.0950s
maas-integration.TestMAASIntegration.test_create_admin: 0.1217s
maas-integration.TestMAASIntegration.test_list_zones: 0.2412s
maas-integration.TestMAASIntegration.test_import_boot_resources: 0.2566s
maas-integration.TestMAASIntegration.test_login_api: 0.3089s
maas-integration.TestMAASIntegration.test_cluster_connected: 0.4637s
maas-integration.TestMAASIntegration.test_delete_zone: 0.4818s
maas-integration.TestMAASIntegration.test_add_new_zones: 0.5065s
maas-integration.TestMAASIntegration.test_set_http_proxy: 1.0379s
maas-integration.TestMAASIntegration.test_update_dns_config: 1.0743s
maas-integration.TestMAASIntegration.test_update_maas_url: 2.1956s
maas-integration.TestMAASIntegration.test_set_up_dhcp_region: 13.2526s
maas-integration.TestMAASIntegration.test_imported_boot_resources: 1800.0026s
----------------------------------------------------------------------
Ran 18 tests in 1821.586s

FAILED (SKIP=3, errors=1)
adt-run: DBG: testbed command exited with code 1
adt-run [14:47:48]: test maas-package-test: -----------------------]
adt-run: DBG: testbed executing test finished with exit status 1
adt-run: DBG: sending command to testbed: copyup /tmp/adt-run.lheI4v/maas-package-test-stdout /var/lib/jenkins/workspace/maas-utopic-trunk/results/maas-package-test-stdout
adt-run: DBG: got reply from testbed: ok
adt-run: DBG: sending command to testbed: copyup /tmp/adt-run.lheI4v/maas-package-test-stderr /var/lib/jenkins/workspace/maas-utopic-trunk/results/maas-package-test-stderr
adt-run: DBG: got reply from testbed: ok
adt-run [14:47:49]: test maas-package-test:  - - - - - - - - - - results - - - - - - - - - -
maas-package-test    FAIL non-zero exit status 1
adt-run: DBG: sending command to testbed: copyup /tmp/adt-run.lheI4v/maas-package-test-artifacts/ /var/lib/jenkins/workspace/maas-utopic-trunk/results/artifacts/
adt-run: DBG: got reply from testbed: ok
adt-run: DBG: testbed command ['rm', '-rf', '/tmp/adt-run.lheI4v/maas-package-test-artifacts'], kind short, sout raw, serr pipe, env ['LANG=C.UTF-8']
adt-run: DBG: testbed command exited with code 0
adt-run: DBG: no need to restore click AppArmor profiles
adt-run: DBG: needs_reset, previously=False, requested by run_tests() line 1287
adt-run: DBG: testbed stop
adt-run: DBG: testbed close, scratch=/tmp/adt-run.lheI4v
adt-run: DBG: sending command to testbed: close
qemu: terminating on signal 15 from pid 1971
adt-run: DBG: got reply from testbed: ok
adt-run: DBG: sending command to testbed: quit
adt-run: DBG: / tests-tree rmtree /var/lib/jenkins/workspace/maas-utopic-trunk/results/tests-tree
Build step 'Execute shell' marked build as failure
Archiving artifacts
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any