0s autopkgtest [18:31:08]: starting date and time: 2024-11-13 18:31:08+0000 0s autopkgtest [18:31:08]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [18:31:08]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.7klcqjfo/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python-psutil --apt-upgrade pystemd --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=python-psutil/5.9.8-2build3 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-8.secgroup --name adt-plucky-s390x-pystemd-20241113-183108-juju-7f2275-prod-proposed-migration-environment-2-585d1c26-b7a9-4324-962f-8f7f8e5a56c2 --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --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/ 113s autopkgtest [18:33:01]: testbed dpkg architecture: s390x 113s autopkgtest [18:33:01]: testbed apt version: 2.9.8 113s autopkgtest [18:33:01]: @@@@@@@@@@@@@@@@@@@@ test bed setup 114s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 114s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [971 kB] 115s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 115s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [104 kB] 115s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [17.2 kB] 115s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [112 kB] 115s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [646 kB] 115s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [17.8 kB] 115s Fetched 1949 kB in 1s (2406 kB/s) 115s Reading package lists... 117s Reading package lists... 117s Building dependency tree... 117s Reading state information... 117s Calculating upgrade... 117s The following packages will be upgraded: 117s libgnutls30t64 libgpgme11t64 libjson-glib-1.0-0 libjson-glib-1.0-common 117s libutempter0 117s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 117s Need to get 1184 kB of archives. 117s After this operation, 3072 B of additional disk space will be used. 117s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libgnutls30t64 s390x 3.8.8-2ubuntu1 [950 kB] 118s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libgpgme11t64 s390x 1.23.2-5ubuntu4 [151 kB] 118s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-glib-1.0-common all 1.10.0+ds-3 [5586 B] 118s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-glib-1.0-0 s390x 1.10.0+ds-3 [67.5 kB] 118s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libutempter0 s390x 1.2.1-4 [9708 B] 118s Fetched 1184 kB in 1s (1909 kB/s) 118s (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 ... 55510 files and directories currently installed.) 118s Preparing to unpack .../libgnutls30t64_3.8.8-2ubuntu1_s390x.deb ... 118s Unpacking libgnutls30t64:s390x (3.8.8-2ubuntu1) over (3.8.6-2ubuntu1) ... 118s Setting up libgnutls30t64:s390x (3.8.8-2ubuntu1) ... 118s (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 ... 55510 files and directories currently installed.) 118s Preparing to unpack .../libgpgme11t64_1.23.2-5ubuntu4_s390x.deb ... 118s Unpacking libgpgme11t64:s390x (1.23.2-5ubuntu4) over (1.18.0-4.1ubuntu4) ... 118s Preparing to unpack .../libjson-glib-1.0-common_1.10.0+ds-3_all.deb ... 118s Unpacking libjson-glib-1.0-common (1.10.0+ds-3) over (1.10.0+ds-2) ... 118s Preparing to unpack .../libjson-glib-1.0-0_1.10.0+ds-3_s390x.deb ... 118s Unpacking libjson-glib-1.0-0:s390x (1.10.0+ds-3) over (1.10.0+ds-2) ... 118s Preparing to unpack .../libutempter0_1.2.1-4_s390x.deb ... 118s Unpacking libutempter0:s390x (1.2.1-4) over (1.2.1-3build1) ... 118s Setting up libutempter0:s390x (1.2.1-4) ... 118s Setting up libjson-glib-1.0-common (1.10.0+ds-3) ... 118s Setting up libgpgme11t64:s390x (1.23.2-5ubuntu4) ... 118s Setting up libjson-glib-1.0-0:s390x (1.10.0+ds-3) ... 118s Processing triggers for libc-bin (2.40-1ubuntu3) ... 119s Reading package lists... 119s Building dependency tree... 119s Reading state information... 119s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 119s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 119s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 119s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 119s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 120s Reading package lists... 120s Reading package lists... 120s Building dependency tree... 120s Reading state information... 120s Calculating upgrade... 121s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 121s Reading package lists... 121s Building dependency tree... 121s Reading state information... 121s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 124s autopkgtest [18:33:12]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 124s autopkgtest [18:33:12]: @@@@@@@@@@@@@@@@@@@@ apt-source pystemd 125s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pystemd 0.13.2-2 (dsc) [2172 B] 125s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pystemd 0.13.2-2 (tar) [308 kB] 125s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pystemd 0.13.2-2 (diff) [3268 B] 125s gpgv: Signature made Wed Mar 27 14:34:41 2024 UTC 125s gpgv: using RSA key 8F6DE104377F3B11E741748731F3144544A1741A 125s gpgv: issuer "tchet@debian.org" 125s gpgv: Can't check signature: No public key 125s dpkg-source: warning: cannot verify inline signature for ./pystemd_0.13.2-2.dsc: no acceptable signature found 125s autopkgtest [18:33:13]: testing package pystemd version 0.13.2-2 126s autopkgtest [18:33:14]: build not needed 126s autopkgtest [18:33:14]: test upstream-unittests: preparing testbed 127s Reading package lists... 128s Building dependency tree... 128s Reading state information... 128s Starting pkgProblemResolver with broken count: 0 128s Starting 2 pkgProblemResolver with broken count: 0 128s Done 128s The following additional packages will be installed: 128s libxslt1.1 python3-all python3-lxml python3-psutil python3-pystemd 128s Suggested packages: 128s python-lxml-doc 128s Recommended packages: 128s python3-bs4 python3-cssselect python3-html5lib 128s The following NEW packages will be installed: 128s autopkgtest-satdep libxslt1.1 python3-all python3-lxml python3-psutil 128s python3-pystemd 128s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 128s Need to get 2004 kB/2005 kB of archives. 128s After this operation, 10.3 MB of additional disk space will be used. 128s Get:1 /tmp/autopkgtest.m5YmV3/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [720 B] 128s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libxslt1.1 s390x 1.1.39-0exp1ubuntu1 [169 kB] 128s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x python3-all s390x 3.12.6-0ubuntu1 [890 B] 128s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x python3-lxml s390x 5.3.0-1 [1314 kB] 129s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3-psutil s390x 5.9.8-2build3 [195 kB] 129s Get:6 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pystemd s390x 0.13.2-2 [325 kB] 129s Fetched 2004 kB in 1s (3260 kB/s) 129s Selecting previously unselected package libxslt1.1:s390x. 129s (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 ... 55510 files and directories currently installed.) 129s Preparing to unpack .../0-libxslt1.1_1.1.39-0exp1ubuntu1_s390x.deb ... 129s Unpacking libxslt1.1:s390x (1.1.39-0exp1ubuntu1) ... 129s Selecting previously unselected package python3-all. 129s Preparing to unpack .../1-python3-all_3.12.6-0ubuntu1_s390x.deb ... 129s Unpacking python3-all (3.12.6-0ubuntu1) ... 129s Selecting previously unselected package python3-lxml:s390x. 129s Preparing to unpack .../2-python3-lxml_5.3.0-1_s390x.deb ... 129s Unpacking python3-lxml:s390x (5.3.0-1) ... 129s Selecting previously unselected package python3-psutil. 129s Preparing to unpack .../3-python3-psutil_5.9.8-2build3_s390x.deb ... 129s Unpacking python3-psutil (5.9.8-2build3) ... 129s Selecting previously unselected package python3-pystemd. 129s Preparing to unpack .../4-python3-pystemd_0.13.2-2_s390x.deb ... 129s Unpacking python3-pystemd (0.13.2-2) ... 129s Selecting previously unselected package autopkgtest-satdep. 129s Preparing to unpack .../5-1-autopkgtest-satdep.deb ... 129s Unpacking autopkgtest-satdep (0) ... 129s Setting up python3-all (3.12.6-0ubuntu1) ... 129s Setting up python3-psutil (5.9.8-2build3) ... 129s Setting up libxslt1.1:s390x (1.1.39-0exp1ubuntu1) ... 129s Setting up python3-lxml:s390x (5.3.0-1) ... 129s Setting up python3-pystemd (0.13.2-2) ... 129s Setting up autopkgtest-satdep (0) ... 129s Processing triggers for libc-bin (2.40-1ubuntu3) ... 131s (Reading database ... 55774 files and directories currently installed.) 131s Removing autopkgtest-satdep (0) ... 132s autopkgtest [18:33:20]: test upstream-unittests: [----------------------- 132s test_context (test_base.TestContextManager.test_context) ... ok 132s test_find_in_object (test_base.TestGetItem.test_find_in_object) ... ok 132s test_find_method_in_interfaces (test_base.TestGetItem.test_find_method_in_interfaces) ... ok 132s test_find_property_in_interfaces (test_base.TestGetItem.test_find_property_in_interfaces) ... ok 132s test_set_load (test_base.TestLoad.test_set_load) ... ok 132s test_listen_fds_start (test_daemon.TestListen.test_listen_fds_start) ... ok 132s test_notify (test_daemon.TestListen.test_notify) ... ok 132s test_notify (test_daemon.TestNotify.test_notify) ... ok 132s test_compile_array_of_structs (test_dbus_arg_parsing.TestCompileArray.test_compile_array_of_structs) ... ok 132s test_compile_array_with_simple_arg (test_dbus_arg_parsing.TestCompileArray.test_compile_array_with_simple_arg) ... ok 132s test_compile_double_array (test_dbus_arg_parsing.TestCompileArray.test_compile_double_array) ... ok 132s test_compile_array (test_dbus_arg_parsing.TestCompileMainFunc.test_compile_array) ... ok 132s test_compile_little_complex_expr (test_dbus_arg_parsing.TestCompileMainFunc.test_compile_little_complex_expr) ... ok 132s test_compile_simplest (test_dbus_arg_parsing.TestCompileMainFunc.test_compile_simplest) ... ok 132s test_compile (test_dbus_arg_parsing.TestCompileSimple.test_compile) ... ok 132s test_result_of_compile (test_dbus_arg_parsing.TestCompileSimple.test_result_of_compile) ... ok 132s test_apply (test_dbus_arg_parsing.TestCompileStruct.test_apply) ... ok 132s test_compile (test_dbus_arg_parsing.TestCompileStruct.test_compile) ... ok 132s test_closure (test_dbus_arg_parsing.TestFindClosure.test_closure) ... ok 132s test_multi_closure (test_dbus_arg_parsing.TestFindClosure.test_multi_closure) ... ok 132s test_connecting_to_missing_socket_raises_file_not_found_error (test_dbuslib.TestDBusError.test_connecting_to_missing_socket_raises_file_not_found_error) ... ok 132s test_connecting_to_serverless_socket_raises_connection_refused_error (test_dbuslib.TestDBusError.test_connecting_to_serverless_socket_raises_connection_refused_error) ... ok 132s test_decode (test_dbuslib.TestEncode.test_decode) ... ok 132s test_encode (test_dbuslib.TestEncode.test_encode) ... ok 132s test_weird_decode (test_dbuslib.TestEncode.test_weird_decode) ... ok 132s test_weird_encode (test_dbuslib.TestEncode.test_weird_encode) ... ok 133s test_enter (test_futures.TestEnterUnit.test_enter) ... ok 133s test_run (test_futures.TestFuturesPool.test_run) ... ok 133s test_run (test_futures.TestFuturesRun.test_run) ... ok 133s test_pre_run (test_futures.TestTransientUnitProcess.test_pre_run) ... ok 133s test_msg (test_journal.TestJournalLog.test_msg) ... ok 133s test_sample (test_unit_signatures.TestArraySignature.test_sample) ... ok 133s test_convert_all (test_utils.TestContextToCharStar.test_convert_all) ... ok 133s test_convert_to_char (test_utils.TestContextToCharStar.test_convert_to_char) ... ok 133s test_pass_normal_vars (test_utils.TestContextToCharStar.test_pass_normal_vars) ... ok 133s test_array (test_utils.TestX2x2Cmdlist.test_array) ... ok 133s tests_bytes (test_utils.TestX2x2Cmdlist.tests_bytes) ... ok 133s tests_none (test_utils.TestX2x2Cmdlist.tests_none) ... ok 133s tests_strings (test_utils.TestX2x2Cmdlist.tests_strings) ... ok 133s 133s ---------------------------------------------------------------------- 133s Ran 39 tests in 0.177s 133s 133s OK 133s autopkgtest [18:33:21]: test upstream-unittests: -----------------------] 133s autopkgtest [18:33:21]: test upstream-unittests: - - - - - - - - - - results - - - - - - - - - - 133s upstream-unittests PASS 134s autopkgtest [18:33:22]: test pystemd-unit: preparing testbed 135s Reading package lists... 135s Building dependency tree... 135s Reading state information... 136s Starting pkgProblemResolver with broken count: 0 136s Starting 2 pkgProblemResolver with broken count: 0 136s Done 136s The following NEW packages will be installed: 136s autopkgtest-satdep 136s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 136s Need to get 0 B/728 B of archives. 136s After this operation, 0 B of additional disk space will be used. 136s Get:1 /tmp/autopkgtest.m5YmV3/2-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [728 B] 136s Selecting previously unselected package autopkgtest-satdep. 136s (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 ... 55774 files and directories currently installed.) 136s Preparing to unpack .../2-autopkgtest-satdep.deb ... 136s Unpacking autopkgtest-satdep (0) ... 136s Setting up autopkgtest-satdep (0) ... 138s (Reading database ... 55774 files and directories currently installed.) 138s Removing autopkgtest-satdep (0) ... 138s autopkgtest [18:33:26]: test pystemd-unit: [----------------------- 139s autopkgtest [18:33:27]: test pystemd-unit: -----------------------] 139s pystemd-unit PASS 139s autopkgtest [18:33:27]: test pystemd-unit: - - - - - - - - - - results - - - - - - - - - - 140s autopkgtest [18:33:28]: @@@@@@@@@@@@@@@@@@@@ summary 140s upstream-unittests PASS 140s pystemd-unit PASS 151s virt: nova [W] Using flock in prodstack6-s390x 151s virt: Creating nova instance adt-plucky-s390x-pystemd-20241113-183108-juju-7f2275-prod-proposed-migration-environment-2-585d1c26-b7a9-4324-962f-8f7f8e5a56c2 from image adt/ubuntu-plucky-s390x-server-20241113.img (UUID e740277e-1f72-40ae-bfbe-46030537c71c)...