0s autopkgtest [08:03:28]: starting date and time: 2025-07-11 08:03:28+0000 0s autopkgtest [08:03:28]: git checkout: 508d4a25 a-v-ssh wait_for_ssh: demote "ssh connection failed" to a debug message 0s autopkgtest [08:03:28]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.l0wyc8td/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade stenographer --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.41-9ubuntu1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-14.secgroup --name adt-questing-arm64-stenographer-20250711-080328-juju-7f2275-prod-proposed-migration-environment-2-fb60da09-75a0-4b4f-b5af-44f993199482 --image adt/ubuntu-questing-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-questing-arm64-stenographer-20250711-080328-juju-7f2275-prod-proposed-migration-environment-2-fb60da09-75a0-4b4f-b5af-44f993199482 from image adt/ubuntu-questing-arm64-server-20250711.img (UUID 206595d5-c736-4a14-a20f-fc9659da5b85)... 91s autopkgtest [08:04:59]: testbed dpkg architecture: arm64 91s autopkgtest [08:04:59]: testbed apt version: 3.1.3 92s autopkgtest [08:05:00]: @@@@@@@@@@@@@@@@@@@@ test bed setup 92s autopkgtest [08:05:00]: testbed release detected to be: None 93s autopkgtest [08:05:01]: updating testbed package index (apt update) 93s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [249 kB] 93s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 93s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 94s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 94s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [15.4 kB] 94s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [37.7 kB] 94s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [179 kB] 94s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 Packages [54.1 kB] 94s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe arm64 Packages [175 kB] 94s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse arm64 Packages [15.7 kB] 94s Fetched 726 kB in 1s (886 kB/s) 95s Reading package lists... 96s autopkgtest [08:05:04]: upgrading testbed (apt dist-upgrade and autopurge) 96s Reading package lists... 96s Building dependency tree... 96s Reading state information... 97s Calculating upgrade... 97s The following packages will be upgraded: 97s libc-bin libc-dev-bin libc6 libc6-dev locales 97s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 97s Need to get 9543 kB of archives. 97s After this operation, 16.4 kB of additional disk space will be used. 97s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 libc6-dev arm64 2.41-9ubuntu1 [1749 kB] 98s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 libc-dev-bin arm64 2.41-9ubuntu1 [22.7 kB] 98s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 libc6 arm64 2.41-9ubuntu1 [2919 kB] 98s Get:4 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 libc-bin arm64 2.41-9ubuntu1 [599 kB] 98s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 locales all 2.41-9ubuntu1 [4253 kB] 99s Preconfiguring packages ... 99s Fetched 9543 kB in 1s (10.1 MB/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 ... 127583 files and directories currently installed.) 99s Preparing to unpack .../libc6-dev_2.41-9ubuntu1_arm64.deb ... 99s Unpacking libc6-dev:arm64 (2.41-9ubuntu1) over (2.41-6ubuntu2) ... 99s Preparing to unpack .../libc-dev-bin_2.41-9ubuntu1_arm64.deb ... 99s Unpacking libc-dev-bin (2.41-9ubuntu1) over (2.41-6ubuntu2) ... 99s Preparing to unpack .../libc6_2.41-9ubuntu1_arm64.deb ... 100s Unpacking libc6:arm64 (2.41-9ubuntu1) over (2.41-6ubuntu2) ... 100s Setting up libc6:arm64 (2.41-9ubuntu1) ... 100s (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 ... 127583 files and directories currently installed.) 100s Preparing to unpack .../libc-bin_2.41-9ubuntu1_arm64.deb ... 100s Unpacking libc-bin (2.41-9ubuntu1) over (2.41-6ubuntu2) ... 100s Setting up libc-bin (2.41-9ubuntu1) ... 100s (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 ... 127583 files and directories currently installed.) 100s Preparing to unpack .../locales_2.41-9ubuntu1_all.deb ... 100s Unpacking locales (2.41-9ubuntu1) over (2.41-6ubuntu2) ... 101s Setting up locales (2.41-9ubuntu1) ... 102s Generating locales (this might take a while)... 107s en_US.UTF-8... done 107s Generation complete. 107s Setting up libc-dev-bin (2.41-9ubuntu1) ... 107s Setting up libc6-dev:arm64 (2.41-9ubuntu1) ... 107s Processing triggers for man-db (2.13.1-1) ... 108s Processing triggers for systemd (257.7-1ubuntu1) ... 109s Reading package lists... 110s Building dependency tree... 110s Reading state information... 110s Solving dependencies... 112s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 115s autopkgtest [08:05:23]: testbed running kernel: Linux 6.15.0-4-generic #4-Ubuntu SMP PREEMPT_DYNAMIC Fri Jul 4 14:27:49 UTC 2025 116s autopkgtest [08:05:24]: @@@@@@@@@@@@@@@@@@@@ apt-source stenographer 119s Get:1 http://ftpmaster.internal/ubuntu questing/universe stenographer 1.0.1-7 (dsc) [2753 B] 119s Get:2 http://ftpmaster.internal/ubuntu questing/universe stenographer 1.0.1-7 (tar) [149 kB] 119s Get:3 http://ftpmaster.internal/ubuntu questing/universe stenographer 1.0.1-7 (diff) [15.1 kB] 119s gpgv: Signature made Wed Aug 7 05:05:27 2024 UTC 119s gpgv: using RSA key 5B34BA5AAB5507E903426E85E8D37AE2F09F4872 119s gpgv: Can't check signature: No public key 119s dpkg-source: warning: cannot verify inline signature for ./stenographer_1.0.1-7.dsc: no acceptable signature found 119s autopkgtest [08:05:27]: testing package stenographer version 1.0.1-7 120s autopkgtest [08:05:28]: build not needed 121s autopkgtest [08:05:29]: test run-example: preparing testbed 121s Reading package lists... 122s Building dependency tree... 122s Reading state information... 122s Solving dependencies... 123s The following NEW packages will be installed: 123s libleveldb1d libsnappy1v5 net-tools stenographer stenographer-client 123s stenographer-common 123s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 123s Need to get 4238 kB of archives. 123s After this operation, 14.6 MB of additional disk space will be used. 123s Get:1 http://ftpmaster.internal/ubuntu questing/main arm64 libsnappy1v5 arm64 1.2.2-1 [30.5 kB] 123s Get:2 http://ftpmaster.internal/ubuntu questing/universe arm64 libleveldb1d arm64 1.23-5build1 [124 kB] 123s Get:3 http://ftpmaster.internal/ubuntu questing/main arm64 net-tools arm64 2.10-1.3ubuntu1 [208 kB] 123s Get:4 http://ftpmaster.internal/ubuntu questing/universe arm64 stenographer-common all 1.0.1-7 [21.0 kB] 123s Get:5 http://ftpmaster.internal/ubuntu questing/universe arm64 stenographer arm64 1.0.1-7 [3850 kB] 124s Get:6 http://ftpmaster.internal/ubuntu questing/universe arm64 stenographer-client all 1.0.1-7 [5288 B] 124s Fetched 4238 kB in 1s (4940 kB/s) 124s Selecting previously unselected package libsnappy1v5:arm64. 124s (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 ... 127583 files and directories currently installed.) 124s Preparing to unpack .../0-libsnappy1v5_1.2.2-1_arm64.deb ... 124s Unpacking libsnappy1v5:arm64 (1.2.2-1) ... 124s Selecting previously unselected package libleveldb1d:arm64. 124s Preparing to unpack .../1-libleveldb1d_1.23-5build1_arm64.deb ... 124s Unpacking libleveldb1d:arm64 (1.23-5build1) ... 124s Selecting previously unselected package net-tools. 124s Preparing to unpack .../2-net-tools_2.10-1.3ubuntu1_arm64.deb ... 124s Unpacking net-tools (2.10-1.3ubuntu1) ... 124s Selecting previously unselected package stenographer-common. 124s Preparing to unpack .../3-stenographer-common_1.0.1-7_all.deb ... 124s Unpacking stenographer-common (1.0.1-7) ... 125s Selecting previously unselected package stenographer. 125s Preparing to unpack .../4-stenographer_1.0.1-7_arm64.deb ... 125s Unpacking stenographer (1.0.1-7) ... 125s Selecting previously unselected package stenographer-client. 125s Preparing to unpack .../5-stenographer-client_1.0.1-7_all.deb ... 125s Unpacking stenographer-client (1.0.1-7) ... 125s Setting up net-tools (2.10-1.3ubuntu1) ... 125s Setting up stenographer-common (1.0.1-7) ... 125s Generating CA state 127s Generating key/cert for 'client' 128s Generating key/cert for 'server' 131s Warning: Ignoring -days without -x509; not generating a certificate 131s Using configuration from /tmp/stenossl.gAulDFmWFyUQ 131s Check that the request matches the signature 131s Signature ok 131s The Subject's Distinguished Name is as follows 131s countryName :PRINTABLE:'XX' 131s organizationName :ASN.1 12:'Stenographer' 131s commonName :ASN.1 12:'127.0.0.1_client' 131s Certificate is to be certified until Nov 25 08:05:36 2052 GMT (9999 days) 131s 131s Write out database with 1 new entries 131s Database updated 131s Warning: Ignoring -days without -x509; not generating a certificate 131s Using configuration from /tmp/stenossl.gAulDFmWFyUQ 131s Check that the request matches the signature 131s Signature ok 131s The Subject's Distinguished Name is as follows 131s countryName :PRINTABLE:'XX' 131s organizationName :ASN.1 12:'Stenographer' 131s commonName :ASN.1 12:'127.0.0.1' 131s Certificate is to be certified until Nov 25 08:05:39 2052 GMT (9999 days) 131s 131s Write out database with 1 new entries 131s Database updated 131s Setting up stenographer-client (1.0.1-7) ... 131s Setting up libsnappy1v5:arm64 (1.2.2-1) ... 131s Setting up libleveldb1d:arm64 (1.23-5build1) ... 131s Setting up stenographer (1.0.1-7) ... 131s setcap on /usr/sbin/stenotype worked. 131s Processing triggers for man-db (2.13.1-1) ... 132s Processing triggers for libc-bin (2.41-9ubuntu1) ... 133s autopkgtest [08:05:41]: test run-example: [----------------------- 133s Filesystem info: 133s Filesystem Type Size Used Avail Use% Mounted on 133s /dev/vda1 ext4 19G 3.1G 16G 17% / 133s Kernel IP routing table 133s Destination Gateway Genmask Flags Metric Ref Use Iface 133s 0.0.0.0 10.145.243.1 0.0.0.0 UG 100 0 0 enp3s0 133s 10.145.243.0 0.0.0.0 255.255.255.0 U 100 0 0 enp3s0 133s 10.145.243.1 0.0.0.0 255.255.255.255 UH 100 0 0 enp3s0 133s 10.145.243.2 0.0.0.0 255.255.255.255 UH 100 0 0 enp3s0 133s 91.189.91.131 10.145.243.1 255.255.255.255 UGH 100 0 0 enp3s0 133s 91.189.91.132 10.145.243.1 255.255.255.255 UGH 100 0 0 enp3s0 133s 169.254.169.254 10.145.243.2 255.255.255.255 UGH 100 0 0 enp3s0 133s Using interface enp3s0 153s ● stenographer.service - packet capture to disk 153s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 153s Active: active (running) since Fri 2025-07-11 08:05:41 UTC; 20s ago 153s Invocation: d8c6f59d757341dea613fe8316147e85 153s Docs: https://github.com/google/stenographer 153s https://github.com/google/stenographer/blob/master/DESIGN.md 153s https://github.com/google/stenographer/blob/master/INSTALL.md 153s Main PID: 2734 (stenographer) 153s Tasks: 13 (limit: 4543) 153s Memory: 10M (peak: 10.4M) 153s CPU: 130ms 153s CGroup: /system.slice/stenographer.service 153s ├─2734 /usr/sbin/stenographer 153s └─2740 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer3956382357 --iface=enp3s0 153s 153s Jul 11 08:05:41 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 153s active 154s % Total % Received % Xferd Average Speed Time Time Time Current 154s Dload Upload Total Spent Left Speed 154s 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 271 100 271 0 0 840 0 --:--:-- --:--:-- --:--:-- 841 334s ● stenographer.service - packet capture to disk 334s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 334s Active: active (running) since Fri 2025-07-11 08:05:41 UTC; 3min 20s ago 334s Invocation: d8c6f59d757341dea613fe8316147e85 334s Docs: https://github.com/google/stenographer 334s https://github.com/google/stenographer/blob/master/DESIGN.md 334s https://github.com/google/stenographer/blob/master/INSTALL.md 334s Main PID: 2734 (stenographer) 334s Tasks: 13 (limit: 4543) 334s Memory: 10.1M (peak: 10.6M) 334s CPU: 182ms 334s CGroup: /system.slice/stenographer.service 334s ├─2734 /usr/sbin/stenographer 334s └─2740 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer3956382357 --iface=enp3s0 334s 334s Jul 11 08:05:41 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 334s tcp 0 0 127.0.0.1:1234 0.0.0.0:* LISTEN 2734/stenographer 334s Running stenographer query 'after 5m ago', piping to 'tcpdump ' 334s curl: (58) could not load PEM client certificate from /etc/stenographer/certs/client_cert.pem, OpenSSL error error:8000000D:system library::Permission denied, (no key found, wrong pass phrase, or wrong file format?) 334s tcpdump: truncated dump file; tried to read 4 file header bytes, only got 0 334s autopkgtest [08:09:02]: test run-example: -----------------------] 335s run-example FAIL non-zero exit status 1 335s autopkgtest [08:09:03]: test run-example: - - - - - - - - - - results - - - - - - - - - - 335s autopkgtest [08:09:03]: @@@@@@@@@@@@@@@@@@@@ summary 335s run-example FAIL non-zero exit status 1