0s autopkgtest [14:44:49]: starting date and time: 2024-03-22 14:44:49+0000 0s autopkgtest [14:44:49]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [14:44:49]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8kpg51tk/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed=src:sphinx --apt-upgrade python-multipledispatch --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=sphinx/7.2.6-6 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos02-s390x-17.secgroup --name adt-noble-s390x-python-multipledispatch-20240322-144449-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-s390x-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,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 125s autopkgtest [14:46:54]: testbed dpkg architecture: s390x 125s autopkgtest [14:46:54]: testbed apt version: 2.7.12 125s autopkgtest [14:46:54]: @@@@@@@@@@@@@@@@@@@@ test bed setup 126s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 127s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3759 kB] 131s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [497 kB] 132s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 132s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [54.0 kB] 132s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main s390x Packages [665 kB] 133s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main s390x c-n-f Metadata [3032 B] 133s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x Packages [1372 B] 133s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x c-n-f Metadata [116 B] 133s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x Packages [3995 kB] 136s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x c-n-f Metadata [7292 B] 136s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x Packages [45.1 kB] 136s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x c-n-f Metadata [116 B] 138s Fetched 9150 kB in 11s (839 kB/s) 138s Reading package lists... 141s Reading package lists... 141s Building dependency tree... 141s Reading state information... 142s Calculating upgrade... 142s The following packages will be upgraded: 142s cloud-init debianutils fonts-ubuntu-console python3-markupsafe 142s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 142s Need to get 719 kB of archives. 142s After this operation, 11.3 kB disk space will be freed. 142s Get:1 http://ftpmaster.internal/ubuntu noble/main s390x debianutils s390x 5.17 [90.1 kB] 142s Get:2 http://ftpmaster.internal/ubuntu noble/main s390x fonts-ubuntu-console all 0.869+git20240321-0ubuntu1 [18.7 kB] 142s Get:3 http://ftpmaster.internal/ubuntu noble/main s390x python3-markupsafe s390x 2.1.5-1build1 [12.8 kB] 142s Get:4 http://ftpmaster.internal/ubuntu noble/main s390x cloud-init all 24.1.2-0ubuntu1 [597 kB] 143s Preconfiguring packages ... 143s Fetched 719 kB in 1s (803 kB/s) 143s (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 ... 52171 files and directories currently installed.) 143s Preparing to unpack .../debianutils_5.17_s390x.deb ... 143s Unpacking debianutils (5.17) over (5.16) ... 143s Setting up debianutils (5.17) ... 143s (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 ... 52171 files and directories currently installed.) 143s Preparing to unpack .../fonts-ubuntu-console_0.869+git20240321-0ubuntu1_all.deb ... 143s Unpacking fonts-ubuntu-console (0.869+git20240321-0ubuntu1) over (0.869-0ubuntu1) ... 143s Preparing to unpack .../python3-markupsafe_2.1.5-1build1_s390x.deb ... 143s Unpacking python3-markupsafe (2.1.5-1build1) over (2.1.5-1) ... 144s Preparing to unpack .../cloud-init_24.1.2-0ubuntu1_all.deb ... 144s Unpacking cloud-init (24.1.2-0ubuntu1) over (24.1.1-0ubuntu1) ... 144s Setting up fonts-ubuntu-console (0.869+git20240321-0ubuntu1) ... 144s Setting up cloud-init (24.1.2-0ubuntu1) ... 145s Setting up python3-markupsafe (2.1.5-1build1) ... 145s Processing triggers for man-db (2.12.0-3) ... 146s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 147s Reading package lists... 147s Building dependency tree... 147s Reading state information... 147s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 148s Unknown architecture, assuming PC-style ttyS0 148s sh: Attempting to set up Debian/Ubuntu apt sources automatically 148s sh: Distribution appears to be Ubuntu 149s Reading package lists... 149s Building dependency tree... 149s Reading state information... 149s eatmydata is already the newest version (131-1). 149s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 149s Reading package lists... 149s Building dependency tree... 149s Reading state information... 149s dbus is already the newest version (1.14.10-4ubuntu1). 149s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 150s Reading package lists... 150s Building dependency tree... 150s Reading state information... 150s rng-tools-debian is already the newest version (2.4). 150s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 150s Reading package lists... 150s Building dependency tree... 150s Reading state information... 151s The following packages will be REMOVED: 151s cloud-init* python3-configobj* python3-debconf* 151s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 151s After this operation, 3256 kB disk space will be freed. 151s (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 ... 52170 files and directories currently installed.) 151s Removing cloud-init (24.1.2-0ubuntu1) ... 151s Removing python3-configobj (5.0.8-3) ... 151s Removing python3-debconf (1.5.86) ... 151s Processing triggers for man-db (2.12.0-3) ... 152s (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 ... 51781 files and directories currently installed.) 152s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 152s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 152s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 152s invoke-rc.d: policy-rc.d denied execution of try-restart. 153s Reading package lists... 153s Building dependency tree... 153s Reading state information... 153s linux-generic is already the newest version (6.8.0-11.11+1). 153s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 153s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 153s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 153s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 155s Reading package lists... 156s Reading package lists... 156s Building dependency tree... 156s Reading state information... 156s Calculating upgrade... 156s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 156s Reading package lists... 156s Building dependency tree... 156s Reading state information... 156s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 157s autopkgtest [14:47:26]: rebooting testbed after setup commands that affected boot 174s autopkgtest [14:47:43]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Tue Feb 13 23:45:46 UTC 2024 177s autopkgtest [14:47:46]: @@@@@@@@@@@@@@@@@@@@ apt-source python-multipledispatch 179s Get:1 http://ftpmaster.internal/ubuntu noble/universe python-multipledispatch 1.0.0-1 (dsc) [2425 B] 179s Get:2 http://ftpmaster.internal/ubuntu noble/universe python-multipledispatch 1.0.0-1 (tar) [24.2 kB] 179s Get:3 http://ftpmaster.internal/ubuntu noble/universe python-multipledispatch 1.0.0-1 (diff) [4036 B] 180s gpgv: Signature made Tue Aug 15 17:36:36 2023 UTC 180s gpgv: using RSA key 419F7E9A47C3AB9519F1B0A339953A37DE4EB36B 180s gpgv: Can't check signature: No public key 180s dpkg-source: warning: cannot verify inline signature for ./python-multipledispatch_1.0.0-1.dsc: no acceptable signature found 180s autopkgtest [14:47:49]: testing package python-multipledispatch version 1.0.0-1 180s autopkgtest [14:47:49]: build not needed 181s autopkgtest [14:47:50]: test command1: preparing testbed 183s Reading package lists... 183s Building dependency tree... 183s Reading state information... 183s Starting pkgProblemResolver with broken count: 0 183s Starting 2 pkgProblemResolver with broken count: 0 183s Done 184s The following additional packages will be installed: 184s python3-all python3-cpuinfo python3-iniconfig python3-multipledispatch 184s python3-packaging python3-pluggy python3-pytest python3-pytest-benchmark 184s Recommended packages: 184s python3-elasticsearch python3-freezegun python3-pygal 184s The following NEW packages will be installed: 184s autopkgtest-satdep python3-all python3-cpuinfo python3-iniconfig 184s python3-multipledispatch python3-packaging python3-pluggy python3-pytest 184s python3-pytest-benchmark 184s 0 upgraded, 9 newly installed, 0 to remove and 0 not upgraded. 184s Need to get 448 kB/449 kB of archives. 184s After this operation, 1885 kB of additional disk space will be used. 184s Get:1 /tmp/autopkgtest.Hhn6z6/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [736 B] 184s Get:2 http://ftpmaster.internal/ubuntu noble/main s390x python3-all s390x 3.12.1-0ubuntu2 [908 B] 184s Get:3 http://ftpmaster.internal/ubuntu noble/universe s390x python3-cpuinfo all 9.0.0-1 [21.2 kB] 184s Get:4 http://ftpmaster.internal/ubuntu noble/universe s390x python3-iniconfig all 1.1.1-2 [6024 B] 184s Get:5 http://ftpmaster.internal/ubuntu noble/universe s390x python3-multipledispatch all 1.0.0-1 [15.8 kB] 184s Get:6 http://ftpmaster.internal/ubuntu noble/main s390x python3-packaging all 23.2-1 [40.6 kB] 184s Get:7 http://ftpmaster.internal/ubuntu noble/universe s390x python3-pluggy all 1.4.0-1 [20.4 kB] 184s Get:8 http://ftpmaster.internal/ubuntu noble/universe s390x python3-pytest all 7.4.4-1 [305 kB] 184s Get:9 http://ftpmaster.internal/ubuntu noble/universe s390x python3-pytest-benchmark all 4.0.0-3 [38.2 kB] 185s Fetched 448 kB in 1s (685 kB/s) 185s Selecting previously unselected package python3-all. 185s (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 ... 51726 files and directories currently installed.) 185s Preparing to unpack .../0-python3-all_3.12.1-0ubuntu2_s390x.deb ... 185s Unpacking python3-all (3.12.1-0ubuntu2) ... 185s Selecting previously unselected package python3-cpuinfo. 185s Preparing to unpack .../1-python3-cpuinfo_9.0.0-1_all.deb ... 185s Unpacking python3-cpuinfo (9.0.0-1) ... 185s Selecting previously unselected package python3-iniconfig. 185s Preparing to unpack .../2-python3-iniconfig_1.1.1-2_all.deb ... 185s Unpacking python3-iniconfig (1.1.1-2) ... 185s Selecting previously unselected package python3-multipledispatch. 185s Preparing to unpack .../3-python3-multipledispatch_1.0.0-1_all.deb ... 185s Unpacking python3-multipledispatch (1.0.0-1) ... 185s Selecting previously unselected package python3-packaging. 185s Preparing to unpack .../4-python3-packaging_23.2-1_all.deb ... 185s Unpacking python3-packaging (23.2-1) ... 185s Selecting previously unselected package python3-pluggy. 185s Preparing to unpack .../5-python3-pluggy_1.4.0-1_all.deb ... 185s Unpacking python3-pluggy (1.4.0-1) ... 185s Selecting previously unselected package python3-pytest. 185s Preparing to unpack .../6-python3-pytest_7.4.4-1_all.deb ... 185s Unpacking python3-pytest (7.4.4-1) ... 185s Selecting previously unselected package python3-pytest-benchmark. 185s Preparing to unpack .../7-python3-pytest-benchmark_4.0.0-3_all.deb ... 185s Unpacking python3-pytest-benchmark (4.0.0-3) ... 185s Selecting previously unselected package autopkgtest-satdep. 185s Preparing to unpack .../8-1-autopkgtest-satdep.deb ... 185s Unpacking autopkgtest-satdep (0) ... 185s Setting up python3-iniconfig (1.1.1-2) ... 185s Setting up python3-multipledispatch (1.0.0-1) ... 186s Setting up python3-all (3.12.1-0ubuntu2) ... 186s Setting up python3-packaging (23.2-1) ... 186s Setting up python3-cpuinfo (9.0.0-1) ... 186s Setting up python3-pluggy (1.4.0-1) ... 187s Setting up python3-pytest (7.4.4-1) ... 187s Setting up python3-pytest-benchmark (4.0.0-3) ... 187s Setting up autopkgtest-satdep (0) ... 187s Processing triggers for man-db (2.12.0-3) ... 189s (Reading database ... 51955 files and directories currently installed.) 189s Removing autopkgtest-satdep (0) ... 190s autopkgtest [14:47:59]: test command1: set -e ; for py in $(py3versions -r 2>/dev/null) ; do echo "Testing with $py:" ; $py -m pytest ; done 190s autopkgtest [14:47:59]: test command1: [----------------------- 190s Testing with python3.12: 190s ============================= test session starts ============================== 190s platform linux -- Python 3.12.2, pytest-7.4.4, pluggy-1.4.0 190s benchmark: 4.0.0 (defaults: timer=time.perf_counter disable_gc=False min_rounds=5 min_time=0.000005 max_time=1.0 calibration_precision=10 warmup=False warmup_iterations=100000) 190s rootdir: /tmp/autopkgtest.Hhn6z6/build.b1e/src 190s plugins: benchmark-4.0.0 190s collected 63 items 190s 190s bench/test_simple.py . [ 1%] 193s multipledispatch/tests/test_benchmark.py .... [ 7%] 193s multipledispatch/tests/test_conflict.py ......... [ 22%] 194s multipledispatch/tests/test_core.py ............ [ 41%] 194s multipledispatch/tests/test_dispatcher.py ............................ [ 85%] 194s multipledispatch/tests/test_dispatcher_3only.py ...... [ 95%] 194s multipledispatch/tests/test_variadic.py ... [100%] 194s 194s =============================== warnings summary =============================== 194s multipledispatch/tests/test_core.py::test_multipledispatch 194s multipledispatch/tests/test_core.py:31: PytestBenchmarkWarning: Benchmark fixture was not used at all in this test! 194s def test_multipledispatch(benchmark): 194s 194s multipledispatch/tests/test_core.py::test_caching_correct_behavior 194s multipledispatch/tests/test_core.py::test_methods_multiple_dispatch 194s /tmp/autopkgtest.Hhn6z6/build.b1e/src/multipledispatch/dispatcher.py:27: AmbiguityWarning: 194s Ambiguities exist in dispatched function f 194s 194s The following signatures may result in ambiguous behavior: 194s [C, A], [A, C] 194s 194s 194s Consider making the following additions: 194s 194s @dispatch(C, C) 194s def f(...) 194s warn(warning_text(dispatcher.name, ambiguities), AmbiguityWarning) 194s 194s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 194s 194s ------------------------------------------------------------------------------------------------------------------ benchmark: 4 tests ----------------------------------------------------------------------------------------------------------------- 194s Name (time in ns) Min Max Mean StdDev Median IQR Outliers OPS (Kops/s) Rounds Iterations 194s ------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------- 194s test_benchmark_call_single_dispatch[a] 395.3333 (1.0) 577,916.1667 (3.07) 528.3594 (1.0) 1,706.2664 (1.17) 438.7500 (1.0) 45.7500 (1.0) 927;35853 1,892.6512 (1.0) 189215 12 194s test_benchmark_call_single_dispatch[1] 484.0000 (1.22) 188,417.0000 (1.0) 639.2182 (1.21) 1,464.4052 (1.0) 537.0000 (1.22) 131.0000 (2.86) 199;5325 1,564.4111 (0.83) 77985 1 194s test_benchmark_call_multiple_dispatch[val0] 510.0000 (1.29) 386,563.0000 (2.05) 744.9182 (1.41) 2,547.1878 (1.74) 562.0000 (1.28) 159.0000 (3.48) 505;3267 1,342.4293 (0.71) 53848 1 194s test_benchmark_add_and_use_instance 161,629.0000 (408.84) 15,280,734.0000 (81.10) 232,457.3700 (439.96) 325,797.9875 (222.48) 180,782.5000 (412.04) 80,462.0000 (>1000.0) 52;160 4.3019 (0.00) 2824 1 194s ------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------- 194s 194s Legend: 194s Outliers: 1 Standard Deviation from Mean; 1.5 IQR (InterQuartile Range) from 1st Quartile and 3rd Quartile. 194s OPS: Operations Per Second, computed as 1 / Mean 194s ======================== 63 passed, 3 warnings in 4.15s ======================== 195s autopkgtest [14:48:04]: test command1: -----------------------] 195s autopkgtest [14:48:04]: test command1: - - - - - - - - - - results - - - - - - - - - - 195s command1 PASS 196s autopkgtest [14:48:05]: @@@@@@@@@@@@@@@@@@@@ summary 196s command1 PASS 208s Creating nova instance adt-noble-s390x-python-multipledispatch-20240322-144449-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-s390x-server-20240321.img (UUID f7ee8f0f-480f-4014-94f0-3be2a19e259d)...