0s autopkgtest [18:51:38]: starting date and time: 2025-01-19 18:51:38+0000 0s autopkgtest [18:51:38]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [18:51:38]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.80p6_wtm/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 builder-cpu2-ram4-disk20 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-15.secgroup --name adt-plucky-amd64-pagekite-20250119-185138-juju-7f2275-prod-proposed-migration-environment-15-ad3dbc57-5f6b-46fa-820f-e0f714bc3e64 --image adt/ubuntu-plucky-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-amd64 -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/ 53s autopkgtest [18:52:31]: testbed dpkg architecture: amd64 53s autopkgtest [18:52:31]: testbed apt version: 2.9.18 53s autopkgtest [18:52:31]: @@@@@@@@@@@@@@@@@@@@ test bed setup 53s autopkgtest [18:52:31]: testbed release detected to be: None 54s autopkgtest [18:52:32]: updating testbed package index (apt update) 55s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 55s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 55s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 55s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 55s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [768 kB] 55s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9708 B] 55s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [145 kB] 55s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [14.6 kB] 55s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main i386 Packages [188 kB] 55s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 Packages [276 kB] 55s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/restricted i386 Packages [2408 B] 55s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/restricted amd64 Packages [40.1 kB] 55s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/universe amd64 Packages [906 kB] 55s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/universe i386 Packages [378 kB] 55s Get:15 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse amd64 Packages [24.6 kB] 55s Get:16 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse i386 Packages [4116 B] 55s Fetched 2831 kB in 1s (3018 kB/s) 56s Reading package lists... 57s Reading package lists... 57s Building dependency tree... 57s Reading state information... 57s Calculating upgrade... 58s The following packages will be upgraded: 58s gir1.2-glib-2.0 libglib2.0-0t64 libglib2.0-bin libglib2.0-data liblz4-1 58s libzstd1 python3.13-gdbm zstd 58s 8 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 58s Need to get 3233 kB of archives. 58s After this operation, 601 kB of additional disk space will be used. 58s Get:1 http://ftpmaster.internal/ubuntu plucky/main amd64 libzstd1 amd64 1.5.6+dfsg-2 [369 kB] 58s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 liblz4-1 amd64 1.9.4-4 [63.9 kB] 58s Get:3 http://ftpmaster.internal/ubuntu plucky/main amd64 libglib2.0-data all 2.82.4-2 [52.3 kB] 58s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 libglib2.0-bin amd64 2.82.4-2 [103 kB] 58s Get:5 http://ftpmaster.internal/ubuntu plucky/main amd64 gir1.2-glib-2.0 amd64 2.82.4-2 [182 kB] 58s Get:6 http://ftpmaster.internal/ubuntu plucky/main amd64 libglib2.0-0t64 amd64 2.82.4-2 [1656 kB] 58s Get:7 http://ftpmaster.internal/ubuntu plucky/main amd64 python3.13-gdbm amd64 3.13.1-3 [31.7 kB] 58s Get:8 http://ftpmaster.internal/ubuntu plucky/main amd64 zstd amd64 1.5.6+dfsg-2 [775 kB] 59s Fetched 3233 kB in 1s (4701 kB/s) 59s (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 ... 89449 files and directories currently installed.) 59s Preparing to unpack .../libzstd1_1.5.6+dfsg-2_amd64.deb ... 59s Unpacking libzstd1:amd64 (1.5.6+dfsg-2) over (1.5.6+dfsg-1) ... 59s Setting up libzstd1:amd64 (1.5.6+dfsg-2) ... 59s (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 ... 89449 files and directories currently installed.) 59s Preparing to unpack .../liblz4-1_1.9.4-4_amd64.deb ... 59s Unpacking liblz4-1:amd64 (1.9.4-4) over (1.9.4-3) ... 59s Setting up liblz4-1:amd64 (1.9.4-4) ... 59s (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 ... 89449 files and directories currently installed.) 59s Preparing to unpack .../0-libglib2.0-data_2.82.4-2_all.deb ... 59s Unpacking libglib2.0-data (2.82.4-2) over (2.82.4-1) ... 59s Preparing to unpack .../1-libglib2.0-bin_2.82.4-2_amd64.deb ... 59s Unpacking libglib2.0-bin (2.82.4-2) over (2.82.4-1) ... 59s Preparing to unpack .../2-gir1.2-glib-2.0_2.82.4-2_amd64.deb ... 59s Unpacking gir1.2-glib-2.0:amd64 (2.82.4-2) over (2.82.4-1) ... 59s Preparing to unpack .../3-libglib2.0-0t64_2.82.4-2_amd64.deb ... 59s Unpacking libglib2.0-0t64:amd64 (2.82.4-2) over (2.82.4-1) ... 59s Preparing to unpack .../4-python3.13-gdbm_3.13.1-3_amd64.deb ... 59s Unpacking python3.13-gdbm (3.13.1-3) over (3.13.1-2) ... 59s Preparing to unpack .../5-zstd_1.5.6+dfsg-2_amd64.deb ... 59s Unpacking zstd (1.5.6+dfsg-2) over (1.5.6+dfsg-1) ... 59s Setting up libglib2.0-0t64:amd64 (2.82.4-2) ... 59s No schema files found: doing nothing. 59s Setting up libglib2.0-data (2.82.4-2) ... 59s Setting up gir1.2-glib-2.0:amd64 (2.82.4-2) ... 59s Setting up zstd (1.5.6+dfsg-2) ... 59s Setting up python3.13-gdbm (3.13.1-3) ... 59s Setting up libglib2.0-bin (2.82.4-2) ... 59s Processing triggers for libc-bin (2.40-4ubuntu1) ... 59s Processing triggers for man-db (2.13.0-1) ... 60s 60s Running kernel seems to be up-to-date. 60s 60s Restarting services... 61s /etc/needrestart/restart.d/systemd-manager 61s systemctl restart packagekit.service polkit.service ssh.service systemd-fsckd.service systemd-journald.service systemd-networkd.service systemd-resolved.service systemd-timesyncd.service systemd-udevd.service udisks2.service 61s 61s Service restarts being deferred: 61s systemctl restart ModemManager.service 61s systemctl restart systemd-logind.service 61s 61s No containers need to be restarted. 61s 61s User sessions running outdated binaries: 61s ubuntu @ session #4: sshd-session[1196] 61s ubuntu @ user manager service: systemd[953] 61s 61s No VM guests are running outdated hypervisor (qemu) binaries on this host. 62s Reading package lists... 63s Building dependency tree... 63s Reading state information... 63s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 63s autopkgtest [18:52:41]: upgrading testbed (apt dist-upgrade and autopurge) 63s Reading package lists... 63s Building dependency tree... 63s Reading state information... 64s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 64s Starting 2 pkgProblemResolver with broken count: 0 64s Done 64s Entering ResolveByKeep 64s 64s The following packages will be upgraded: 64s python3-openssl 64s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 64s Need to get 46.1 kB of archives. 64s After this operation, 0 B of additional disk space will be used. 64s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 python3-openssl all 25.0.0-1 [46.1 kB] 65s Fetched 46.1 kB in 0s (168 kB/s) 65s (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 ... 89449 files and directories currently installed.) 65s Preparing to unpack .../python3-openssl_25.0.0-1_all.deb ... 65s Unpacking python3-openssl (25.0.0-1) over (24.3.0-1) ... 65s Setting up python3-openssl (25.0.0-1) ... 66s 66s Running kernel seems to be up-to-date. 66s 66s Restarting services... 66s 66s Service restarts being deferred: 66s systemctl restart systemd-logind.service 66s 66s No containers need to be restarted. 66s 66s User sessions running outdated binaries: 66s ubuntu @ session #4: sshd-session[1196] 66s ubuntu @ user manager service: systemd[953] 66s 66s No VM guests are running outdated hypervisor (qemu) binaries on this host. 67s Reading package lists... 67s Building dependency tree... 67s Reading state information... 67s Starting pkgProblemResolver with broken count: 0 67s Starting 2 pkgProblemResolver with broken count: 0 67s Done 67s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 70s autopkgtest [18:52:48]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 13:41:20 UTC 2024 70s autopkgtest [18:52:48]: @@@@@@@@@@@@@@@@@@@@ apt-source pagekite 71s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (dsc) [2453 B] 71s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (tar) [690 kB] 71s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pagekite 1.5.2.201011-2.1ubuntu2 (diff) [19.2 kB] 72s gpgv: Signature made Wed Nov 13 09:04:06 2024 UTC 72s gpgv: using RSA key 568BF22A66337CBFC9A6B9B72C83DBC8E9BD0E37 72s gpgv: Can't check signature: No public key 72s dpkg-source: warning: cannot verify inline signature for ./pagekite_1.5.2.201011-2.1ubuntu2.dsc: no acceptable signature found 72s autopkgtest [18:52:50]: testing package pagekite version 1.5.2.201011-2.1ubuntu2 72s autopkgtest [18:52:50]: build not needed 72s autopkgtest [18:52:50]: test test-client-running: preparing testbed 73s Reading package lists... 73s Building dependency tree... 73s Reading state information... 73s Starting pkgProblemResolver with broken count: 0 73s Starting 2 pkgProblemResolver with broken count: 0 73s Done 74s The following NEW packages will be installed: 74s daemon pagekite python3-socksipychain 74s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 74s Need to get 234 kB of archives. 74s After this operation, 851 kB of additional disk space will be used. 74s Get:1 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-socksipychain all 2.1.2-2 [19.3 kB] 74s Get:2 http://ftpmaster.internal/ubuntu plucky/universe amd64 daemon amd64 0.8.4-1 [62.7 kB] 74s Get:3 http://ftpmaster.internal/ubuntu plucky/universe amd64 pagekite all 1.5.2.201011-2.1ubuntu2 [152 kB] 74s Fetched 234 kB in 0s (543 kB/s) 74s Selecting previously unselected package python3-socksipychain. 74s (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 ... 89449 files and directories currently installed.) 74s Preparing to unpack .../python3-socksipychain_2.1.2-2_all.deb ... 74s Unpacking python3-socksipychain (2.1.2-2) ... 74s Selecting previously unselected package daemon. 74s Preparing to unpack .../daemon_0.8.4-1_amd64.deb ... 74s Unpacking daemon (0.8.4-1) ... 74s Selecting previously unselected package pagekite. 74s Preparing to unpack .../pagekite_1.5.2.201011-2.1ubuntu2_all.deb ... 74s Unpacking pagekite (1.5.2.201011-2.1ubuntu2) ... 75s Setting up python3-socksipychain (2.1.2-2) ... 75s Setting up daemon (0.8.4-1) ... 75s Setting up pagekite (1.5.2.201011-2.1ubuntu2) ... 75s /usr/lib/python3/dist-packages/pagekite/common.py:153: SyntaxWarning: invalid escape sequence '\.' 75s SERVICE_DOMAIN_RE = re.compile('\.(' + '|'.join(SERVICE_DOMAINS) + ')$') 75s /usr/lib/python3/dist-packages/pagekite/pk.py:1242: SyntaxWarning: invalid escape sequence '\.' 75s 'localhost': '((::ffff:)?127\..*|::1)', 75s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:163: SyntaxWarning: invalid escape sequence '\d' 75s HTTP_HEADER = re.compile('(?ism)^(([A-Z]+) ([^\n]+) HTTP/\d+\.\d+\s*)$') 75s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:216: SyntaxWarning: invalid escape sequence '\.' 75s '(?:wp-admin/(?!admin-ajax|css/)|wp-config\.php' 75s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:218: SyntaxWarning: invalid escape sequence '\.' 75s '|system32/|\.\.|\.ht(?:access|pass)' 75s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:222: SyntaxWarning: invalid escape sequence '\.' 75s '|(?:adm[^\n]*|install[^\n]*|setup)\.php)' 75s /usr/lib/python3/dist-packages/pagekite/proto/filters.py:224: SyntaxWarning: invalid escape sequence '\d' 75s ' HTTP/\d+\.\d+\s*)$') 75s /usr/lib/python3/dist-packages/pagekite/proto/selectables.py:656: SyntaxWarning: invalid escape sequence '\s' 75s XMPP_REGEXP = re.compile("<[^>]+\sto=([^\s>]+)[^>]*>") 75s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:57: SyntaxWarning: invalid escape sequence '\.' 75s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 75s /usr/lib/python3/dist-packages/pagekite/ui/basic.py:58: SyntaxWarning: invalid escape sequence '\.' 75s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 75s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:46: SyntaxWarning: invalid escape sequence '\.' 75s '(?:\.[a-z0-9!#$%&\'*+/=?^_`{|}~-]+)*@' 75s /usr/lib/python3/dist-packages/pagekite/ui/remote.py:47: SyntaxWarning: invalid escape sequence '\.' 75s '(?:[a-z0-9](?:[a-z0-9-]*[a-z0-9])?\.)*' 75s invoke-rc.d: policy-rc.d denied execution of start. 75s Created symlink '/etc/systemd/system/multi-user.target.wants/pagekite.service' → '/usr/lib/systemd/system/pagekite.service'. 75s /usr/sbin/policy-rc.d returned 101, not running 'start pagekite.service' 75s Processing triggers for man-db (2.13.0-1) ... 76s 76s Running kernel seems to be up-to-date. 76s 76s Restarting services... 76s 76s Service restarts being deferred: 76s systemctl restart systemd-logind.service 76s 76s No containers need to be restarted. 76s 76s User sessions running outdated binaries: 76s ubuntu @ session #4: sshd-session[1196] 76s ubuntu @ user manager service: systemd[953] 76s 76s No VM guests are running outdated hypervisor (qemu) binaries on this host. 79s autopkgtest [18:52:57]: test test-client-running: [----------------------- 79s ● pagekite.service - PageKite 79s Loaded: loaded (/usr/lib/systemd/system/pagekite.service; enabled; preset: enabled) 79s Active: active (running) since Sun 2025-01-19 18:52:57 UTC; 28ms ago 79s Invocation: cd7eb882a5e646d1905d1869d8492c83 79s Docs: man:pagekite 79s file:///usr/share/doc/pagekite/README.md.gz 79s https://pagekite.net/ 79s Main PID: 2628 ((pagekite)) 79s Tasks: 1 (limit: 4609) 79s Memory: 1.7M (peak: 1.7M) 79s CPU: 17ms 79s CGroup: /system.slice/pagekite.service 79s └─2628 "(pagekite)" 79s 79s Jan 19 18:52:57 autopkgtest systemd[1]: Started pagekite.service - PageKite. 79s success: service running 80s autopkgtest [18:52:58]: test test-client-running: -----------------------] 80s autopkgtest [18:52:58]: test test-client-running: - - - - - - - - - - results - - - - - - - - - - 80s test-client-running PASS 81s autopkgtest [18:52:59]: test test-tunnel: preparing testbed 81s Reading package lists... 81s Building dependency tree... 81s Reading state information... 81s Starting pkgProblemResolver with broken count: 0 81s Starting 2 pkgProblemResolver with broken count: 0 81s Done 82s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 82s autopkgtest [18:53:00]: test test-tunnel: [----------------------- 83s starting frontend 83s ts=678d4a0d; t=2025-01-19T18:53:01; 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 83s ts=678d4a0d; t=2025-01-19T18:53:01; ll=1; listen=:8080; id=s1 84s starting backend 84s ts=678d4a0e; t=2025-01-19T18:53:02; 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 94s trying to connect to ident server via pagekite 94s ts=678d4a18; t=2025-01-19T18:53:12; ll=2; port=8080; accept=~.1:49730; id=s1 95s success 95s stopping pagekite processes 100s autopkgtest [18:53:18]: test test-tunnel: -----------------------] 101s test-tunnel PASS 101s autopkgtest [18:53:19]: test test-tunnel: - - - - - - - - - - results - - - - - - - - - - 101s autopkgtest [18:53:19]: @@@@@@@@@@@@@@@@@@@@ summary 101s test-client-running PASS 101s test-tunnel PASS 118s nova [W] Skipping flock for amd64 118s Creating nova instance adt-plucky-amd64-pagekite-20250119-185138-juju-7f2275-prod-proposed-migration-environment-15-ad3dbc57-5f6b-46fa-820f-e0f714bc3e64 from image adt/ubuntu-plucky-amd64-server-20250119.img (UUID 7982e7e7-53fc-4a89-b206-09501ed3ffd2)... 118s nova [W] Timed out waiting for 314206fd-0520-4e24-b8a6-19e87050186d to get deleted.