0s autopkgtest [13:43:15]: starting date and time: 2024-11-14 13:43:15+0000 0s autopkgtest [13:43:15]: git checkout: 6f3be7a8 Fix armhf LXD image generation for plucky 0s autopkgtest [13:43:15]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.s33rgin2/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:pyyaml --apt-upgrade lavacli --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=pyyaml/6.0.2-1build1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-s390x-2.secgroup --name adt-plucky-s390x-lavacli-20241114-134314-juju-7f2275-prod-proposed-migration-environment-20-c8913aca-7043-4c06-b447-dfd52eb9eff3 --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-s390x -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 109s autopkgtest [13:45:04]: testbed dpkg architecture: s390x 109s autopkgtest [13:45:04]: testbed apt version: 2.9.8 109s autopkgtest [13:45:04]: @@@@@@@@@@@@@@@@@@@@ test bed setup 110s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 110s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 110s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [105 kB] 110s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [983 kB] 110s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.3 kB] 110s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [114 kB] 110s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [677 kB] 110s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [5540 B] 110s Fetched 1980 kB in 1s (2416 kB/s) 110s Reading package lists... 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 113s Calculating upgrade... 113s The following packages will be upgraded: 113s pastebinit python3-yaml 113s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 113s Need to get 203 kB of archives. 113s After this operation, 261 kB of additional disk space will be used. 113s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3-yaml s390x 6.0.2-1build1 [188 kB] 113s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x pastebinit all 1.7.1-1 [14.9 kB] 113s Fetched 203 kB in 0s (484 kB/s) 113s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 55511 files and directories currently installed.) 113s Preparing to unpack .../python3-yaml_6.0.2-1build1_s390x.deb ... 113s Unpacking python3-yaml (6.0.2-1build1) over (6.0.2-1) ... 113s Preparing to unpack .../pastebinit_1.7.1-1_all.deb ... 113s Unpacking pastebinit (1.7.1-1) over (1.7.0-1) ... 114s Setting up pastebinit (1.7.1-1) ... 114s Setting up python3-yaml (6.0.2-1build1) ... 114s Processing triggers for man-db (2.12.1-3) ... 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 114s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 115s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 115s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 115s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 115s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 116s Reading package lists... 116s Reading package lists... 116s Building dependency tree... 116s Reading state information... 116s Calculating upgrade... 116s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 116s Reading package lists... 116s Building dependency tree... 116s Reading state information... 116s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 119s autopkgtest [13:45:14]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 119s autopkgtest [13:45:14]: @@@@@@@@@@@@@@@@@@@@ apt-source lavacli 120s Get:1 http://ftpmaster.internal/ubuntu plucky/universe lavacli 1.2-1 (dsc) [2181 B] 120s Get:2 http://ftpmaster.internal/ubuntu plucky/universe lavacli 1.2-1 (tar) [70.3 kB] 120s Get:3 http://ftpmaster.internal/ubuntu plucky/universe lavacli 1.2-1 (diff) [15.3 kB] 120s gpgv: Signature made Fri Dec 17 18:28:19 2021 UTC 120s gpgv: using RSA key B2DEE66036C40829FCD0F10CFC0DB1BBCD460BDE 120s gpgv: Can't check signature: No public key 120s dpkg-source: warning: cannot verify inline signature for ./lavacli_1.2-1.dsc: no acceptable signature found 120s autopkgtest [13:45:15]: testing package lavacli version 1.2-1 121s autopkgtest [13:45:16]: build not needed 121s autopkgtest [13:45:16]: test testsuite: preparing testbed 124s Reading package lists... 124s Building dependency tree... 124s Reading state information... 124s Starting pkgProblemResolver with broken count: 0 124s Starting 2 pkgProblemResolver with broken count: 0 124s Done 124s The following additional packages will be installed: 124s lavacli libnorm1t64 libpgm-5.3-0t64 libsodium23 libzmq5 python3-aiohttp 124s python3-aiosignal python3-async-timeout python3-frozenlist python3-iniconfig 124s python3-multidict python3-packaging python3-pluggy python3-py python3-pytest 124s python3-yarl python3-zmq 124s Suggested packages: 124s subversion 124s Recommended packages: 124s libjs-jquery python3-aiodns 124s The following NEW packages will be installed: 124s autopkgtest-satdep lavacli libnorm1t64 libpgm-5.3-0t64 libsodium23 libzmq5 124s python3-aiohttp python3-aiosignal python3-async-timeout python3-frozenlist 124s python3-iniconfig python3-multidict python3-packaging python3-pluggy 124s python3-py python3-pytest python3-yarl python3-zmq 124s 0 upgraded, 18 newly installed, 0 to remove and 0 not upgraded. 124s Need to get 1913 kB/1913 kB of archives. 124s After this operation, 7413 kB of additional disk space will be used. 124s Get:1 /tmp/autopkgtest.ZvkRbn/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [720 B] 124s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-multidict s390x 6.1.0-1 [34.1 kB] 124s Get:3 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-yarl s390x 1.9.4-1 [72.8 kB] 124s Get:4 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-async-timeout all 4.0.3-1 [6412 B] 124s Get:5 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-frozenlist s390x 1.5.0-1 [49.7 kB] 124s Get:6 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-aiosignal all 1.3.1-1 [5172 B] 124s Get:7 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-aiohttp s390x 3.9.5-1 [294 kB] 124s Get:8 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-py all 1.11.0-2 [72.7 kB] 124s Get:9 http://ftpmaster.internal/ubuntu plucky/universe s390x libnorm1t64 s390x 1.5.9+dfsg-3.1build1 [158 kB] 124s Get:10 http://ftpmaster.internal/ubuntu plucky/universe s390x libpgm-5.3-0t64 s390x 5.3.128~dfsg-2.1build1 [169 kB] 125s Get:11 http://ftpmaster.internal/ubuntu plucky/main s390x libsodium23 s390x 1.0.18-1build3 [138 kB] 125s Get:12 http://ftpmaster.internal/ubuntu plucky/universe s390x libzmq5 s390x 4.3.5-1build2 [258 kB] 125s Get:13 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-zmq s390x 24.0.1-5build1 [298 kB] 125s Get:14 http://ftpmaster.internal/ubuntu plucky/universe s390x lavacli all 1.2-1 [37.0 kB] 125s Get:15 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-iniconfig all 1.1.1-2 [6024 B] 125s Get:16 http://ftpmaster.internal/ubuntu plucky/main s390x python3-packaging all 24.1-1 [41.4 kB] 125s Get:17 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pluggy all 1.5.0-1 [21.0 kB] 125s Get:18 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pytest all 8.3.3-1 [251 kB] 125s Fetched 1913 kB in 1s (3158 kB/s) 125s Selecting previously unselected package python3-multidict. 125s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 55512 files and directories currently installed.) 125s Preparing to unpack .../00-python3-multidict_6.1.0-1_s390x.deb ... 125s Unpacking python3-multidict (6.1.0-1) ... 125s Selecting previously unselected package python3-yarl. 125s Preparing to unpack .../01-python3-yarl_1.9.4-1_s390x.deb ... 125s Unpacking python3-yarl (1.9.4-1) ... 125s Selecting previously unselected package python3-async-timeout. 125s Preparing to unpack .../02-python3-async-timeout_4.0.3-1_all.deb ... 125s Unpacking python3-async-timeout (4.0.3-1) ... 125s Selecting previously unselected package python3-frozenlist. 125s Preparing to unpack .../03-python3-frozenlist_1.5.0-1_s390x.deb ... 125s Unpacking python3-frozenlist (1.5.0-1) ... 125s Selecting previously unselected package python3-aiosignal. 125s Preparing to unpack .../04-python3-aiosignal_1.3.1-1_all.deb ... 125s Unpacking python3-aiosignal (1.3.1-1) ... 125s Selecting previously unselected package python3-aiohttp. 125s Preparing to unpack .../05-python3-aiohttp_3.9.5-1_s390x.deb ... 125s Unpacking python3-aiohttp (3.9.5-1) ... 125s Selecting previously unselected package python3-py. 125s Preparing to unpack .../06-python3-py_1.11.0-2_all.deb ... 125s Unpacking python3-py (1.11.0-2) ... 125s Selecting previously unselected package libnorm1t64:s390x. 125s Preparing to unpack .../07-libnorm1t64_1.5.9+dfsg-3.1build1_s390x.deb ... 125s Unpacking libnorm1t64:s390x (1.5.9+dfsg-3.1build1) ... 125s Selecting previously unselected package libpgm-5.3-0t64:s390x. 125s Preparing to unpack .../08-libpgm-5.3-0t64_5.3.128~dfsg-2.1build1_s390x.deb ... 125s Unpacking libpgm-5.3-0t64:s390x (5.3.128~dfsg-2.1build1) ... 125s Selecting previously unselected package libsodium23:s390x. 125s Preparing to unpack .../09-libsodium23_1.0.18-1build3_s390x.deb ... 125s Unpacking libsodium23:s390x (1.0.18-1build3) ... 125s Selecting previously unselected package libzmq5:s390x. 125s Preparing to unpack .../10-libzmq5_4.3.5-1build2_s390x.deb ... 125s Unpacking libzmq5:s390x (4.3.5-1build2) ... 125s Selecting previously unselected package python3-zmq. 125s Preparing to unpack .../11-python3-zmq_24.0.1-5build1_s390x.deb ... 125s Unpacking python3-zmq (24.0.1-5build1) ... 125s Selecting previously unselected package lavacli. 125s Preparing to unpack .../12-lavacli_1.2-1_all.deb ... 125s Unpacking lavacli (1.2-1) ... 125s Selecting previously unselected package python3-iniconfig. 125s Preparing to unpack .../13-python3-iniconfig_1.1.1-2_all.deb ... 125s Unpacking python3-iniconfig (1.1.1-2) ... 125s Selecting previously unselected package python3-packaging. 125s Preparing to unpack .../14-python3-packaging_24.1-1_all.deb ... 125s Unpacking python3-packaging (24.1-1) ... 125s Selecting previously unselected package python3-pluggy. 125s Preparing to unpack .../15-python3-pluggy_1.5.0-1_all.deb ... 125s Unpacking python3-pluggy (1.5.0-1) ... 125s Selecting previously unselected package python3-pytest. 125s Preparing to unpack .../16-python3-pytest_8.3.3-1_all.deb ... 125s Unpacking python3-pytest (8.3.3-1) ... 125s Selecting previously unselected package autopkgtest-satdep. 125s Preparing to unpack .../17-1-autopkgtest-satdep.deb ... 125s Unpacking autopkgtest-satdep (0) ... 125s Setting up python3-iniconfig (1.1.1-2) ... 125s Setting up libnorm1t64:s390x (1.5.9+dfsg-3.1build1) ... 125s Setting up libsodium23:s390x (1.0.18-1build3) ... 125s Setting up python3-py (1.11.0-2) ... 125s Setting up python3-multidict (6.1.0-1) ... 125s Setting up python3-frozenlist (1.5.0-1) ... 125s Setting up python3-aiosignal (1.3.1-1) ... 126s Setting up python3-async-timeout (4.0.3-1) ... 126s Setting up libpgm-5.3-0t64:s390x (5.3.128~dfsg-2.1build1) ... 126s Setting up python3-packaging (24.1-1) ... 126s Setting up python3-pluggy (1.5.0-1) ... 126s Setting up python3-yarl (1.9.4-1) ... 126s Setting up libzmq5:s390x (4.3.5-1build2) ... 126s Setting up python3-pytest (8.3.3-1) ... 126s Setting up python3-aiohttp (3.9.5-1) ... 126s Setting up python3-zmq (24.0.1-5build1) ... 127s Setting up lavacli (1.2-1) ... 127s Setting up autopkgtest-satdep (0) ... 127s Processing triggers for man-db (2.12.1-3) ... 127s Processing triggers for libc-bin (2.40-1ubuntu3) ... 129s (Reading database ... 56136 files and directories currently installed.) 129s Removing autopkgtest-satdep (0) ... 129s autopkgtest [13:45:24]: test testsuite: [----------------------- 130s ============================= test session starts ============================== 130s platform linux -- Python 3.12.7, pytest-8.3.3, pluggy-1.5.0 130s rootdir: /tmp/autopkgtest.ZvkRbn/autopkgtest_tmp 130s plugins: typeguard-4.4.1 130s collected 199 items 130s 130s tests/test_aliases.py ............. [ 6%] 131s tests/test_device_types.py ........FF............... [ 19%] 131s tests/test_devices.py ................................... [ 36%] 131s tests/test_events.py ............ [ 42%] 131s tests/test_helpers.py .. [ 43%] 131s tests/test_identities.py ............. [ 50%] 132s tests/test_jobs.py ......................................... [ 70%] 132s tests/test_lavacli.py ... [ 72%] 132s tests/test_results.py .............. [ 79%] 133s tests/test_system.py ............ [ 85%] 133s tests/test_tags.py ........ [ 89%] 133s tests/test_workers.py ..................... [100%] 133s 133s =================================== FAILURES =================================== 133s _________________________ test_dt_hc_get_before_2018_4 _________________________ 133s 133s setup = None 133s monkeypatch = <_pytest.monkeypatch.MonkeyPatch object at 0x3ff93b042f0> 133s capsys = <_pytest.capture.CaptureFixture object at 0x3ff93b07290> 133s 133s def test_dt_hc_get_before_2018_4(setup, monkeypatch, capsys): 133s version = "2018.2" 133s monkeypatch.setattr( 133s sys, "argv", ["lavacli", "device-types", "health-check", "get", "mydt"] 133s ) 133s monkeypatch.setattr( 133s xmlrpc.client.ServerProxy, 133s "data", 133s [ 133s {"request": "system.version", "args": (), "ret": version}, 133s {"request": None, "args": (), "ret": []}, 133s ], 133s ) 133s with pytest.raises(SystemExit): 133s main() 133s > assert ( # nosec 133s capsys.readouterr()[1] 133s == """usage: lavacli device-types [-h] {add,aliases,list,show,template,update} ... 133s lavacli device-types: error: argument sub_sub_command: invalid choice: 'health-check' (choose from 'add', 'aliases', 'list', 'show', 'template', 'update') 133s """ 133s ) 133s E assert 'usage: lavac...te, update)\n' == "usage: lavac..., 'update')\n" 133s E 133s E Skipping 166 identical leading characters in diff, use -v to show 133s E - oose from 'add', 'aliases', 'list', 'show', 'template', 'update') 133s E ? - - - - - - - - - - - - 133s E + oose from add, aliases, list, show, template, update) 133s 133s tests/test_device_types.py:227: AssertionError 133s _________________________ test_dt_hc_set_before_2018_4 _________________________ 133s 133s setup = None 133s monkeypatch = <_pytest.monkeypatch.MonkeyPatch object at 0x3ff93df39e0> 133s capsys = <_pytest.capture.CaptureFixture object at 0x3ff93df0b30> 133s 133s def test_dt_hc_set_before_2018_4(setup, monkeypatch, capsys): 133s version = "2018.2" 133s monkeypatch.setattr( 133s sys, "argv", ["lavacli", "device-types", "health-check", "set", "mydt"] 133s ) 133s monkeypatch.setattr( 133s xmlrpc.client.ServerProxy, 133s "data", 133s [ 133s {"request": "system.version", "args": (), "ret": version}, 133s {"request": None, "args": (), "ret": []}, 133s ], 133s ) 133s with pytest.raises(SystemExit): 133s main() 133s > assert ( # nosec 133s capsys.readouterr()[1] 133s == """usage: lavacli device-types [-h] {add,aliases,list,show,template,update} ... 133s lavacli device-types: error: argument sub_sub_command: invalid choice: 'health-check' (choose from 'add', 'aliases', 'list', 'show', 'template', 'update') 133s """ 133s ) 133s E assert 'usage: lavac...te, update)\n' == "usage: lavac..., 'update')\n" 133s E 133s E Skipping 166 identical leading characters in diff, use -v to show 133s E - oose from 'add', 'aliases', 'list', 'show', 'template', 'update') 133s E ? - - - - - - - - - - - - 133s E + oose from add, aliases, list, show, template, update) 133s 133s tests/test_device_types.py:250: AssertionError 133s =============================== warnings summary =============================== 133s tests/test_events.py: 114 warnings 133s /usr/lib/python3/dist-packages/lavacli/commands/events.py:208: DeprecationWarning: zmq.utils.strtypes is deprecated in pyzmq 23. 133s (topic, _, dt, username, data) = (u(m) for m in msg) 133s 133s tests/test_events.py::test_events_wait_device 133s tests/test_events.py::test_events_wait_device_state 133s tests/test_events.py::test_events_wait_device_health 133s tests/test_events.py::test_events_wait_job 133s tests/test_events.py::test_events_wait_worker 133s tests/test_events.py::test_events_wait_worker_invalid_message 133s /usr/lib/python3/dist-packages/lavacli/commands/events.py:268: DeprecationWarning: zmq.utils.strtypes is deprecated in pyzmq 23. 133s sock.setsockopt(zmq.SUBSCRIBE, b(config.get("events", {}).get("topic", ""))) 133s 133s tests/test_events.py: 106 warnings 133s /usr/lib/python3/dist-packages/lavacli/commands/events.py:293: DeprecationWarning: zmq.utils.strtypes is deprecated in pyzmq 23. 133s (topic, _uuid, _dt, _username, data) = (u(m) for m in msg) 133s 133s tests/test_jobs.py::test_jobs_logs_failure_comment_and_polling 133s /usr/lib/python3/dist-packages/lavacli/commands/jobs.py:550: DeprecationWarning: datetime.datetime.utcnow() is deprecated and scheduled for removal in a future version. Use timezone-aware objects to represent datetimes in UTC: datetime.datetime.now(datetime.UTC). 133s "dt": datetime.datetime.utcnow().isoformat(), 133s 133s tests/test_jobs.py::test_jobs_resubmit_follow 133s /usr/lib/python3/dist-packages/lavacli/commands/jobs.py:606: DeprecationWarning: datetime.datetime.utcnow() is deprecated and scheduled for removal in a future version. Use timezone-aware objects to represent datetimes in UTC: datetime.datetime.now(datetime.UTC). 133s "dt": datetime.datetime.utcnow().isoformat(), 133s 133s tests/test_jobs.py::test_jobs_run 133s /usr/lib/python3/dist-packages/lavacli/commands/jobs.py:647: DeprecationWarning: datetime.datetime.utcnow() is deprecated and scheduled for removal in a future version. Use timezone-aware objects to represent datetimes in UTC: datetime.datetime.now(datetime.UTC). 133s "dt": datetime.datetime.utcnow().isoformat(), 133s 133s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 133s =========================== short test summary info ============================ 133s FAILED tests/test_device_types.py::test_dt_hc_get_before_2018_4 - assert 'usa... 133s FAILED tests/test_device_types.py::test_dt_hc_set_before_2018_4 - assert 'usa... 133s ================= 2 failed, 197 passed, 229 warnings in 3.54s ================== 134s autopkgtest [13:45:29]: test testsuite: -----------------------] 134s autopkgtest [13:45:29]: test testsuite: - - - - - - - - - - results - - - - - - - - - - 134s testsuite FAIL non-zero exit status 1 134s autopkgtest [13:45:29]: @@@@@@@@@@@@@@@@@@@@ summary 134s testsuite FAIL non-zero exit status 1 146s nova [W] Using flock in prodstack6-s390x 146s flock: timeout while waiting to get lock 146s Creating nova instance adt-plucky-s390x-lavacli-20241114-134314-juju-7f2275-prod-proposed-migration-environment-20-c8913aca-7043-4c06-b447-dfd52eb9eff3 from image adt/ubuntu-plucky-s390x-server-20241114.img (UUID 41a907ef-1f3c-4685-a0eb-228b0d61c6b5)...