0s autopkgtest [02:23:18]: starting date and time: 2025-01-18 02:23:18+0000 0s autopkgtest [02:23:18]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [02:23:18]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.7nlshpod/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:pyopenssl --apt-upgrade pagekite --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=pyopenssl/25.0.0-1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-10.secgroup --name adt-plucky-s390x-pagekite-20250118-022318-juju-7f2275-prod-proposed-migration-environment-15-676da0e0-9d9a-4999-b6cd-91770c5e87da --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --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,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 101s autopkgtest [02:24:59]: testbed dpkg architecture: s390x 101s autopkgtest [02:24:59]: testbed apt version: 2.9.18 101s autopkgtest [02:24:59]: @@@@@@@@@@@@@@@@@@@@ test bed setup 101s autopkgtest [02:24:59]: testbed release detected to be: None 102s autopkgtest [02:25:00]: updating testbed package index (apt update) 102s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 103s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 103s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 103s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 103s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.3 kB] 103s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [156 kB] 103s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [838 kB] 103s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9708 B] 103s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [265 kB] 103s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [756 B] 103s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [922 kB] 103s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [4972 B] 103s Fetched 2286 kB in 1s (2390 kB/s) 104s Reading package lists... 105s Reading package lists... 105s Building dependency tree... 105s Reading state information... 105s Calculating upgrade... 105s The following packages will be upgraded: 105s gcc-14-base libatomic1 libgcc-s1 libstdc++6 python3-certifi python3-chardet 105s python3-jwt rng-tools-debian usb.ids 105s 9 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 105s Need to get 1408 kB of archives. 105s After this operation, 1024 B disk space will be freed. 105s Get:1 http://ftpmaster.internal/ubuntu plucky/universe s390x rng-tools-debian s390x 2.6 [44.6 kB] 105s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libatomic1 s390x 14.2.0-13ubuntu1 [9422 B] 105s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x gcc-14-base s390x 14.2.0-13ubuntu1 [53.0 kB] 105s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libstdc++6 s390x 14.2.0-13ubuntu1 [896 kB] 106s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libgcc-s1 s390x 14.2.0-13ubuntu1 [35.9 kB] 106s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x usb.ids all 2025.01.14-1 [223 kB] 106s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x python3-certifi all 2024.12.14+ds-1 [9800 B] 106s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x python3-chardet all 5.2.0+dfsg-2 [116 kB] 106s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jwt all 2.10.1-2 [21.0 kB] 106s Fetched 1408 kB in 1s (2251 kB/s) 106s (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 ... 55658 files and directories currently installed.) 106s Preparing to unpack .../rng-tools-debian_2.6_s390x.deb ... 106s Unpacking rng-tools-debian (2.6) over (2.5) ... 106s Preparing to unpack .../libatomic1_14.2.0-13ubuntu1_s390x.deb ... 106s Unpacking libatomic1:s390x (14.2.0-13ubuntu1) over (14.2.0-12ubuntu1) ... 106s Preparing to unpack .../gcc-14-base_14.2.0-13ubuntu1_s390x.deb ... 106s Unpacking gcc-14-base:s390x (14.2.0-13ubuntu1) over (14.2.0-12ubuntu1) ... 106s Setting up gcc-14-base:s390x (14.2.0-13ubuntu1) ... 106s (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 ... 55658 files and directories currently installed.) 106s Preparing to unpack .../libstdc++6_14.2.0-13ubuntu1_s390x.deb ... 106s Unpacking libstdc++6:s390x (14.2.0-13ubuntu1) over (14.2.0-12ubuntu1) ... 106s Setting up libstdc++6:s390x (14.2.0-13ubuntu1) ... 106s (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 ... 55658 files and directories currently installed.) 106s Preparing to unpack .../libgcc-s1_14.2.0-13ubuntu1_s390x.deb ... 106s Unpacking libgcc-s1:s390x (14.2.0-13ubuntu1) over (14.2.0-12ubuntu1) ... 106s Setting up libgcc-s1:s390x (14.2.0-13ubuntu1) ... 106s (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 ... 55658 files and directories currently installed.) 106s Preparing to unpack .../usb.ids_2025.01.14-1_all.deb ... 106s Unpacking usb.ids (2025.01.14-1) over (2024.12.04-1) ... 106s Preparing to unpack .../python3-certifi_2024.12.14+ds-1_all.deb ... 106s Unpacking python3-certifi (2024.12.14+ds-1) over (2024.8.30+dfsg-1) ... 106s Preparing to unpack .../python3-chardet_5.2.0+dfsg-2_all.deb ... 106s Unpacking python3-chardet (5.2.0+dfsg-2) over (5.2.0+dfsg-1) ... 106s Preparing to unpack .../python3-jwt_2.10.1-2_all.deb ... 106s Unpacking python3-jwt (2.10.1-2) over (2.7.0-1) ... 106s Setting up python3-jwt (2.10.1-2) ... 106s Setting up python3-chardet (5.2.0+dfsg-2) ... 107s Setting up python3-certifi (2024.12.14+ds-1) ... 107s Setting up rng-tools-debian (2.6) ... 107s Setting up libatomic1:s390x (14.2.0-13ubuntu1) ... 107s Setting up usb.ids (2025.01.14-1) ... 107s Processing triggers for man-db (2.13.0-1) ... 108s Processing triggers for libc-bin (2.40-4ubuntu1) ... 108s Reading package lists... 108s Building dependency tree... 108s Reading state information... 109s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 109s autopkgtest [02:25:07]: upgrading testbed (apt dist-upgrade and autopurge) 109s Reading package lists... 109s Building dependency tree... 109s Reading state information... 109s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 109s Starting 2 pkgProblemResolver with broken count: 0 109s Done 109s Entering ResolveByKeep 109s 109s The following packages will be upgraded: 109s python3-openssl 110s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 110s Need to get 46.1 kB of archives. 110s After this operation, 0 B of additional disk space will be used. 110s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3-openssl all 25.0.0-1 [46.1 kB] 110s Fetched 46.1 kB in 0s (170 kB/s) 110s (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 ... 55655 files and directories currently installed.) 110s Preparing to unpack .../python3-openssl_25.0.0-1_all.deb ... 110s Unpacking python3-openssl (25.0.0-1) over (24.3.0-1) ... 110s Setting up python3-openssl (25.0.0-1) ... 110s Reading package lists... 111s Building dependency tree... 111s Reading state information... 111s Starting pkgProblemResolver with broken count: 0 111s Starting 2 pkgProblemResolver with broken count: 0 111s Done 111s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 111s autopkgtest [02:25:09]: rebooting testbed after setup commands that affected boot 130s autopkgtest [02:25:28]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 132s autopkgtest [02:25:30]: @@@@@@@@@@@@@@@@@@@@ apt-source pagekite 134s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (dsc) [2453 B] 134s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (tar) [690 kB] 134s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (diff) [19.2 kB] 134s gpgv: Signature made Wed Nov 13 09:04:06 2024 UTC 134s gpgv: using RSA key 568BF22A66337CBFC9A6B9B72C83DBC8E9BD0E37 134s gpgv: Can't check signature: No public key 134s dpkg-source: warning: cannot verify inline signature for ./pagekite_1.5.2.201011-2.1ubuntu2.dsc: no acceptable signature found 134s autopkgtest [02:25:32]: testing package pagekite version 1.5.2.201011-2.1ubuntu2 134s autopkgtest [02:25:32]: build not needed 134s autopkgtest [02:25:32]: test test-client-running: preparing testbed 135s Reading package lists... 135s Building dependency tree... 135s Reading state information... 135s Starting pkgProblemResolver with broken count: 0 135s Starting 2 pkgProblemResolver with broken count: 0 135s Done 135s The following NEW packages will be installed: 135s daemon pagekite python3-six python3-socksipychain 135s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 135s Need to get 249 kB of archives. 135s After this operation, 919 kB of additional disk space will be used. 135s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x python3-six all 1.17.0-1 [13.2 kB] 135s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-socksipychain all 2.1.2-2 [19.3 kB] 135s Get:3 http://ftpmaster.internal/ubuntu plucky/universe s390x daemon s390x 0.8.4-1 [64.9 kB] 135s Get:4 http://ftpmaster.internal/ubuntu plucky/universe s390x pagekite all 1.5.2.201011-2.1ubuntu2 [152 kB] 136s Fetched 249 kB in 0s (609 kB/s) 136s Selecting previously unselected package python3-six. 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 ... 55655 files and directories currently installed.) 136s Preparing to unpack .../python3-six_1.17.0-1_all.deb ... 136s Unpacking python3-six (1.17.0-1) ... 136s Selecting previously unselected package python3-socksipychain. 136s Preparing to unpack .../python3-socksipychain_2.1.2-2_all.deb ... 136s Unpacking python3-socksipychain (2.1.2-2) ... 136s Selecting previously unselected package daemon. 136s Preparing to unpack .../daemon_0.8.4-1_s390x.deb ... 136s Unpacking daemon (0.8.4-1) ... 136s Selecting previously unselected package pagekite. 136s Preparing to unpack .../pagekite_1.5.2.201011-2.1ubuntu2_all.deb ... 136s Unpacking pagekite (1.5.2.201011-2.1ubuntu2) ... 136s Setting up python3-six (1.17.0-1) ... 136s Setting up daemon (0.8.4-1) ... 136s Setting up python3-socksipychain (2.1.2-2) ... 136s Setting up pagekite (1.5.2.201011-2.1ubuntu2) ... 136s /usr/lib/python3/dist-packages/pagekite/common.py:153: SyntaxWarning: invalid escape sequence '\.' 136s SERVICE_DOMAIN_RE = re.compile('\.(' + '|'.join(SERVICE_DOMAINS) + ')$') 136s /usr/lib/python3/dist-packages/pagekite/pk.py:1242: SyntaxWarning: invalid escape sequence '\.' 136s 'localhost': '((::ffff:)?127\..*|::1)', 136s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:163: SyntaxWarning: invalid escape sequence '\d' 136s HTTP_HEADER = re.compile('(?ism)^(([A-Z]+) ([^\n]+) HTTP/\d+\.\d+\s*)$') 136s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:216: SyntaxWarning: invalid escape sequence '\.' 136s '(?:wp-admin/(?!admin-ajax|css/)|wp-config\.php' 136s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:218: SyntaxWarning: invalid escape sequence '\.' 136s '|system32/|\.\.|\.ht(?:access|pass)' 136s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:222: SyntaxWarning: invalid escape sequence '\.' 136s '|(?:adm[^\n]*|install[^\n]*|setup)\.php)' 136s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:224: SyntaxWarning: invalid escape sequence '\d' 136s ' HTTP/\d+\.\d+\s*)$') 136s /usr/lib/python3/dist-packages/pagekite/proto/selectables.py:656: SyntaxWarning: invalid escape sequence '\s' 136s XMPP_REGEXP = re.compile("<[^>]+\sto=([^\s>]+)[^>]*>") 136s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:57: SyntaxWarning: invalid escape sequence '\.' 136s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 136s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:58: SyntaxWarning: invalid escape sequence '\.' 136s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 136s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:46: SyntaxWarning: invalid escape sequence '\.' 136s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 136s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:47: SyntaxWarning: invalid escape sequence '\.' 136s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 137s Created symlink '/etc/systemd/system/multi-user.target.wants/pagekite.service' → '/usr/lib/systemd/system/pagekite.service'. 137s Processing triggers for man-db (2.13.0-1) ... 138s autopkgtest [02:25:36]: test test-client-running: [----------------------- 138s ● pagekite.service - PageKite 138s Loaded: loaded (/usr/lib/systemd/system/pagekite.service; enabled; preset: enabled) 138s Active: active (running) since Sat 2025-01-18 02:27:02 UTC; 8ms ago 138s Invocation: 9344802ae91743a1ae9184fd9fad7cde 138s Docs: man:pagekite 138s file:///usr/share/doc/pagekite/README.md.gz 138s https://pagekite.net/ 138s Main PID: 1477 ((pagekite)) 138s Tasks: 1 (limit: 4774) 138s Memory: 1.2M (peak: 1.3M) 138s CPU: 2ms 138s CGroup: /system.slice/pagekite.service 138s └─1477 "(pagekite)" 138s 138s Jan 18 02:27:02 autopkgtest systemd[1]: Started pagekite.service - PageKite. 138s success: service running 139s autopkgtest [02:25:37]: test test-client-running: -----------------------] 140s autopkgtest [02:25:38]: test test-client-running: - - - - - - - - - - results - - - - - - - - - - 140s test-client-running PASS 140s autopkgtest [02:25:38]: test test-tunnel: preparing testbed 140s Reading package lists... 140s Building dependency tree... 140s Reading state information... 141s Starting pkgProblemResolver with broken count: 0 141s Starting 2 pkgProblemResolver with broken count: 0 141s Done 141s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 141s autopkgtest [02:25:39]: test test-tunnel: [----------------------- 142s starting frontend 142s ts=678b117a; t=2025-01-18T02:27:06; ll=0; started=/usr/bin/pagekite; version=1.5.2.201011; platform=linux; python=3.12.8 (main, Dec 13 2024, 13:19:48) [GCC 14.2.0]; argv=--isfrontend --ports=8080 --protos=http --domain=http:autopkgtest:foo; ca_certs=/etc/ssl/certs/ca-certificates.crt; send_always_buffers=False; tunnel_socket_blocks=False; optfile_.SELF/defaults.cfg=ok 142s ts=678b117a; t=2025-01-18T02:27:06; ll=1; listen=:8080; id=s1 143s starting backend 143s ts=678b117b; t=2025-01-18T02:27:07; ll=0; started=/usr/bin/pagekite; version=1.5.2.201011; platform=linux; python=3.12.8 (main, Dec 13 2024, 13:19:48) [GCC 14.2.0]; argv=--frontend=autopkgtest:8080 --service_on=http:autopkgtest:localhost:113:foo; ca_certs=/etc/ssl/certs/ca-certificates.crt; send_always_buffers=False; tunnel_socket_blocks=False; optfile_.SELF/defaults.cfg=ok 153s trying to connect to ident server via pagekite 153s ts=678b1184; t=2025-01-18T02:27:16; ll=2; port=8080; accept=~.1:42494; id=s1 154s success 154s stopping pagekite processes 159s autopkgtest [02:25:57]: test test-tunnel: -----------------------] 159s test-tunnel PASS 159s autopkgtest [02:25:57]: test test-tunnel: - - - - - - - - - - results - - - - - - - - - - 160s autopkgtest [02:25:58]: @@@@@@@@@@@@@@@@@@@@ summary 160s test-client-running PASS 160s test-tunnel PASS 177s nova [W] Using flock in prodstack6-s390x 177s flock: timeout while waiting to get lock 177s Creating nova instance adt-plucky-s390x-pagekite-20250118-022318-juju-7f2275-prod-proposed-migration-environment-15-676da0e0-9d9a-4999-b6cd-91770c5e87da from image adt/ubuntu-plucky-s390x-server-20250117.img (UUID 77043c30-ce55-43c6-ae27-2590a56e9de9)... 177s nova [W] Timed out waiting for 0f567819-a568-4392-bf23-7a1472033519 to get deleted.