0s autopkgtest [19:05:25]: starting date and time: 2024-12-23 19:05:25+0000 0s autopkgtest [19:05:25]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [19:05:25]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.7dj771g3/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:ca-certificates --apt-upgrade pagekite --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=ca-certificates/20241223 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-13.secgroup --name adt-plucky-s390x-pagekite-20241223-190525-juju-7f2275-prod-proposed-migration-environment-2-f0293619-baa7-4ad4-8d1f-582712586ad8 --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,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 89s autopkgtest [19:06:54]: testbed dpkg architecture: s390x 89s autopkgtest [19:06:54]: testbed apt version: 2.9.16 90s autopkgtest [19:06:55]: @@@@@@@@@@@@@@@@@@@@ test bed setup 90s autopkgtest [19:06:55]: testbed release detected to be: None 90s autopkgtest [19:06:55]: updating testbed package index (apt update) 91s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 91s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 91s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 91s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 91s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [52.8 kB] 91s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [574 kB] 91s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [10.8 kB] 91s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9708 B] 91s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [60.3 kB] 91s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [756 B] 91s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [419 kB] 91s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3108 B] 92s Fetched 1205 kB in 1s (1403 kB/s) 92s Reading package lists... 93s Reading package lists... 93s Building dependency tree... 93s Reading state information... 93s Calculating upgrade... 93s The following packages will be upgraded: 93s apt apt-utils libapt-pkg6.0t64 publicsuffix 93s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 93s Need to get 2810 kB of archives. 93s After this operation, 50.2 kB disk space will be freed. 93s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libapt-pkg6.0t64 s390x 2.9.18 [1093 kB] 94s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x apt s390x 2.9.18 [1367 kB] 94s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x apt-utils s390x 2.9.18 [215 kB] 94s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x publicsuffix all 20241206.1516-0.1 [135 kB] 94s Fetched 2810 kB in 1s (3487 kB/s) 94s (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 ... 55500 files and directories currently installed.) 94s Preparing to unpack .../libapt-pkg6.0t64_2.9.18_s390x.deb ... 94s Unpacking libapt-pkg6.0t64:s390x (2.9.18) over (2.9.16) ... 94s Setting up libapt-pkg6.0t64:s390x (2.9.18) ... 94s (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 ... 55500 files and directories currently installed.) 94s Preparing to unpack .../archives/apt_2.9.18_s390x.deb ... 94s Unpacking apt (2.9.18) over (2.9.16) ... 94s Setting up apt (2.9.18) ... 95s (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 ... 55494 files and directories currently installed.) 95s Preparing to unpack .../apt-utils_2.9.18_s390x.deb ... 95s Unpacking apt-utils (2.9.18) over (2.9.16) ... 95s Preparing to unpack .../publicsuffix_20241206.1516-0.1_all.deb ... 95s Unpacking publicsuffix (20241206.1516-0.1) over (20241025.1547-0.1) ... 95s Setting up apt-utils (2.9.18) ... 95s Setting up publicsuffix (20241206.1516-0.1) ... 95s Processing triggers for man-db (2.13.0-1) ... 96s Processing triggers for libc-bin (2.40-4ubuntu1) ... 97s Reading package lists... 97s Building dependency tree... 97s Reading state information... 97s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 97s autopkgtest [19:07:02]: upgrading testbed (apt dist-upgrade and autopurge) 97s Reading package lists... 97s Building dependency tree... 97s Reading state information... 98s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 98s Starting 2 pkgProblemResolver with broken count: 0 98s Done 98s Entering ResolveByKeep 98s 98s The following packages will be upgraded: 98s ca-certificates 98s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 98s Need to get 165 kB of archives. 98s After this operation, 11.3 kB of additional disk space will be used. 98s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x ca-certificates all 20241223 [165 kB] 99s Preconfiguring packages ... 99s Fetched 165 kB in 0s (494 kB/s) 99s (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 ... 55494 files and directories currently installed.) 99s Preparing to unpack .../ca-certificates_20241223_all.deb ... 99s Unpacking ca-certificates (20241223) over (20240203) ... 99s Setting up ca-certificates (20241223) ... 100s Updating certificates in /etc/ssl/certs... 100s rehash: warning: skipping ca-certificates.crt, it does not contain exactly one certificate or CRL 100s 7 added, 1 removed; done. 100s Processing triggers for man-db (2.13.0-1) ... 101s Processing triggers for ca-certificates (20241223) ... 101s Updating certificates in /etc/ssl/certs... 101s 0 added, 0 removed; done. 101s Running hooks in /etc/ca-certificates/update.d... 101s done. 101s Reading package lists... 101s Building dependency tree... 101s Reading state information... 101s Starting pkgProblemResolver with broken count: 0 101s Starting 2 pkgProblemResolver with broken count: 0 101s Done 102s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 102s autopkgtest [19:07:07]: rebooting testbed after setup commands that affected boot 122s autopkgtest [19:07:27]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 124s autopkgtest [19:07:29]: @@@@@@@@@@@@@@@@@@@@ apt-source pagekite 126s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (dsc) [2453 B] 126s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (tar) [690 kB] 126s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (diff) [19.2 kB] 126s gpgv: Signature made Wed Nov 13 09:04:06 2024 UTC 126s gpgv: using RSA key 568BF22A66337CBFC9A6B9B72C83DBC8E9BD0E37 126s gpgv: Can't check signature: No public key 126s dpkg-source: warning: cannot verify inline signature for ./pagekite_1.5.2.201011-2.1ubuntu2.dsc: no acceptable signature found 126s autopkgtest [19:07:31]: testing package pagekite version 1.5.2.201011-2.1ubuntu2 126s autopkgtest [19:07:31]: build not needed 127s autopkgtest [19:07:32]: test test-client-running: preparing testbed 127s Reading package lists... 127s Building dependency tree... 127s Reading state information... 127s Starting pkgProblemResolver with broken count: 0 127s Starting 2 pkgProblemResolver with broken count: 0 127s Done 127s The following NEW packages will be installed: 127s daemon pagekite python3-six python3-socksipychain 127s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 127s Need to get 249 kB of archives. 127s After this operation, 919 kB of additional disk space will be used. 127s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x python3-six all 1.17.0-1 [13.2 kB] 128s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-socksipychain all 2.1.2-2 [19.3 kB] 128s Get:3 http://ftpmaster.internal/ubuntu plucky/universe s390x daemon s390x 0.8.4-1 [64.9 kB] 128s Get:4 http://ftpmaster.internal/ubuntu plucky/universe s390x pagekite all 1.5.2.201011-2.1ubuntu2 [152 kB] 128s Fetched 249 kB in 0s (606 kB/s) 128s Selecting previously unselected package python3-six. 128s (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 ... 55500 files and directories currently installed.) 128s Preparing to unpack .../python3-six_1.17.0-1_all.deb ... 128s Unpacking python3-six (1.17.0-1) ... 128s Selecting previously unselected package python3-socksipychain. 128s Preparing to unpack .../python3-socksipychain_2.1.2-2_all.deb ... 128s Unpacking python3-socksipychain (2.1.2-2) ... 128s Selecting previously unselected package daemon. 128s Preparing to unpack .../daemon_0.8.4-1_s390x.deb ... 128s Unpacking daemon (0.8.4-1) ... 128s Selecting previously unselected package pagekite. 128s Preparing to unpack .../pagekite_1.5.2.201011-2.1ubuntu2_all.deb ... 128s Unpacking pagekite (1.5.2.201011-2.1ubuntu2) ... 128s Setting up python3-six (1.17.0-1) ... 128s Setting up daemon (0.8.4-1) ... 128s Setting up python3-socksipychain (2.1.2-2) ... 128s Setting up pagekite (1.5.2.201011-2.1ubuntu2) ... 128s /usr/lib/python3/dist-packages/pagekite/common.py:153: SyntaxWarning: invalid escape sequence '\.' 128s SERVICE_DOMAIN_RE = re.compile('\.(' + '|'.join(SERVICE_DOMAINS) + ')$') 128s /usr/lib/python3/dist-packages/pagekite/pk.py:1242: SyntaxWarning: invalid escape sequence '\.' 128s 'localhost': '((::ffff:)?127\..*|::1)', 128s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:163: SyntaxWarning: invalid escape sequence '\d' 128s HTTP_HEADER = re.compile('(?ism)^(([A-Z]+) ([^\n]+) HTTP/\d+\.\d+\s*)$') 128s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:216: SyntaxWarning: invalid escape sequence '\.' 128s '(?:wp-admin/(?!admin-ajax|css/)|wp-config\.php' 128s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:218: SyntaxWarning: invalid escape sequence '\.' 128s '|system32/|\.\.|\.ht(?:access|pass)' 128s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:222: SyntaxWarning: invalid escape sequence '\.' 128s '|(?:adm[^\n]*|install[^\n]*|setup)\.php)' 128s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:224: SyntaxWarning: invalid escape sequence '\d' 128s ' HTTP/\d+\.\d+\s*)$') 128s /usr/lib/python3/dist-packages/pagekite/proto/selectables.py:656: SyntaxWarning: invalid escape sequence '\s' 128s XMPP_REGEXP = re.compile("<[^>]+\sto=([^\s>]+)[^>]*>") 129s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:57: SyntaxWarning: invalid escape sequence '\.' 129s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 129s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:58: SyntaxWarning: invalid escape sequence '\.' 129s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 129s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:46: SyntaxWarning: invalid escape sequence '\.' 129s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 129s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:47: SyntaxWarning: invalid escape sequence '\.' 129s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 129s Created symlink '/etc/systemd/system/multi-user.target.wants/pagekite.service' → '/usr/lib/systemd/system/pagekite.service'. 129s Processing triggers for man-db (2.13.0-1) ... 130s autopkgtest [19:07:35]: test test-client-running: [----------------------- 131s ● pagekite.service - PageKite 131s Loaded: loaded (/usr/lib/systemd/system/pagekite.service; enabled; preset: enabled) 131s Active: active (running) since Mon 2024-12-23 19:09:02 UTC; 6ms ago 131s Invocation: 6e1981406bf74037a68882ccb25e0d92 131s Docs: man:pagekite 131s file:///usr/share/doc/pagekite/README.md.gz 131s https://pagekite.net/ 131s Main PID: 1485 ((pagekite)) 131s Tasks: 1 (limit: 4774) 131s Memory: 1.2M (peak: 1.3M) 131s CPU: 2ms 131s CGroup: /system.slice/pagekite.service 131s └─1485 "(pagekite)" 131s 131s Dec 23 19:09:02 autopkgtest systemd[1]: Started pagekite.service - PageKite. 131s success: service running 131s autopkgtest [19:07:36]: test test-client-running: -----------------------] 132s test-client-running PASS 132s autopkgtest [19:07:37]: test test-client-running: - - - - - - - - - - results - - - - - - - - - - 132s autopkgtest [19:07:37]: test test-tunnel: preparing testbed 132s Reading package lists... 132s Building dependency tree... 132s Reading state information... 132s Starting pkgProblemResolver with broken count: 0 132s Starting 2 pkgProblemResolver with broken count: 0 133s Done 133s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 133s autopkgtest [19:07:38]: test test-tunnel: [----------------------- 134s starting frontend 134s ts=6769b551; t=2024-12-23T19:09:05; 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 134s ts=6769b551; t=2024-12-23T19:09:05; ll=1; listen=:8080; id=s1 135s starting backend 135s ts=6769b552; t=2024-12-23T19:09: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=--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 145s trying to connect to ident server via pagekite 145s ts=6769b55c; t=2024-12-23T19:09:16; ll=2; port=8080; accept=~.1:58426; id=s1 146s success 146s stopping pagekite processes 151s autopkgtest [19:07:56]: test test-tunnel: -----------------------] 151s test-tunnel PASS 151s autopkgtest [19:07:56]: test test-tunnel: - - - - - - - - - - results - - - - - - - - - - 152s autopkgtest [19:07:57]: @@@@@@@@@@@@@@@@@@@@ summary 152s test-client-running PASS 152s test-tunnel PASS 157s nova [W] Using flock in prodstack6-s390x 157s Creating nova instance adt-plucky-s390x-pagekite-20241223-190525-juju-7f2275-prod-proposed-migration-environment-2-f0293619-baa7-4ad4-8d1f-582712586ad8 from image adt/ubuntu-plucky-s390x-server-20241223.img (UUID 7ccf5e8e-26ca-4e4c-af24-bf710dc6556d)... 157s nova [W] Timed out waiting for 7cf2dc49-a8f7-4081-a6b4-3ea80ab7a5d0 to get deleted.