0s autopkgtest [11:41:52]: starting date and time: 2024-11-13 11:41:52+0000 0s autopkgtest [11:41:52]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [11:41:52]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.vs6b2onv/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python3-defaults,src:python3-stdlib-extensions --apt-upgrade libapache2-mod-python --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=python3-defaults/3.12.7-1 python3-stdlib-extensions/3.12.7-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-20.secgroup --name adt-plucky-s390x-libapache2-mod-python-20241113-114152-juju-7f2275-prod-proposed-migration-environment-2-7303c9b8-a0ed-44e9-95d1-e7fe03d15248 --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/ 108s autopkgtest [11:43:40]: testbed dpkg architecture: s390x 108s autopkgtest [11:43:40]: testbed apt version: 2.9.8 108s autopkgtest [11:43:40]: @@@@@@@@@@@@@@@@@@@@ test bed setup 109s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 109s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [849 kB] 110s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 110s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [76.4 kB] 110s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.3 kB] 110s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [85.8 kB] 110s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [565 kB] 110s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [16.6 kB] 110s Fetched 1689 kB in 1s (2182 kB/s) 110s Reading package lists... 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 112s Calculating upgrade... 112s The following NEW packages will be installed: 112s python3.13-gdbm 112s The following packages will be upgraded: 112s libgpgme11t64 libpython3-stdlib python3 python3-gdbm python3-minimal 113s 5 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 113s Need to get 252 kB of archives. 113s After this operation, 98.3 kB of additional disk space will be used. 113s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3-minimal s390x 3.12.7-1 [27.4 kB] 113s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3 s390x 3.12.7-1 [24.0 kB] 113s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libpython3-stdlib s390x 3.12.7-1 [10.0 kB] 113s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x python3.13-gdbm s390x 3.13.0-2 [31.0 kB] 113s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3-gdbm s390x 3.12.7-1 [8642 B] 113s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libgpgme11t64 s390x 1.23.2-5ubuntu4 [151 kB] 113s Fetched 252 kB in 0s (602 kB/s) 113s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 55510 files and directories currently installed.) 113s Preparing to unpack .../python3-minimal_3.12.7-1_s390x.deb ... 113s Unpacking python3-minimal (3.12.7-1) over (3.12.6-0ubuntu1) ... 113s Setting up python3-minimal (3.12.7-1) ... 113s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 55510 files and directories currently installed.) 113s Preparing to unpack .../python3_3.12.7-1_s390x.deb ... 113s Unpacking python3 (3.12.7-1) over (3.12.6-0ubuntu1) ... 113s Preparing to unpack .../libpython3-stdlib_3.12.7-1_s390x.deb ... 113s Unpacking libpython3-stdlib:s390x (3.12.7-1) over (3.12.6-0ubuntu1) ... 113s Selecting previously unselected package python3.13-gdbm. 113s Preparing to unpack .../python3.13-gdbm_3.13.0-2_s390x.deb ... 113s Unpacking python3.13-gdbm (3.13.0-2) ... 113s Preparing to unpack .../python3-gdbm_3.12.7-1_s390x.deb ... 113s Unpacking python3-gdbm:s390x (3.12.7-1) over (3.12.6-1ubuntu1) ... 113s Preparing to unpack .../libgpgme11t64_1.23.2-5ubuntu4_s390x.deb ... 113s Unpacking libgpgme11t64:s390x (1.23.2-5ubuntu4) over (1.18.0-4.1ubuntu4) ... 114s Setting up libgpgme11t64:s390x (1.23.2-5ubuntu4) ... 114s Setting up python3.13-gdbm (3.13.0-2) ... 114s Setting up libpython3-stdlib:s390x (3.12.7-1) ... 114s Setting up python3 (3.12.7-1) ... 114s Setting up python3-gdbm:s390x (3.12.7-1) ... 114s Processing triggers for man-db (2.12.1-3) ... 114s Processing triggers for libc-bin (2.40-1ubuntu3) ... 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 115s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 115s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 115s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 115s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 115s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 116s Reading package lists... 116s Reading package lists... 116s Building dependency tree... 116s Reading state information... 116s Calculating upgrade... 116s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 116s Reading package lists... 116s Building dependency tree... 116s Reading state information... 117s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 120s autopkgtest [11:43:52]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 120s autopkgtest [11:43:52]: @@@@@@@@@@@@@@@@@@@@ apt-source libapache2-mod-python 123s Get:1 http://ftpmaster.internal/ubuntu plucky/universe libapache2-mod-python 3.5.0.1-3build1 (dsc) [2486 B] 123s Get:2 http://ftpmaster.internal/ubuntu plucky/universe libapache2-mod-python 3.5.0.1-3build1 (tar) [313 kB] 123s Get:3 http://ftpmaster.internal/ubuntu plucky/universe libapache2-mod-python 3.5.0.1-3build1 (diff) [14.6 kB] 123s gpgv: Signature made Sun Mar 31 01:39:36 2024 UTC 123s gpgv: using RSA key AC483F68DE728F43F2202FCA568D30F321B2133D 123s gpgv: issuer "steve.langasek@ubuntu.com" 123s gpgv: Can't check signature: No public key 123s dpkg-source: warning: cannot verify inline signature for ./libapache2-mod-python_3.5.0.1-3build1.dsc: no acceptable signature found 123s autopkgtest [11:43:55]: testing package libapache2-mod-python version 3.5.0.1-3build1 123s autopkgtest [11:43:55]: build not needed 124s autopkgtest [11:43:56]: test smoke: preparing testbed 125s Reading package lists... 125s Building dependency tree... 125s Reading state information... 125s Starting pkgProblemResolver with broken count: 0 125s Starting 2 pkgProblemResolver with broken count: 0 125s Done 125s The following additional packages will be installed: 125s apache2 apache2-bin apache2-data apache2-utils libapache2-mod-python 125s libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap libaprutil1t64 125s liblua5.4-0 125s Suggested packages: 125s apache2-doc apache2-suexec-pristine | apache2-suexec-custom www-browser 125s libapache2-mod-python-doc 125s Recommended packages: 125s ssl-cert 125s The following NEW packages will be installed: 125s apache2 apache2-bin apache2-data apache2-utils autopkgtest-satdep 125s libapache2-mod-python libapr1t64 libaprutil1-dbd-sqlite3 libaprutil1-ldap 125s libaprutil1t64 liblua5.4-0 125s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded. 125s Need to get 2292 kB/2293 kB of archives. 125s After this operation, 8456 kB of additional disk space will be used. 125s Get:1 /tmp/autopkgtest.DlOI13/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [728 B] 125s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libapr1t64 s390x 1.7.2-3.2ubuntu1 [114 kB] 126s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libaprutil1t64 s390x 1.6.3-3ubuntu1 [98.3 kB] 126s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libaprutil1-dbd-sqlite3 s390x 1.6.3-3ubuntu1 [11.7 kB] 126s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libaprutil1-ldap s390x 1.6.3-3ubuntu1 [9052 B] 126s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x liblua5.4-0 s390x 5.4.6-3build2 [179 kB] 126s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x apache2-bin s390x 2.4.62-1ubuntu1 [1408 kB] 126s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x apache2-data all 2.4.62-1ubuntu1 [163 kB] 126s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x apache2-utils s390x 2.4.62-1ubuntu1 [101 kB] 126s Get:10 http://ftpmaster.internal/ubuntu plucky/main s390x apache2 s390x 2.4.62-1ubuntu1 [90.4 kB] 126s Get:11 http://ftpmaster.internal/ubuntu plucky/universe s390x libapache2-mod-python s390x 3.5.0.1-3build1 [117 kB] 126s Fetched 2292 kB in 1s (3315 kB/s) 126s Selecting previously unselected package libapr1t64:s390x. 126s (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 ... 55517 files and directories currently installed.) 126s Preparing to unpack .../00-libapr1t64_1.7.2-3.2ubuntu1_s390x.deb ... 126s Unpacking libapr1t64:s390x (1.7.2-3.2ubuntu1) ... 126s Selecting previously unselected package libaprutil1t64:s390x. 126s Preparing to unpack .../01-libaprutil1t64_1.6.3-3ubuntu1_s390x.deb ... 126s Unpacking libaprutil1t64:s390x (1.6.3-3ubuntu1) ... 126s Selecting previously unselected package libaprutil1-dbd-sqlite3:s390x. 126s Preparing to unpack .../02-libaprutil1-dbd-sqlite3_1.6.3-3ubuntu1_s390x.deb ... 126s Unpacking libaprutil1-dbd-sqlite3:s390x (1.6.3-3ubuntu1) ... 126s Selecting previously unselected package libaprutil1-ldap:s390x. 126s Preparing to unpack .../03-libaprutil1-ldap_1.6.3-3ubuntu1_s390x.deb ... 126s Unpacking libaprutil1-ldap:s390x (1.6.3-3ubuntu1) ... 126s Selecting previously unselected package liblua5.4-0:s390x. 126s Preparing to unpack .../04-liblua5.4-0_5.4.6-3build2_s390x.deb ... 126s Unpacking liblua5.4-0:s390x (5.4.6-3build2) ... 126s Selecting previously unselected package apache2-bin. 126s Preparing to unpack .../05-apache2-bin_2.4.62-1ubuntu1_s390x.deb ... 126s Unpacking apache2-bin (2.4.62-1ubuntu1) ... 126s Selecting previously unselected package apache2-data. 126s Preparing to unpack .../06-apache2-data_2.4.62-1ubuntu1_all.deb ... 126s Unpacking apache2-data (2.4.62-1ubuntu1) ... 126s Selecting previously unselected package apache2-utils. 126s Preparing to unpack .../07-apache2-utils_2.4.62-1ubuntu1_s390x.deb ... 126s Unpacking apache2-utils (2.4.62-1ubuntu1) ... 126s Selecting previously unselected package apache2. 126s Preparing to unpack .../08-apache2_2.4.62-1ubuntu1_s390x.deb ... 126s Unpacking apache2 (2.4.62-1ubuntu1) ... 126s Selecting previously unselected package libapache2-mod-python. 126s Preparing to unpack .../09-libapache2-mod-python_3.5.0.1-3build1_s390x.deb ... 126s Unpacking libapache2-mod-python (3.5.0.1-3build1) ... 126s Selecting previously unselected package autopkgtest-satdep. 126s Preparing to unpack .../10-1-autopkgtest-satdep.deb ... 126s Unpacking autopkgtest-satdep (0) ... 126s Setting up libapr1t64:s390x (1.7.2-3.2ubuntu1) ... 126s Setting up liblua5.4-0:s390x (5.4.6-3build2) ... 126s Setting up apache2-data (2.4.62-1ubuntu1) ... 126s Setting up libaprutil1t64:s390x (1.6.3-3ubuntu1) ... 126s Setting up libaprutil1-ldap:s390x (1.6.3-3ubuntu1) ... 126s Setting up libaprutil1-dbd-sqlite3:s390x (1.6.3-3ubuntu1) ... 126s Setting up apache2-utils (2.4.62-1ubuntu1) ... 126s Setting up apache2-bin (2.4.62-1ubuntu1) ... 126s Setting up libapache2-mod-python (3.5.0.1-3build1) ... 126s Package apache2 is not configured yet. Will defer actions by package libapache2-mod-python. 127s Setting up apache2 (2.4.62-1ubuntu1) ... 127s Enabling module mpm_event. 127s Enabling module authz_core. 127s Enabling module authz_host. 127s Enabling module authn_core. 127s Enabling module auth_basic. 127s Enabling module access_compat. 127s Enabling module authn_file. 127s Enabling module authz_user. 127s Enabling module alias. 127s Enabling module dir. 127s Enabling module autoindex. 127s Enabling module env. 127s Enabling module mime. 127s Enabling module negotiation. 127s Enabling module setenvif. 127s Enabling module filter. 127s Enabling module deflate. 127s Enabling module status. 127s Enabling module reqtimeout. 127s Enabling conf charset. 127s Enabling conf localized-error-pages. 127s Enabling conf other-vhosts-access-log. 127s Enabling conf security. 127s Enabling conf serve-cgi-bin. 127s Enabling site 000-default. 127s info: Executing deferred 'a2enmod python' for package libapache2-mod-python 127s Enabling module python. 128s Created symlink '/etc/systemd/system/multi-user.target.wants/apache2.service' → '/usr/lib/systemd/system/apache2.service'. 128s Created symlink '/etc/systemd/system/multi-user.target.wants/apache-htcacheclean.service' → '/usr/lib/systemd/system/apache-htcacheclean.service'. 129s Setting up autopkgtest-satdep (0) ... 129s Processing triggers for ufw (0.36.2-8) ... 129s Processing triggers for man-db (2.12.1-3) ... 130s Processing triggers for libc-bin (2.40-1ubuntu3) ... 131s (Reading database ... 56261 files and directories currently installed.) 131s Removing autopkgtest-satdep (0) ... 132s autopkgtest [11:44:04]: test smoke: [----------------------- 132s INFO: setup configuration 132s INFO: enable apache2 python module 132s Module python already enabled 132s INFO: reloading apache2 service 132s INFO: testing handler publisher 132s ERROR: The output of the hello script (publisher) does not match the expected value! 132s - expected: 'Hello, world!' 132s - received: '#!/usr/bin/python3 132s 132s def index(): 132s return "Hello, world! 132s "' 132s INFO: copy apache2 logs 132s INFO: copy apache2 config 133s autopkgtest [11:44:05]: test smoke: -----------------------] 133s autopkgtest [11:44:05]: test smoke: - - - - - - - - - - results - - - - - - - - - - 133s smoke FAIL non-zero exit status 1 134s autopkgtest [11:44:06]: @@@@@@@@@@@@@@@@@@@@ summary 134s smoke FAIL non-zero exit status 1 148s virt: nova [W] Using flock in prodstack6-s390x 148s virt: flock: timeout while waiting to get lock 148s virt: Creating nova instance adt-plucky-s390x-libapache2-mod-python-20241113-114152-juju-7f2275-prod-proposed-migration-environment-2-7303c9b8-a0ed-44e9-95d1-e7fe03d15248 from image adt/ubuntu-plucky-s390x-server-20241113.img (UUID e740277e-1f72-40ae-bfbe-46030537c71c)...