0s autopkgtest [17:51:35]: starting date and time: 2024-05-05 17:51:35+0000 0s autopkgtest [17:51:35]: git checkout: 699e7f9f ssh-setup/nova: explicitely set 'fqdn' in cloud-init 0s autopkgtest [17:51:35]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work._vd9v8h2/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:pytest --apt-upgrade doit --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=pytest/8.1.2-1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos01-ppc64el-12.secgroup --name adt-oracular-ppc64el-doit-20240505-175135-juju-7f2275-prod-proposed-migration-environment-2-e90a1724-3082-49f3-8ef0-a0c34d54ebbc --image adt/ubuntu-oracular-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -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://us.ports.ubuntu.com/ubuntu-ports/ 362s autopkgtest [17:57:37]: testbed dpkg architecture: ppc64el 362s autopkgtest [17:57:37]: testbed apt version: 2.7.14build2 362s autopkgtest [17:57:37]: @@@@@@@@@@@@@@@@@@@@ test bed setup 363s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [64.7 kB] 364s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [2800 B] 364s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [1651 kB] 364s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [23.5 kB] 364s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [108 kB] 364s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [180 kB] 364s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1260 B] 364s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [1279 kB] 364s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [22.6 kB] 365s Fetched 3332 kB in 2s (1760 kB/s) 365s Reading package lists... 368s Reading package lists... 369s Building dependency tree... 369s Reading state information... 369s Calculating upgrade... 369s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 369s Reading package lists... 369s Building dependency tree... 369s Reading state information... 370s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 370s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 370s Get:2 http://ftpmaster.internal/ubuntu oracular InRelease [64.6 kB] 370s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 370s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 370s Get:5 http://ftpmaster.internal/ubuntu oracular/universe Sources [19.8 MB] 372s Get:6 http://ftpmaster.internal/ubuntu oracular/universe ppc64el Packages [15.0 MB] 378s Fetched 34.9 MB in 8s (4352 kB/s) 379s Reading package lists... 379s Reading package lists... 380s Building dependency tree... 380s Reading state information... 380s Calculating upgrade... 380s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 380s Reading package lists... 380s Building dependency tree... 380s Reading state information... 380s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 384s autopkgtest [17:57:59]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP Sat Apr 20 00:05:55 UTC 2024 384s autopkgtest [17:57:59]: @@@@@@@@@@@@@@@@@@@@ apt-source doit 388s Get:1 http://ftpmaster.internal/ubuntu oracular/universe doit 0.36.0-2 (dsc) [2385 B] 388s Get:2 http://ftpmaster.internal/ubuntu oracular/universe doit 0.36.0-2 (tar) [1434 kB] 388s Get:3 http://ftpmaster.internal/ubuntu oracular/universe doit 0.36.0-2 (diff) [7240 B] 388s gpgv: Signature made Sun Feb 11 22:19:04 2024 UTC 388s gpgv: using RSA key 8F6DE104377F3B11E741748731F3144544A1741A 388s gpgv: issuer "tchet@debian.org" 388s gpgv: Can't check signature: No public key 388s dpkg-source: warning: cannot verify inline signature for ./doit_0.36.0-2.dsc: no acceptable signature found 389s autopkgtest [17:58:04]: testing package doit version 0.36.0-2 389s autopkgtest [17:58:04]: build not needed 390s autopkgtest [17:58:05]: test version: preparing testbed 391s Reading package lists... 392s Building dependency tree... 392s Reading state information... 392s Starting pkgProblemResolver with broken count: 0 392s Starting 2 pkgProblemResolver with broken count: 0 392s Done 392s The following additional packages will be installed: 392s fonts-font-awesome fonts-lato libjs-jquery libjs-sphinxdoc libjs-underscore 392s python-doit-doc python3-cloudpickle python3-coverage python3-doit 392s python3-importlib-metadata python3-iniconfig python3-more-itertools 392s python3-packaging python3-pip python3-pluggy python3-pyasyncore 392s python3-pyflakes python3-pyinotify python3-pytest python3-wheel python3-zipp 392s sphinx-rtd-theme-common 392s Suggested packages: 392s node-html5shiv python-coverage-doc python-pyinotify-doc 392s Recommended packages: 392s javascript-common build-essential python3-dev pyflakes3 392s The following NEW packages will be installed: 392s autopkgtest-satdep fonts-font-awesome fonts-lato libjs-jquery 392s libjs-sphinxdoc libjs-underscore python-doit-doc python3-cloudpickle 392s python3-coverage python3-doit python3-importlib-metadata python3-iniconfig 392s python3-more-itertools python3-packaging python3-pip python3-pluggy 392s python3-pyasyncore python3-pyflakes python3-pyinotify python3-pytest 392s python3-wheel python3-zipp sphinx-rtd-theme-common 392s 0 upgraded, 23 newly installed, 0 to remove and 0 not upgraded. 392s Need to get 8275 kB/8276 kB of archives. 392s After this operation, 30.2 MB of additional disk space will be used. 392s Get:1 /tmp/autopkgtest.AYSgTj/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [756 B] 392s Get:2 http://ftpmaster.internal/ubuntu oracular/main ppc64el fonts-lato all 2.015-1 [2781 kB] 394s Get:3 http://ftpmaster.internal/ubuntu oracular/main ppc64el fonts-font-awesome all 5.0.10+really4.7.0~dfsg-4.1 [516 kB] 394s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 394s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 394s Get:6 http://ftpmaster.internal/ubuntu oracular/main ppc64el libjs-sphinxdoc all 7.2.6-6 [149 kB] 394s Get:7 http://ftpmaster.internal/ubuntu oracular/main ppc64el sphinx-rtd-theme-common all 2.0.0+dfsg-1 [1012 kB] 394s Get:8 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python-doit-doc all 0.36.0-2 [1281 kB] 395s Get:9 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-cloudpickle all 3.0.0-2 [21.5 kB] 395s Get:10 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-coverage ppc64el 7.4.4+dfsg1-0ubuntu2 [149 kB] 395s Get:11 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-more-itertools all 10.2.0-1 [52.9 kB] 395s Get:12 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-zipp all 1.0.0-6 [6090 B] 395s Get:13 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-importlib-metadata all 4.12.0-1 [17.8 kB] 395s Get:14 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-pyasyncore all 1.0.2-2 [10.1 kB] 395s Get:15 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-pyinotify all 0.9.6-2ubuntu1 [25.0 kB] 395s Get:16 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-doit all 0.36.0-2 [70.3 kB] 395s Get:17 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-iniconfig all 1.1.1-2 [6024 B] 395s Get:18 http://ftpmaster.internal/ubuntu oracular/main ppc64el python3-packaging all 24.0-1 [41.1 kB] 395s Get:19 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-wheel all 0.42.0-2 [53.1 kB] 395s Get:20 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-pip all 24.0+dfsg-1ubuntu1 [1316 kB] 395s Get:21 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-pluggy all 1.4.0-1 [20.4 kB] 395s Get:22 http://ftpmaster.internal/ubuntu oracular/universe ppc64el python3-pyflakes all 3.2.0-1 [52.8 kB] 395s Get:23 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el python3-pytest all 8.1.2-1 [248 kB] 396s Fetched 8275 kB in 3s (2781 kB/s) 396s Selecting previously unselected package fonts-lato. 397s (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 ... 72141 files and directories currently installed.) 397s Preparing to unpack .../00-fonts-lato_2.015-1_all.deb ... 397s Unpacking fonts-lato (2.015-1) ... 397s Selecting previously unselected package fonts-font-awesome. 397s Preparing to unpack .../01-fonts-font-awesome_5.0.10+really4.7.0~dfsg-4.1_all.deb ... 397s Unpacking fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 397s Selecting previously unselected package libjs-jquery. 397s Preparing to unpack .../02-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 397s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 397s Selecting previously unselected package libjs-underscore. 397s Preparing to unpack .../03-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 397s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 398s Selecting previously unselected package libjs-sphinxdoc. 398s Preparing to unpack .../04-libjs-sphinxdoc_7.2.6-6_all.deb ... 398s Unpacking libjs-sphinxdoc (7.2.6-6) ... 398s Selecting previously unselected package sphinx-rtd-theme-common. 398s Preparing to unpack .../05-sphinx-rtd-theme-common_2.0.0+dfsg-1_all.deb ... 398s Unpacking sphinx-rtd-theme-common (2.0.0+dfsg-1) ... 398s Selecting previously unselected package python-doit-doc. 398s Preparing to unpack .../06-python-doit-doc_0.36.0-2_all.deb ... 398s Unpacking python-doit-doc (0.36.0-2) ... 398s Selecting previously unselected package python3-cloudpickle. 398s Preparing to unpack .../07-python3-cloudpickle_3.0.0-2_all.deb ... 398s Unpacking python3-cloudpickle (3.0.0-2) ... 398s Selecting previously unselected package python3-coverage. 398s Preparing to unpack .../08-python3-coverage_7.4.4+dfsg1-0ubuntu2_ppc64el.deb ... 398s Unpacking python3-coverage (7.4.4+dfsg1-0ubuntu2) ... 398s Selecting previously unselected package python3-more-itertools. 398s Preparing to unpack .../09-python3-more-itertools_10.2.0-1_all.deb ... 398s Unpacking python3-more-itertools (10.2.0-1) ... 398s Selecting previously unselected package python3-zipp. 398s Preparing to unpack .../10-python3-zipp_1.0.0-6_all.deb ... 398s Unpacking python3-zipp (1.0.0-6) ... 398s Selecting previously unselected package python3-importlib-metadata. 398s Preparing to unpack .../11-python3-importlib-metadata_4.12.0-1_all.deb ... 398s Unpacking python3-importlib-metadata (4.12.0-1) ... 398s Selecting previously unselected package python3-pyasyncore. 398s Preparing to unpack .../12-python3-pyasyncore_1.0.2-2_all.deb ... 398s Unpacking python3-pyasyncore (1.0.2-2) ... 398s Selecting previously unselected package python3-pyinotify. 398s Preparing to unpack .../13-python3-pyinotify_0.9.6-2ubuntu1_all.deb ... 398s Unpacking python3-pyinotify (0.9.6-2ubuntu1) ... 398s Selecting previously unselected package python3-doit. 398s Preparing to unpack .../14-python3-doit_0.36.0-2_all.deb ... 398s Unpacking python3-doit (0.36.0-2) ... 398s Selecting previously unselected package python3-iniconfig. 398s Preparing to unpack .../15-python3-iniconfig_1.1.1-2_all.deb ... 398s Unpacking python3-iniconfig (1.1.1-2) ... 398s Selecting previously unselected package python3-packaging. 398s Preparing to unpack .../16-python3-packaging_24.0-1_all.deb ... 398s Unpacking python3-packaging (24.0-1) ... 398s Selecting previously unselected package python3-wheel. 398s Preparing to unpack .../17-python3-wheel_0.42.0-2_all.deb ... 398s Unpacking python3-wheel (0.42.0-2) ... 398s Selecting previously unselected package python3-pip. 398s Preparing to unpack .../18-python3-pip_24.0+dfsg-1ubuntu1_all.deb ... 398s Unpacking python3-pip (24.0+dfsg-1ubuntu1) ... 398s Selecting previously unselected package python3-pluggy. 398s Preparing to unpack .../19-python3-pluggy_1.4.0-1_all.deb ... 398s Unpacking python3-pluggy (1.4.0-1) ... 398s Selecting previously unselected package python3-pyflakes. 398s Preparing to unpack .../20-python3-pyflakes_3.2.0-1_all.deb ... 398s Unpacking python3-pyflakes (3.2.0-1) ... 398s Selecting previously unselected package python3-pytest. 398s Preparing to unpack .../21-python3-pytest_8.1.2-1_all.deb ... 398s Unpacking python3-pytest (8.1.2-1) ... 399s Selecting previously unselected package autopkgtest-satdep. 399s Preparing to unpack .../22-1-autopkgtest-satdep.deb ... 399s Unpacking autopkgtest-satdep (0) ... 399s Setting up python3-more-itertools (10.2.0-1) ... 399s Setting up python3-iniconfig (1.1.1-2) ... 399s Setting up fonts-lato (2.015-1) ... 399s Setting up python3-pyflakes (3.2.0-1) ... 399s Setting up python3-coverage (7.4.4+dfsg1-0ubuntu2) ... 400s Setting up python3-zipp (1.0.0-6) ... 400s Setting up python3-wheel (0.42.0-2) ... 400s Setting up python3-cloudpickle (3.0.0-2) ... 400s Setting up python3-packaging (24.0-1) ... 401s Setting up python3-pip (24.0+dfsg-1ubuntu1) ... 402s Setting up python3-pluggy (1.4.0-1) ... 403s Setting up python3-pyasyncore (1.0.2-2) ... 403s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 403s Setting up fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 403s Setting up sphinx-rtd-theme-common (2.0.0+dfsg-1) ... 403s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 403s Setting up python3-importlib-metadata (4.12.0-1) ... 403s Setting up python3-pytest (8.1.2-1) ... 403s Setting up python3-pyinotify (0.9.6-2ubuntu1) ... 404s Setting up libjs-sphinxdoc (7.2.6-6) ... 404s Setting up python-doit-doc (0.36.0-2) ... 404s Setting up python3-doit (0.36.0-2) ... 404s Setting up autopkgtest-satdep (0) ... 404s Processing triggers for man-db (2.12.0-4build2) ... 409s (Reading database ... 73623 files and directories currently installed.) 409s Removing autopkgtest-satdep (0) ... 410s autopkgtest [17:58:25]: test version: [----------------------- 411s 0.36.0 411s lib @ /usr/lib/python3/dist-packages/doit 411s autopkgtest [17:58:26]: test version: -----------------------] 411s autopkgtest [17:58:26]: test version: - - - - - - - - - - results - - - - - - - - - - 411s version PASS (superficial) 412s autopkgtest [17:58:27]: test command1: preparing testbed 413s Reading package lists... 414s Building dependency tree... 414s Reading state information... 414s Starting pkgProblemResolver with broken count: 0 414s Starting 2 pkgProblemResolver with broken count: 0 414s Done 415s The following NEW packages will be installed: 415s autopkgtest-satdep 415s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 415s Need to get 0 B/756 B of archives. 415s After this operation, 0 B of additional disk space will be used. 415s Get:1 /tmp/autopkgtest.AYSgTj/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [756 B] 415s Selecting previously unselected package autopkgtest-satdep. 415s (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 ... 73623 files and directories currently installed.) 415s Preparing to unpack .../2-autopkgtest-satdep.deb ... 415s Unpacking autopkgtest-satdep (0) ... 415s Setting up autopkgtest-satdep (0) ... 418s (Reading database ... 73623 files and directories currently installed.) 418s Removing autopkgtest-satdep (0) ... 419s autopkgtest [17:58:34]: test command1: pytest-3 -k "not (test_execute or test_dep or test_target)" 419s autopkgtest [17:58:34]: test command1: [----------------------- 421s ============================= test session starts ============================== 421s platform linux -- Python 3.12.3, pytest-8.1.2, pluggy-1.4.0 421s rootdir: /tmp/autopkgtest.AYSgTj/build.wbq/src 421s collected 794 items / 183 deselected / 611 selected 421s 421s tests/test___init__.py . [ 0%] 422s tests/test_action.py ................................................... [ 8%] 422s ................................................. [ 16%] 422s tests/test_api.py .... [ 17%] 422s tests/test_cmd_base.py ......................... [ 21%] 422s tests/test_cmd_clean.py ............ [ 23%] 423s tests/test_cmd_completion.py ........ [ 24%] 423s tests/test_cmd_dumpdb.py . [ 24%] 423s tests/test_cmd_forget.py ........ [ 26%] 423s tests/test_cmd_help.py ........ [ 27%] 423s tests/test_cmd_ignore.py ..... [ 28%] 423s tests/test_cmd_info.py .... [ 28%] 424s tests/test_cmd_list.py ................. [ 31%] 424s tests/test_cmd_resetdep.py ........ [ 32%] 424s tests/test_cmd_run.py .............. [ 35%] 424s tests/test_cmd_strace.py .... [ 35%] 424s tests/test_cmdparse.py ........................................ [ 42%] 424s tests/test_control.py .................................................. [ 50%] 425s ........ [ 51%] 425s tests/test_doit_cmd.py ................... [ 54%] 425s tests/test_exceptions.py ......... [ 56%] 425s tests/test_loader.py ................................................... [ 64%] 425s .... [ 65%] 425s tests/test_plugin.py ......... [ 66%] 425s tests/test_reporter.py .......................... [ 71%] 426s tests/test_runner.py ................................................... [ 79%] 426s ....................... [ 83%] 427s tests/test_task.py ..................................................... [ 91%] 427s ..................... [ 95%] 427s tests/test_tools.py ............................ [100%] 427s 427s =============================== warnings summary =============================== 427s tests/test_cmd_run.py: 1 warning 427s tests/test_runner.py: 12 warnings 427s /usr/lib/python3.12/multiprocessing/popen_fork.py:66: DeprecationWarning: This process (pid=2469) is multi-threaded, use of fork() may lead to deadlocks in the child. 427s self.pid = os.fork() 427s 427s tests/test_reporter.py::TestTaskResult::test 427s tests/test_reporter.py::TestJsonReporter::test_normal 427s tests/test_reporter.py::TestJsonReporter::test_normal 427s tests/test_reporter.py::TestJsonReporter::test_cleanup_error 427s tests/test_reporter.py::TestJsonReporter::test_runtime_error 427s tests/test_reporter.py::TestJsonReporter::test_ignore_stdout 427s /tmp/autopkgtest.AYSgTj/build.wbq/src/doit/reporter.py:192: DeprecationWarning: datetime.datetime.utcfromtimestamp() is deprecated and scheduled for removal in a future version. Use timezone-aware objects to represent datetimes in UTC: datetime.datetime.fromtimestamp(timestamp, datetime.UTC). 427s started = datetime.datetime.utcfromtimestamp(self._started_on) 427s 427s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 427s =============== 611 passed, 183 deselected, 19 warnings in 7.30s =============== 427s autopkgtest [17:58:42]: test command1: -----------------------] 428s command1 PASS 428s autopkgtest [17:58:43]: test command1: - - - - - - - - - - results - - - - - - - - - - 428s autopkgtest [17:58:43]: @@@@@@@@@@@@@@@@@@@@ summary 428s version PASS (superficial) 428s command1 PASS 461s Creating nova instance adt-oracular-ppc64el-doit-20240505-175135-juju-7f2275-prod-proposed-migration-environment-2-e90a1724-3082-49f3-8ef0-a0c34d54ebbc from image adt/ubuntu-oracular-ppc64el-server-20240505.img (UUID 5f2b29ba-0f78-4fea-bb4b-40e2e923a051)...