1s autopkgtest [15:31:34]: starting date and time: 2024-03-22 15:31:34+0000 1s autopkgtest [15:31:34]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 1s autopkgtest [15:31:34]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.u3rk210d/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 pexpect --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-ppc64el-4.secgroup --name adt-noble-ppc64el-pexpect-20240322-153132-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-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,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 449s autopkgtest [15:39:02]: testbed dpkg architecture: ppc64el 450s autopkgtest [15:39:03]: testbed apt version: 2.7.12 450s autopkgtest [15:39:03]: @@@@@@@@@@@@@@@@@@@@ test bed setup 450s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 451s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [497 kB] 451s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 451s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3807 kB] 452s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [54.0 kB] 452s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el Packages [670 kB] 453s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el c-n-f Metadata [3116 B] 453s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el Packages [1372 B] 453s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el c-n-f Metadata [116 B] 453s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el Packages [4100 kB] 454s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el c-n-f Metadata [8652 B] 454s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el Packages [58.3 kB] 454s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el c-n-f Metadata [116 B] 457s Fetched 9323 kB in 4s (2342 kB/s) 457s Reading package lists... 460s Reading package lists... 460s Building dependency tree... 460s Reading state information... 460s Calculating upgrade... 461s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 461s Reading package lists... 461s Building dependency tree... 461s Reading state information... 461s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 462s sh: Attempting to set up Debian/Ubuntu apt sources automatically 462s sh: Distribution appears to be Ubuntu 463s Reading package lists... 463s Building dependency tree... 463s Reading state information... 463s eatmydata is already the newest version (131-1). 463s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 463s Reading package lists... 463s Building dependency tree... 463s Reading state information... 463s dbus is already the newest version (1.14.10-4ubuntu1). 463s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 463s Reading package lists... 464s Building dependency tree... 464s Reading state information... 464s rng-tools-debian is already the newest version (2.4). 464s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 464s Reading package lists... 464s Building dependency tree... 464s Reading state information... 464s The following packages will be REMOVED: 464s cloud-init* python3-configobj* python3-debconf* 464s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 464s After this operation, 3256 kB disk space will be freed. 464s (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 ... 70156 files and directories currently installed.) 464s Removing cloud-init (24.1.2-0ubuntu1) ... 465s Removing python3-configobj (5.0.8-3) ... 465s Removing python3-debconf (1.5.86) ... 465s Processing triggers for man-db (2.12.0-3) ... 466s (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 ... 69767 files and directories currently installed.) 466s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 466s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 466s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 466s invoke-rc.d: policy-rc.d denied execution of try-restart. 466s Reading package lists... 467s Building dependency tree... 467s Reading state information... 467s linux-generic is already the newest version (6.8.0-11.11+1). 467s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 467s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 467s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 467s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 470s Reading package lists... 470s Reading package lists... 470s Building dependency tree... 470s Reading state information... 470s Calculating upgrade... 471s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 471s Reading package lists... 471s Building dependency tree... 471s Reading state information... 471s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 471s autopkgtest [15:39:24]: rebooting testbed after setup commands that affected boot 514s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 522s autopkgtest [15:40:15]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Wed Feb 14 00:33:03 UTC 2024 525s autopkgtest [15:40:18]: @@@@@@@@@@@@@@@@@@@@ apt-source pexpect 528s Get:1 http://ftpmaster.internal/ubuntu noble/main pexpect 4.9-2 (dsc) [2184 B] 528s Get:2 http://ftpmaster.internal/ubuntu noble/main pexpect 4.9-2 (tar) [170 kB] 528s Get:3 http://ftpmaster.internal/ubuntu noble/main pexpect 4.9-2 (diff) [7236 B] 528s gpgv: Signature made Thu Feb 15 15:06:06 2024 UTC 528s gpgv: using RSA key 25E3FF2D7F469DBE7D0D4E50AFCFEC8E669CE1C2 528s gpgv: Can't check signature: No public key 528s dpkg-source: warning: cannot verify inline signature for ./pexpect_4.9-2.dsc: no acceptable signature found 528s autopkgtest [15:40:21]: testing package pexpect version 4.9-2 528s autopkgtest [15:40:21]: build not needed 531s autopkgtest [15:40:24]: test pytest: preparing testbed 537s Reading package lists... 537s Building dependency tree... 537s Reading state information... 537s Starting pkgProblemResolver with broken count: 0 537s Starting 2 pkgProblemResolver with broken count: 0 537s Done 538s The following additional packages will be installed: 538s libjs-jquery libjs-sphinxdoc libjs-underscore python-pexpect-doc python3-all 538s python3-iniconfig python3-packaging python3-pexpect python3-pluggy 538s python3-ptyprocess python3-pytest 538s Recommended packages: 538s javascript-common 538s The following NEW packages will be installed: 538s autopkgtest-satdep libjs-jquery libjs-sphinxdoc libjs-underscore 538s python-pexpect-doc python3-all python3-iniconfig python3-packaging 538s python3-pexpect python3-pluggy python3-ptyprocess python3-pytest 538s 0 upgraded, 12 newly installed, 0 to remove and 0 not upgraded. 538s Need to get 1137 kB/1138 kB of archives. 538s After this operation, 4053 kB of additional disk space will be used. 538s Get:1 /tmp/autopkgtest.M5HmGB/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [736 B] 538s Get:2 http://ftpmaster.internal/ubuntu noble/main ppc64el libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 538s Get:3 http://ftpmaster.internal/ubuntu noble/main ppc64el libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 538s Get:4 http://ftpmaster.internal/ubuntu noble/main ppc64el libjs-sphinxdoc all 7.2.6-4 [149 kB] 538s Get:5 http://ftpmaster.internal/ubuntu noble/main ppc64el python-pexpect-doc all 4.9-2 [106 kB] 538s Get:6 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-all ppc64el 3.12.1-0ubuntu2 [904 B] 538s Get:7 http://ftpmaster.internal/ubuntu noble/universe ppc64el python3-iniconfig all 1.1.1-2 [6024 B] 538s Get:8 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-packaging all 23.2-1 [40.6 kB] 538s Get:9 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-ptyprocess all 0.7.0-5 [15.1 kB] 538s Get:10 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-pexpect all 4.9-2 [48.1 kB] 538s Get:11 http://ftpmaster.internal/ubuntu noble/universe ppc64el python3-pluggy all 1.4.0-1 [20.4 kB] 538s Get:12 http://ftpmaster.internal/ubuntu noble/universe ppc64el python3-pytest all 7.4.4-1 [305 kB] 539s Fetched 1137 kB in 1s (1752 kB/s) 539s Selecting previously unselected package libjs-jquery. 539s (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 ... 69712 files and directories currently installed.) 539s Preparing to unpack .../00-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 539s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 539s Selecting previously unselected package libjs-underscore. 539s Preparing to unpack .../01-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 539s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 539s Selecting previously unselected package libjs-sphinxdoc. 539s Preparing to unpack .../02-libjs-sphinxdoc_7.2.6-4_all.deb ... 539s Unpacking libjs-sphinxdoc (7.2.6-4) ... 539s Selecting previously unselected package python-pexpect-doc. 539s Preparing to unpack .../03-python-pexpect-doc_4.9-2_all.deb ... 539s Unpacking python-pexpect-doc (4.9-2) ... 539s Selecting previously unselected package python3-all. 539s Preparing to unpack .../04-python3-all_3.12.1-0ubuntu2_ppc64el.deb ... 539s Unpacking python3-all (3.12.1-0ubuntu2) ... 539s Selecting previously unselected package python3-iniconfig. 539s Preparing to unpack .../05-python3-iniconfig_1.1.1-2_all.deb ... 539s Unpacking python3-iniconfig (1.1.1-2) ... 539s Selecting previously unselected package python3-packaging. 539s Preparing to unpack .../06-python3-packaging_23.2-1_all.deb ... 539s Unpacking python3-packaging (23.2-1) ... 539s Selecting previously unselected package python3-ptyprocess. 539s Preparing to unpack .../07-python3-ptyprocess_0.7.0-5_all.deb ... 539s Unpacking python3-ptyprocess (0.7.0-5) ... 539s Selecting previously unselected package python3-pexpect. 539s Preparing to unpack .../08-python3-pexpect_4.9-2_all.deb ... 539s Unpacking python3-pexpect (4.9-2) ... 539s Selecting previously unselected package python3-pluggy. 539s Preparing to unpack .../09-python3-pluggy_1.4.0-1_all.deb ... 539s Unpacking python3-pluggy (1.4.0-1) ... 539s Selecting previously unselected package python3-pytest. 539s Preparing to unpack .../10-python3-pytest_7.4.4-1_all.deb ... 539s Unpacking python3-pytest (7.4.4-1) ... 539s Selecting previously unselected package autopkgtest-satdep. 539s Preparing to unpack .../11-1-autopkgtest-satdep.deb ... 539s Unpacking autopkgtest-satdep (0) ... 539s Setting up python3-iniconfig (1.1.1-2) ... 539s Setting up python3-all (3.12.1-0ubuntu2) ... 539s Setting up python3-packaging (23.2-1) ... 539s Setting up python3-pluggy (1.4.0-1) ... 539s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 539s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 539s Setting up python3-ptyprocess (0.7.0-5) ... 539s Setting up python3-pytest (7.4.4-1) ... 540s Setting up python3-pexpect (4.9-2) ... 540s Setting up libjs-sphinxdoc (7.2.6-4) ... 540s Setting up python-pexpect-doc (4.9-2) ... 540s Setting up autopkgtest-satdep (0) ... 540s Processing triggers for man-db (2.12.0-3) ... 543s (Reading database ... 70043 files and directories currently installed.) 543s Removing autopkgtest-satdep (0) ... 544s autopkgtest [15:40:37]: test pytest: [----------------------- 544s ============================= test session starts ============================== 544s platform linux -- Python 3.12.2, pytest-7.4.4, pluggy-1.4.0 -- /usr/bin/python3.12 544s cachedir: .pytest_cache 544s rootdir: /tmp/autopkgtest.M5HmGB/autopkgtest_tmp 545s collecting ... collected 257 items / 62 deselected / 195 selected 545s 545s tests/test_FSM.py::FSMTestCase::test_run_fsm PASSED [ 0%] 545s tests/test_ansi.py::ansiTestCase::test_decode_error PASSED [ 1%] 545s tests/test_ansi.py::ansiTestCase::test_fsm_memory PASSED [ 1%] 545s tests/test_ansi.py::ansiTestCase::test_lines PASSED [ 2%] 545s tests/test_ansi.py::ansiTestCase::test_number_x PASSED [ 2%] 545s tests/test_ansi.py::ansiTestCase::test_tetris PASSED [ 3%] 545s tests/test_ansi.py::ansiTestCase::test_torturet PASSED [ 3%] 545s tests/test_ansi.py::ansiTestCase::test_unicode PASSED [ 4%] 545s tests/test_ansi.py::ansiTestCase::test_utf8_bytes PASSED [ 4%] 545s tests/test_ansi.py::ansiTestCase::test_write PASSED [ 5%] 546s tests/test_async.py::AsyncTests::test_async_and_gc PASSED [ 5%] 546s tests/test_async.py::AsyncTests::test_async_and_sync PASSED [ 6%] 546s tests/test_async.py::AsyncTests::test_async_utf8 PASSED [ 6%] 546s tests/test_async.py::AsyncTests::test_eof PASSED [ 7%] 547s tests/test_async.py::AsyncTests::test_expect_exact PASSED [ 7%] 547s tests/test_async.py::AsyncTests::test_simple_expect PASSED [ 8%] 549s tests/test_async.py::AsyncTests::test_timeout PASSED [ 8%] 549s tests/test_command_list_split.py::SplitCommandLineTestCase::testSplitSizes PASSED [ 9%] 549s tests/test_constructor.py::TestCaseConstructor::test_constructor PASSED [ 9%] 549s tests/test_constructor.py::TestCaseConstructor::test_named_parameters PASSED [ 10%] 549s tests/test_ctrl_chars.py::TestCtrlChars::test_bad_sendcontrol_chars PASSED [ 10%] 563s tests/test_ctrl_chars.py::TestCtrlChars::test_control_chars PASSED [ 11%] 563s tests/test_ctrl_chars.py::TestCtrlChars::test_sendcontrol PASSED [ 11%] 563s tests/test_ctrl_chars.py::TestCtrlChars::test_sendeof PASSED [ 12%] 563s tests/test_ctrl_chars.py::TestCtrlChars::test_sendintr PASSED [ 12%] 564s tests/test_delay.py::TestCaseDelay::test_delayafterread PASSED [ 13%] 565s tests/test_delay.py::TestCaseDelay::test_delaybeforesend PASSED [ 13%] 576s tests/test_destructor.py::TestCaseDestructor::test_destructor PASSED [ 14%] 576s tests/test_dotall.py::TestCaseDotall::test_dotall PASSED [ 14%] 576s tests/test_dotall.py::TestCaseDotall::test_precompiled PASSED [ 15%] 576s tests/test_env.py::TestCaseEnv::test_run_uses_env PASSED [ 15%] 576s tests/test_env.py::TestCaseEnv::test_run_uses_env_path PASSED [ 16%] 576s tests/test_env.py::TestCaseEnv::test_run_uses_env_path_over_path PASSED [ 16%] 576s tests/test_expect.py::ExpectTestCase::test_bad_arg PASSED [ 17%] 576s tests/test_expect.py::ExpectTestCase::test_before_after PASSED [ 17%] 576s tests/test_expect.py::ExpectTestCase::test_before_after_exact PASSED [ 18%] 582s tests/test_expect.py::ExpectTestCase::test_before_after_timeout PASSED [ 18%] 582s tests/test_expect.py::ExpectTestCase::test_buffer_interface PASSED [ 19%] 582s tests/test_expect.py::ExpectTestCase::test_coerce_expect_re_enc_ascii PASSED [ 20%] 582s tests/test_expect.py::ExpectTestCase::test_coerce_expect_re_enc_none PASSED [ 20%] 583s tests/test_expect.py::ExpectTestCase::test_coerce_expect_re_enc_utf8 PASSED [ 21%] 583s tests/test_expect.py::ExpectTestCase::test_expect PASSED [ 21%] 583s tests/test_expect.py::ExpectTestCase::test_expect_basic PASSED [ 22%] 583s tests/test_expect.py::ExpectTestCase::test_expect_echo PASSED [ 22%] 583s tests/test_expect.py::ExpectTestCase::test_expect_echo_exact PASSED [ 23%] 583s tests/test_expect.py::ExpectTestCase::test_expect_eof PASSED [ 23%] 583s tests/test_expect.py::ExpectTestCase::test_expect_exact PASSED [ 24%] 584s tests/test_expect.py::ExpectTestCase::test_expect_exact_basic PASSED [ 24%] 584s tests/test_expect.py::ExpectTestCase::test_expect_ignore_case PASSED [ 25%] 584s tests/test_expect.py::ExpectTestCase::test_expect_ignore_case_flag PASSED [ 25%] 585s tests/test_expect.py::ExpectTestCase::test_expect_index PASSED [ 26%] 587s tests/test_expect.py::ExpectTestCase::test_expect_index_exact PASSED [ 26%] 587s tests/test_expect.py::ExpectTestCase::test_expect_order PASSED [ 27%] 587s tests/test_expect.py::ExpectTestCase::test_expect_order_exact PASSED [ 27%] 587s tests/test_expect.py::ExpectTestCase::test_expect_regex_enc_none PASSED [ 28%] 587s tests/test_expect.py::ExpectTestCase::test_expect_regex_enc_utf8 PASSED [ 28%] 588s tests/test_expect.py::ExpectTestCase::test_expect_setecho_off PASSED [ 29%] 588s tests/test_expect.py::ExpectTestCase::test_expect_setecho_off_exact PASSED [ 29%] 593s tests/test_expect.py::ExpectTestCase::test_expect_timeout PASSED [ 30%] 593s tests/test_expect.py::ExpectTestCase::test_greed PASSED [ 30%] 594s tests/test_expect.py::ExpectTestCase::test_greed_exact PASSED [ 31%] 600s tests/test_expect.py::ExpectTestCase::test_increasing_searchwindowsize PASSED [ 31%] 600s tests/test_expect.py::ExpectTestCase::test_ordering PASSED [ 32%] 601s tests/test_expect.py::ExpectTestCase::test_ordering_exact PASSED [ 32%] 601s tests/test_expect.py::ExpectTestCase::test_searchwindowsize PASSED [ 33%] 603s tests/test_expect.py::ExpectTestCase::test_signal_handling PASSED [ 33%] 603s tests/test_expect.py::ExpectTestCase::test_stdin_closed PASSED [ 34%] 603s tests/test_expect.py::ExpectTestCase::test_stdin_stdout_closed PASSED [ 34%] 603s tests/test_expect.py::ExpectTestCase::test_timeout_none PASSED [ 35%] 603s tests/test_expect.py::ExpectTestCase::test_unexpected_eof PASSED [ 35%] 603s tests/test_expect.py::ExpectTestCase::test_waitnoecho PASSED [ 36%] 614s tests/test_expect.py::ExpectTestCase::test_waitnoecho_order PASSED [ 36%] 614s tests/test_filedescriptor.py::ExpectTestCase::test_fd PASSED [ 37%] 614s tests/test_filedescriptor.py::ExpectTestCase::test_fd_isalive PASSED [ 37%] 614s tests/test_filedescriptor.py::ExpectTestCase::test_fd_isatty PASSED [ 38%] 614s tests/test_filedescriptor.py::ExpectTestCase::test_fileobj PASSED [ 38%] 614s tests/test_filedescriptor.py::ExpectTestCase::test_maxread PASSED [ 39%] 614s tests/test_interact.py::InteractTestCase::test_interact_escape PASSED [ 40%] 615s tests/test_interact.py::InteractTestCase::test_interact_escape_None PASSED [ 40%] 615s tests/test_interact.py::InteractTestCase::test_interact_exit_unicode PASSED [ 41%] 615s tests/test_isalive.py::IsAliveTestCase::test_expect_isalive_consistent_multiple_calls PASSED [ 41%] 615s tests/test_isalive.py::IsAliveTestCase::test_expect_isalive_dead_after_SIGHUP PASSED [ 42%] 615s tests/test_isalive.py::IsAliveTestCase::test_expect_isalive_dead_after_SIGINT PASSED [ 42%] 616s tests/test_isalive.py::IsAliveTestCase::test_expect_isalive_dead_after_SIGKILL PASSED [ 43%] 616s tests/test_isalive.py::IsAliveTestCase::test_expect_isalive_dead_after_normal_termination PASSED [ 43%] 617s tests/test_isalive.py::IsAliveTestCase::test_expect_wait PASSED [ 44%] 618s tests/test_isalive.py::IsAliveTestCase::test_expect_wait_after_termination PASSED [ 44%] 618s tests/test_isalive.py::IsAliveTestCase::test_forced_terminate PASSED [ 45%] 620s tests/test_isalive.py::IsAliveTestCase::test_signal_wait PASSED [ 45%] 620s tests/test_log.py::TestCaseLog::test_log PASSED [ 46%] 620s tests/test_log.py::TestCaseLog::test_log_logfile_read PASSED [ 46%] 620s tests/test_log.py::TestCaseLog::test_log_logfile_send PASSED [ 47%] 620s tests/test_log.py::TestCaseLog::test_log_send_and_received PASSED [ 47%] 620s tests/test_misc.py::TestCaseMisc::test_bad_arguments_second_arg_is_list PASSED [ 48%] 620s tests/test_misc.py::TestCaseMisc::test_bad_arguments_suggest_fdpsawn PASSED [ 48%] 621s tests/test_misc.py::TestCaseMisc::test_bad_child_pid PASSED [ 49%] 621s tests/test_misc.py::TestCaseMisc::test_bad_type_in_expect PASSED [ 49%] 621s tests/test_misc.py::TestCaseMisc::test_cwd PASSED [ 50%] 621s tests/test_misc.py::TestCaseMisc::test_eof PASSED [ 50%] 622s tests/test_misc.py::TestCaseMisc::test_exception_tb PASSED [ 51%] 622s tests/test_misc.py::TestCaseMisc::test_isalive PASSED [ 51%] 622s tests/test_misc.py::TestCaseMisc::test_isatty PASSED [ 52%] 622s tests/test_misc.py::TestCaseMisc::test_isatty_poll PASSED [ 52%] 622s tests/test_misc.py::TestCaseMisc::test_iter PASSED [ 53%] 622s tests/test_misc.py::TestCaseMisc::test_nonnative_pty_fork PASSED [ 53%] 623s tests/test_misc.py::TestCaseMisc::test_read PASSED [ 54%] 623s tests/test_misc.py::TestCaseMisc::test_read_after_close_raises_value_error PASSED [ 54%] 623s tests/test_misc.py::TestCaseMisc::test_read_poll PASSED [ 55%] 624s tests/test_misc.py::TestCaseMisc::test_read_poll_timeout PASSED [ 55%] 625s tests/test_misc.py::TestCaseMisc::test_readline PASSED [ 56%] 625s tests/test_misc.py::TestCaseMisc::test_readline_bin_echo PASSED [ 56%] 625s tests/test_misc.py::TestCaseMisc::test_readlines PASSED [ 57%] 625s tests/test_misc.py::TestCaseMisc::test_searcher_as_string PASSED [ 57%] 625s tests/test_misc.py::TestCaseMisc::test_searcher_as_string_with_EOF PASSED [ 58%] 625s tests/test_misc.py::TestCaseMisc::test_searcher_as_string_with_TIMEOUT PASSED [ 58%] 625s tests/test_misc.py::TestCaseMisc::test_searcher_re_as_string PASSED [ 59%] 625s tests/test_misc.py::TestCaseMisc::test_searcher_re_as_string_with_EOF PASSED [ 60%] 625s tests/test_misc.py::TestCaseMisc::test_searcher_re_as_string_with_TIMEOUT PASSED [ 60%] 627s tests/test_misc.py::TestCaseMisc::test_sighup PASSED [ 61%] 627s tests/test_misc.py::TestCaseMisc::test_terminate PASSED [ 61%] 627s tests/test_misc.py::TestCaseMisc::test_with PASSED [ 62%] 627s tests/test_misc.py::TestCaseMisc::test_write PASSED [ 62%] 627s tests/test_misc.py::TestCaseMisc::test_writelines PASSED [ 63%] 627s tests/test_missing_command.py::MissingCommandTestCase::testMissingCommand PASSED [ 63%] 633s tests/test_performance.py::PerformanceTestCase::test_100000 PASSED [ 64%] 637s tests/test_performance.py::PerformanceTestCase::test_large_stdout_stream PASSED [ 64%] 637s tests/test_pickling.py::PickleTest::test_picking PASSED [ 65%] 637s tests/test_popen_spawn.py::ExpectTestCase::test_bad_arg PASSED [ 65%] 637s tests/test_popen_spawn.py::ExpectTestCase::test_crlf PASSED [ 66%] 637s tests/test_popen_spawn.py::ExpectTestCase::test_crlf_encoding PASSED [ 66%] 637s tests/test_popen_spawn.py::ExpectTestCase::test_expect PASSED [ 67%] 637s tests/test_popen_spawn.py::ExpectTestCase::test_expect_basic PASSED [ 67%] 637s tests/test_popen_spawn.py::ExpectTestCase::test_expect_eof PASSED [ 68%] 637s tests/test_popen_spawn.py::ExpectTestCase::test_expect_exact PASSED [ 68%] 637s tests/test_popen_spawn.py::ExpectTestCase::test_expect_exact_basic PASSED [ 69%] 642s tests/test_popen_spawn.py::ExpectTestCase::test_expect_timeout PASSED [ 69%] 642s tests/test_popen_spawn.py::ExpectTestCase::test_timeout_none PASSED [ 70%] 642s tests/test_popen_spawn.py::ExpectTestCase::test_unexpected_eof PASSED [ 70%] 642s tests/test_repr.py::TestCaseMisc::test_str_before_spawn PASSED [ 71%] 642s tests/test_repr.py::TestCaseMisc::test_str_spawn PASSED [ 71%] 643s tests/test_repr.py::TestCaseMisc::test_str_spawnu PASSED [ 72%] 643s tests/test_run.py::RunFuncTestCase::test_run PASSED [ 72%] 643s tests/test_run.py::RunFuncTestCase::test_run_bad_exitstatus PASSED [ 73%] 648s tests/test_run.py::RunFuncTestCase::test_run_callback PASSED [ 73%] 648s tests/test_run.py::RunFuncTestCase::test_run_event_as_function PASSED [ 74%] 649s tests/test_run.py::RunFuncTestCase::test_run_event_as_method PASSED [ 74%] 649s tests/test_run.py::RunFuncTestCase::test_run_event_as_string PASSED [ 75%] 649s tests/test_run.py::RunFuncTestCase::test_run_event_typeerror PASSED [ 75%] 649s tests/test_run.py::RunFuncTestCase::test_run_exit PASSED [ 76%] 649s tests/test_run.py::RunUnicodeFuncTestCase::test_run PASSED [ 76%] 649s tests/test_run.py::RunUnicodeFuncTestCase::test_run_bad_exitstatus PASSED [ 77%] 654s tests/test_run.py::RunUnicodeFuncTestCase::test_run_callback PASSED [ 77%] 655s tests/test_run.py::RunUnicodeFuncTestCase::test_run_event_as_function PASSED [ 78%] 655s tests/test_run.py::RunUnicodeFuncTestCase::test_run_event_as_method PASSED [ 78%] 655s tests/test_run.py::RunUnicodeFuncTestCase::test_run_event_as_string PASSED [ 79%] 655s tests/test_run.py::RunUnicodeFuncTestCase::test_run_event_typeerror PASSED [ 80%] 655s tests/test_run.py::RunUnicodeFuncTestCase::test_run_exit PASSED [ 80%] 656s tests/test_run.py::RunUnicodeFuncTestCase::test_run_unicode PASSED [ 81%] 656s tests/test_screen.py::screenTestCase::test_cursor_save PASSED [ 81%] 656s tests/test_screen.py::screenTestCase::test_decoding_errors PASSED [ 82%] 656s tests/test_screen.py::screenTestCase::test_fill PASSED [ 82%] 656s tests/test_screen.py::screenTestCase::test_get_region PASSED [ 83%] 656s tests/test_screen.py::screenTestCase::test_insert PASSED [ 83%] 656s tests/test_screen.py::screenTestCase::test_no_bytes PASSED [ 84%] 656s tests/test_screen.py::screenTestCase::test_put PASSED [ 84%] 656s tests/test_screen.py::screenTestCase::test_scroll PASSED [ 85%] 656s tests/test_screen.py::screenTestCase::test_unicode_ascii PASSED [ 85%] 656s tests/test_screen.py::screenTestCase::test_unicode_cp437 PASSED [ 86%] 656s tests/test_screen.py::screenTestCase::test_unicode_utf8 PASSED [ 86%] 659s tests/test_timeout_pattern.py::Exp_TimeoutTestCase::test_correctStackTrace PASSED [ 87%] 659s tests/test_timeout_pattern.py::Exp_TimeoutTestCase::test_exp_timeout_notThrown PASSED [ 87%] 659s tests/test_timeout_pattern.py::Exp_TimeoutTestCase::test_matches_exp_timeout PASSED [ 88%] 664s tests/test_timeout_pattern.py::Exp_TimeoutTestCase::test_pattern_printout PASSED [ 88%] 669s tests/test_timeout_pattern.py::Exp_TimeoutTestCase::test_stacktraceMunging PASSED [ 89%] 670s tests/test_unicode.py::UnicodeTests::test_expect_basic PASSED [ 89%] 670s tests/test_unicode.py::UnicodeTests::test_expect_echo_exact PASSED [ 90%] 670s tests/test_unicode.py::UnicodeTests::test_expect_exact_basic PASSED [ 90%] 670s tests/test_unicode.py::UnicodeTests::test_expect_setecho_toggle PASSED [ 91%] 671s tests/test_unicode.py::UnicodeTests::test_expect_setecho_toggle_exact PASSED [ 91%] 671s tests/test_unicode.py::UnicodeTests::test_log_unicode PASSED [ 92%] 671s tests/test_unicode.py::UnicodeTests::test_readline_bin_echo PASSED [ 92%] 671s tests/test_unicode.py::UnicodeTests::test_spawn_expect_ascii_unicode PASSED [ 93%] 671s tests/test_unicode.py::UnicodeTests::test_spawn_send_unicode PASSED [ 93%] 671s tests/test_unicode.py::UnicodeTests::test_spawn_utf8_incomplete PASSED [ 94%] 672s tests/test_unicode.py::UnicodeTests::test_unicode_argv PASSED [ 94%] 672s tests/test_which.py::TestCaseWhich::test_os_defpath_which PASSED [ 95%] 672s tests/test_which.py::TestCaseWhich::test_path_from_env PASSED [ 95%] 672s tests/test_which.py::TestCaseWhich::test_path_search_which PASSED [ 96%] 672s tests/test_which.py::TestCaseWhich::test_which_finds_ls PASSED [ 96%] 672s tests/test_which.py::TestCaseWhich::test_which_follows_symlink PASSED [ 97%] 672s tests/test_which.py::TestCaseWhich::test_which_should_match_other_group_user PASSED [ 97%] 672s tests/test_which.py::TestCaseWhich::test_which_should_not_match_folders PASSED [ 98%] 672s tests/test_winsize.py::TestCaseWinsize::test_initial_winsize PASSED [ 98%] 672s tests/test_winsize.py::TestCaseWinsize::test_initial_winsize_by_dimension PASSED [ 99%] 672s tests/test_winsize.py::TestCaseWinsize::test_setwinsize PASSED [100%] 672s 672s =============================== warnings summary =============================== 672s ../../../usr/lib/python3/dist-packages/pexpect/ANSI.py:29 672s /usr/lib/python3/dist-packages/pexpect/ANSI.py:29: UserWarning: pexpect.screen and pexpect.ANSI are deprecated. We recommend using pyte to emulate a terminal screen: https://pypi.python.org/pypi/pyte 672s from . import screen 672s 672s tests/test_repr.py: 2 warnings 672s tests/test_run.py: 17 warnings 672s tests/test_timeout_pattern.py: 4 warnings 672s tests/test_unicode.py: 11 warnings 672s tests/test_winsize.py: 3 warnings 672s /usr/lib/python3.12/pty.py:95: DeprecationWarning: This process (pid=1452) is multi-threaded, use of forkpty() may lead to deadlocks in the child. 672s pid, fd = os.forkpty() 672s 672s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 672s ========= 195 passed, 62 deselected, 38 warnings in 127.60s (0:02:07) ========== 673s autopkgtest [15:42:46]: test pytest: -----------------------] 673s pytest PASS 673s autopkgtest [15:42:46]: test pytest: - - - - - - - - - - results - - - - - - - - - - 674s autopkgtest [15:42:47]: test autodep8-python3: preparing testbed 818s autopkgtest [15:45:11]: testbed dpkg architecture: ppc64el 818s autopkgtest [15:45:11]: testbed apt version: 2.7.12 818s autopkgtest [15:45:11]: @@@@@@@@@@@@@@@@@@@@ test bed setup 819s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 820s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3807 kB] 821s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [497 kB] 822s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [54.0 kB] 822s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 822s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el Packages [670 kB] 822s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el c-n-f Metadata [3116 B] 822s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el Packages [1372 B] 822s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el c-n-f Metadata [116 B] 822s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el Packages [4100 kB] 823s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el c-n-f Metadata [8652 B] 823s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el Packages [58.3 kB] 823s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el c-n-f Metadata [116 B] 827s Fetched 9323 kB in 5s (1904 kB/s) 827s Reading package lists... 831s Reading package lists... 831s Building dependency tree... 831s Reading state information... 832s Calculating upgrade... 832s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 832s Reading package lists... 832s Building dependency tree... 832s Reading state information... 833s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 834s sh: Attempting to set up Debian/Ubuntu apt sources automatically 834s sh: Distribution appears to be Ubuntu 835s Reading package lists... 835s Building dependency tree... 835s Reading state information... 836s eatmydata is already the newest version (131-1). 836s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 836s Reading package lists... 836s Building dependency tree... 836s Reading state information... 836s dbus is already the newest version (1.14.10-4ubuntu1). 836s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 836s Reading package lists... 837s Building dependency tree... 837s Reading state information... 837s rng-tools-debian is already the newest version (2.4). 837s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 837s Reading package lists... 837s Building dependency tree... 837s Reading state information... 837s The following packages will be REMOVED: 837s cloud-init* python3-configobj* python3-debconf* 838s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 838s After this operation, 3256 kB disk space will be freed. 838s (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 ... 70156 files and directories currently installed.) 838s Removing cloud-init (24.1.2-0ubuntu1) ... 839s Removing python3-configobj (5.0.8-3) ... 839s Removing python3-debconf (1.5.86) ... 839s Processing triggers for man-db (2.12.0-3) ... 841s (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 ... 69767 files and directories currently installed.) 841s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 841s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 841s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 841s invoke-rc.d: policy-rc.d denied execution of try-restart. 842s Reading package lists... 842s Building dependency tree... 842s Reading state information... 842s linux-generic is already the newest version (6.8.0-11.11+1). 842s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 843s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 843s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 843s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 847s Reading package lists... 847s Reading package lists... 847s Building dependency tree... 847s Reading state information... 847s Calculating upgrade... 848s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 848s Reading package lists... 848s Building dependency tree... 848s Reading state information... 849s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 849s autopkgtest [15:45:42]: rebooting testbed after setup commands that affected boot 1019s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 1035s Reading package lists... 1035s Building dependency tree... 1035s Reading state information... 1035s Starting pkgProblemResolver with broken count: 0 1035s Starting 2 pkgProblemResolver with broken count: 0 1035s Done 1036s The following additional packages will be installed: 1036s python3-all python3-pexpect python3-ptyprocess 1036s Suggested packages: 1036s python-pexpect-doc 1036s The following NEW packages will be installed: 1036s autopkgtest-satdep python3-all python3-pexpect python3-ptyprocess 1036s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 1036s Need to get 64.1 kB/64.8 kB of archives. 1036s After this operation, 283 kB of additional disk space will be used. 1036s Get:1 /tmp/autopkgtest.M5HmGB/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [720 B] 1036s Get:2 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-all ppc64el 3.12.1-0ubuntu2 [904 B] 1036s Get:3 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-ptyprocess all 0.7.0-5 [15.1 kB] 1036s Get:4 http://ftpmaster.internal/ubuntu noble/main ppc64el python3-pexpect all 4.9-2 [48.1 kB] 1037s Fetched 64.1 kB in 1s (113 kB/s) 1037s Selecting previously unselected package python3-all. 1038s (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 ... 69712 files and directories currently installed.) 1038s Preparing to unpack .../python3-all_3.12.1-0ubuntu2_ppc64el.deb ... 1038s Unpacking python3-all (3.12.1-0ubuntu2) ... 1038s Selecting previously unselected package python3-ptyprocess. 1038s Preparing to unpack .../python3-ptyprocess_0.7.0-5_all.deb ... 1038s Unpacking python3-ptyprocess (0.7.0-5) ... 1038s Selecting previously unselected package python3-pexpect. 1038s Preparing to unpack .../python3-pexpect_4.9-2_all.deb ... 1038s Unpacking python3-pexpect (4.9-2) ... 1038s Selecting previously unselected package autopkgtest-satdep. 1038s Preparing to unpack .../2-autopkgtest-satdep.deb ... 1038s Unpacking autopkgtest-satdep (0) ... 1038s Setting up python3-all (3.12.1-0ubuntu2) ... 1038s Setting up python3-ptyprocess (0.7.0-5) ... 1039s Setting up python3-pexpect (4.9-2) ... 1039s Setting up autopkgtest-satdep (0) ... 1043s (Reading database ... 69753 files and directories currently installed.) 1043s Removing autopkgtest-satdep (0) ... 1044s autopkgtest [15:48:57]: test autodep8-python3: set -e ; for py in $(py3versions -r 2>/dev/null) ; do cd "$AUTOPKGTEST_TMP" ; echo "Testing with $py:" ; $py -c "import pexpect; print(pexpect)" ; done 1044s autopkgtest [15:48:57]: test autodep8-python3: [----------------------- 1045s Testing with python3.12: 1045s 1045s autopkgtest [15:48:58]: test autodep8-python3: -----------------------] 1046s autodep8-python3 PASS (superficial) 1046s autopkgtest [15:48:59]: test autodep8-python3: - - - - - - - - - - results - - - - - - - - - - 1046s autopkgtest [15:48:59]: @@@@@@@@@@@@@@@@@@@@ summary 1046s pytest PASS 1046s autodep8-python3 PASS (superficial) 1057s Creating nova instance adt-noble-ppc64el-pexpect-20240322-153132-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-ppc64el-server-20240322.img (UUID 8499323f-6fcd-4f77-8a53-77410adea6d3)... 1057s Creating nova instance adt-noble-ppc64el-pexpect-20240322-153132-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-ppc64el-server-20240322.img (UUID 8499323f-6fcd-4f77-8a53-77410adea6d3)...