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-23; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.vvnhfrc1/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-cpu2-ram4-disk20-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-23@sto01-ppc64el-24.secgroup --name adt-questing-ppc64el-stenographer-20250711-080328-juju-7f2275-prod-proposed-migration-environment-23-ab12e45a-044a-4b2f-b42d-514bc85caf0e --image adt/ubuntu-questing-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-23 --net-id=net_prod-autopkgtest-workers-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-questing-ppc64el-stenographer-20250711-080328-juju-7f2275-prod-proposed-migration-environment-23-ab12e45a-044a-4b2f-b42d-514bc85caf0e from image adt/ubuntu-questing-ppc64el-server-20250710.img (UUID 95a99943-0fdf-49aa-a5c1-1f356ba9a55b)... 39s autopkgtest [08:04:07]: testbed dpkg architecture: ppc64el 39s autopkgtest [08:04:07]: testbed apt version: 3.1.3 40s autopkgtest [08:04:08]: @@@@@@@@@@@@@@@@@@@@ test bed setup 40s autopkgtest [08:04:08]: testbed release detected to be: None 40s autopkgtest [08:04:08]: updating testbed package index (apt update) 41s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [249 kB] 41s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 41s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 41s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 41s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [37.7 kB] 41s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [15.4 kB] 41s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [179 kB] 41s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el Packages [54.3 kB] 41s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe ppc64el Packages [153 kB] 41s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse ppc64el Packages [4452 B] 41s Fetched 694 kB in 0s (1800 kB/s) 42s Reading package lists... 42s autopkgtest [08:04:10]: upgrading testbed (apt dist-upgrade and autopurge) 43s Reading package lists... 43s Building dependency tree... 43s Reading state information... 43s Calculating upgrade... 43s The following packages will be upgraded: 43s libc-bin libc-dev-bin libc6 libc6-dev locales 43s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 43s Need to get 10.3 MB of archives. 43s After this operation, 6144 B of additional disk space will be used. 43s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el libc6-dev ppc64el 2.41-9ubuntu1 [2041 kB] 43s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el libc-dev-bin ppc64el 2.41-9ubuntu1 [23.9 kB] 43s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el libc6 ppc64el 2.41-9ubuntu1 [3244 kB] 43s Get:4 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el libc-bin ppc64el 2.41-9ubuntu1 [740 kB] 43s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el locales all 2.41-9ubuntu1 [4253 kB] 45s Preconfiguring packages ... 45s Fetched 10.3 MB in 0s (30.8 MB/s) 46s (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 ... 117998 files and directories currently installed.) 46s Preparing to unpack .../libc6-dev_2.41-9ubuntu1_ppc64el.deb ... 46s Unpacking libc6-dev:ppc64el (2.41-9ubuntu1) over (2.41-6ubuntu2) ... 46s Preparing to unpack .../libc-dev-bin_2.41-9ubuntu1_ppc64el.deb ... 46s Unpacking libc-dev-bin (2.41-9ubuntu1) over (2.41-6ubuntu2) ... 46s Preparing to unpack .../libc6_2.41-9ubuntu1_ppc64el.deb ... 46s Unpacking libc6:ppc64el (2.41-9ubuntu1) over (2.41-6ubuntu2) ... 47s Setting up libc6:ppc64el (2.41-9ubuntu1) ... 47s (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 ... 117998 files and directories currently installed.) 47s Preparing to unpack .../libc-bin_2.41-9ubuntu1_ppc64el.deb ... 47s Unpacking libc-bin (2.41-9ubuntu1) over (2.41-6ubuntu2) ... 47s Setting up libc-bin (2.41-9ubuntu1) ... 47s (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 ... 117998 files and directories currently installed.) 47s Preparing to unpack .../locales_2.41-9ubuntu1_all.deb ... 47s Unpacking locales (2.41-9ubuntu1) over (2.41-6ubuntu2) ... 47s Setting up locales (2.41-9ubuntu1) ... 48s Generating locales (this might take a while)... 49s en_US.UTF-8... done 49s Generation complete. 49s Setting up libc-dev-bin (2.41-9ubuntu1) ... 49s Setting up libc6-dev:ppc64el (2.41-9ubuntu1) ... 49s Processing triggers for man-db (2.13.1-1) ... 52s Processing triggers for systemd (257.7-1ubuntu1) ... 53s Reading package lists... 53s Building dependency tree... 53s Reading state information... 53s Solving dependencies... 54s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 56s autopkgtest [08:04:24]: testbed running kernel: Linux 6.15.0-4-generic #4-Ubuntu SMP Fri Jul 4 14:38:10 UTC 2025 56s autopkgtest [08:04:24]: @@@@@@@@@@@@@@@@@@@@ apt-source stenographer 58s Get:1 http://ftpmaster.internal/ubuntu questing/universe stenographer 1.0.1-7 (dsc) [2753 B] 58s Get:2 http://ftpmaster.internal/ubuntu questing/universe stenographer 1.0.1-7 (tar) [149 kB] 58s Get:3 http://ftpmaster.internal/ubuntu questing/universe stenographer 1.0.1-7 (diff) [15.1 kB] 58s gpgv: Signature made Wed Aug 7 05:05:27 2024 UTC 58s gpgv: using RSA key 5B34BA5AAB5507E903426E85E8D37AE2F09F4872 58s gpgv: Can't check signature: No public key 58s dpkg-source: warning: cannot verify inline signature for ./stenographer_1.0.1-7.dsc: no acceptable signature found 58s autopkgtest [08:04:26]: testing package stenographer version 1.0.1-7 59s autopkgtest [08:04:27]: build not needed 60s autopkgtest [08:04:28]: test run-example: preparing testbed 61s Reading package lists... 61s Building dependency tree... 61s Reading state information... 61s Solving dependencies... 61s The following NEW packages will be installed: 61s libleveldb1d libsnappy1v5 net-tools stenographer stenographer-client 61s stenographer-common 61s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 61s Need to get 4226 kB of archives. 61s After this operation, 15.2 MB of additional disk space will be used. 61s Get:1 http://ftpmaster.internal/ubuntu questing/main ppc64el libsnappy1v5 ppc64el 1.2.2-1 [33.8 kB] 61s Get:2 http://ftpmaster.internal/ubuntu questing/universe ppc64el libleveldb1d ppc64el 1.23-5build1 [150 kB] 61s Get:3 http://ftpmaster.internal/ubuntu questing/main ppc64el net-tools ppc64el 2.10-1.3ubuntu1 [226 kB] 61s Get:4 http://ftpmaster.internal/ubuntu questing/universe ppc64el stenographer-common all 1.0.1-7 [21.0 kB] 61s Get:5 http://ftpmaster.internal/ubuntu questing/universe ppc64el stenographer ppc64el 1.0.1-7 [3790 kB] 61s Get:6 http://ftpmaster.internal/ubuntu questing/universe ppc64el stenographer-client all 1.0.1-7 [5288 B] 61s Fetched 4226 kB in 0s (15.2 MB/s) 61s Selecting previously unselected package libsnappy1v5:ppc64el. 61s (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 ... 117998 files and directories currently installed.) 61s Preparing to unpack .../0-libsnappy1v5_1.2.2-1_ppc64el.deb ... 61s Unpacking libsnappy1v5:ppc64el (1.2.2-1) ... 61s Selecting previously unselected package libleveldb1d:ppc64el. 61s Preparing to unpack .../1-libleveldb1d_1.23-5build1_ppc64el.deb ... 61s Unpacking libleveldb1d:ppc64el (1.23-5build1) ... 61s Selecting previously unselected package net-tools. 61s Preparing to unpack .../2-net-tools_2.10-1.3ubuntu1_ppc64el.deb ... 61s Unpacking net-tools (2.10-1.3ubuntu1) ... 61s Selecting previously unselected package stenographer-common. 61s Preparing to unpack .../3-stenographer-common_1.0.1-7_all.deb ... 61s Unpacking stenographer-common (1.0.1-7) ... 61s Selecting previously unselected package stenographer. 61s Preparing to unpack .../4-stenographer_1.0.1-7_ppc64el.deb ... 61s Unpacking stenographer (1.0.1-7) ... 61s Selecting previously unselected package stenographer-client. 61s Preparing to unpack .../5-stenographer-client_1.0.1-7_all.deb ... 61s Unpacking stenographer-client (1.0.1-7) ... 61s Setting up net-tools (2.10-1.3ubuntu1) ... 61s Setting up stenographer-common (1.0.1-7) ... 62s Generating CA state 62s Generating key/cert for 'client' 63s Generating key/cert for 'server' 64s Warning: Ignoring -days without -x509; not generating a certificate 64s Using configuration from /tmp/stenossl.KMFhA9gujlRG 64s Check that the request matches the signature 64s Signature ok 64s The Subject's Distinguished Name is as follows 64s countryName :PRINTABLE:'XX' 64s organizationName :ASN.1 12:'Stenographer' 64s commonName :ASN.1 12:'127.0.0.1_client' 64s Certificate is to be certified until Nov 25 08:04:30 2052 GMT (9999 days) 64s 64s Write out database with 1 new entries 64s Database updated 64s Warning: Ignoring -days without -x509; not generating a certificate 64s Using configuration from /tmp/stenossl.KMFhA9gujlRG 64s Check that the request matches the signature 64s Signature ok 64s The Subject's Distinguished Name is as follows 64s countryName :PRINTABLE:'XX' 64s organizationName :ASN.1 12:'Stenographer' 64s commonName :ASN.1 12:'127.0.0.1' 64s Certificate is to be certified until Nov 25 08:04:31 2052 GMT (9999 days) 64s 64s Write out database with 1 new entries 64s Database updated 64s Setting up stenographer-client (1.0.1-7) ... 64s Setting up libsnappy1v5:ppc64el (1.2.2-1) ... 64s Setting up libleveldb1d:ppc64el (1.23-5build1) ... 64s Setting up stenographer (1.0.1-7) ... 64s setcap on /usr/sbin/stenotype worked. 64s Processing triggers for man-db (2.13.1-1) ... 64s Processing triggers for libc-bin (2.41-9ubuntu1) ... 66s autopkgtest [08:04:34]: test run-example: [----------------------- 66s Filesystem info: 66s Filesystem Type Size Used Avail Use% Mounted on 66s /dev/vda1 ext4 20G 3.1G 17G 16% / 66s Kernel IP routing table 66s Destination Gateway Genmask Flags Metric Ref Use Iface 66s 0.0.0.0 10.151.39.1 0.0.0.0 UG 100 0 0 enp0s1 66s 10.151.11.5 10.151.39.1 255.255.255.255 UGH 100 0 0 enp0s1 66s 10.151.11.6 10.151.39.1 255.255.255.255 UGH 100 0 0 enp0s1 66s 10.151.11.7 10.151.39.1 255.255.255.255 UGH 100 0 0 enp0s1 66s 10.151.39.0 0.0.0.0 255.255.255.0 U 100 0 0 enp0s1 66s 10.151.39.1 0.0.0.0 255.255.255.255 UH 100 0 0 enp0s1 66s 10.151.39.2 0.0.0.0 255.255.255.255 UH 100 0 0 enp0s1 66s 169.254.169.254 10.151.39.2 255.255.255.255 UGH 100 0 0 enp0s1 66s Using interface enp0s1 86s ● stenographer.service - packet capture to disk 86s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 86s Active: active (running) since Fri 2025-07-11 08:04:33 UTC; 20s ago 86s Invocation: edf6f8ec01fb40b59793ebb211b71491 86s Docs: https://github.com/google/stenographer 86s https://github.com/google/stenographer/blob/master/DESIGN.md 86s https://github.com/google/stenographer/blob/master/INSTALL.md 86s Main PID: 2949 (stenographer) 86s Tasks: 13 (limit: 4737) 86s Memory: 16.6M (peak: 20.5M) 86s CPU: 29ms 86s CGroup: /system.slice/stenographer.service 86s ├─2949 /usr/sbin/stenographer 86s └─2955 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer2219944085 --iface=enp0s1 86s 86s Jul 11 08:04:33 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 86s active 86s % Total % Received % Xferd Average Speed Time Time Time Current 86s Dload Upload Total Spent Left Speed 86s 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 271 100 271 0 0 875 0 --:--:-- --:--:-- --:--:-- 874 100 271 100 271 0 0 875 0 --:--:-- --:--:-- --:--:-- 874 267s ● stenographer.service - packet capture to disk 267s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 267s Active: active (running) since Fri 2025-07-11 08:04:33 UTC; 3min 20s ago 267s Invocation: edf6f8ec01fb40b59793ebb211b71491 267s Docs: https://github.com/google/stenographer 267s https://github.com/google/stenographer/blob/master/DESIGN.md 267s https://github.com/google/stenographer/blob/master/INSTALL.md 267s Main PID: 2949 (stenographer) 267s Tasks: 13 (limit: 4737) 267s Memory: 18.8M (peak: 24.6M) 267s CPU: 39ms 267s CGroup: /system.slice/stenographer.service 267s ├─2949 /usr/sbin/stenographer 267s └─2955 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer2219944085 --iface=enp0s1 267s 267s Jul 11 08:04:33 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 267s tcp 0 0 127.0.0.1:1234 0.0.0.0:* LISTEN 2949/stenographer 267s Running stenographer query 'after 5m ago', piping to 'tcpdump ' 267s 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?) 267s tcpdump: truncated dump file; tried to read 4 file header bytes, only got 0 267s autopkgtest [08:07:55]: test run-example: -----------------------] 267s autopkgtest [08:07:55]: test run-example: - - - - - - - - - - results - - - - - - - - - - 267s run-example FAIL non-zero exit status 1 268s autopkgtest [08:07:56]: @@@@@@@@@@@@@@@@@@@@ summary 268s run-example FAIL non-zero exit status 1