0s autopkgtest [16:58:26]: starting date and time: 2025-03-15 16:58:26+0000 0s autopkgtest [16:58:26]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [16:58:26]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.c5taoslk/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-1ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-38.secgroup --name adt-plucky-arm64-stenographer-20250315-165826-juju-7f2275-prod-proposed-migration-environment-2-72b1371a-e58b-4e83-b2d8-86a7c2ab4a41 --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -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/ 166s autopkgtest [17:01:12]: testbed dpkg architecture: arm64 166s autopkgtest [17:01:12]: testbed apt version: 2.9.33 166s autopkgtest [17:01:12]: @@@@@@@@@@@@@@@@@@@@ test bed setup 166s autopkgtest [17:01:12]: testbed release detected to be: None 167s autopkgtest [17:01:13]: updating testbed package index (apt update) 168s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 168s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 168s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 168s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 168s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 168s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [99.7 kB] 168s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [379 kB] 169s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [111 kB] 169s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 c-n-f Metadata [1856 B] 169s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 c-n-f Metadata [116 B] 169s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [324 kB] 169s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 c-n-f Metadata [14.7 kB] 169s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [4948 B] 169s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 c-n-f Metadata [268 B] 170s Fetched 1078 kB in 2s (573 kB/s) 171s Reading package lists... 171s Reading package lists... 171s Building dependency tree... 171s Reading state information... 172s Calculating upgrade... 172s Calculating upgrade... 173s The following packages will be upgraded: 173s pinentry-curses python3-jinja2 strace 173s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 173s Need to get 647 kB of archives. 173s After this operation, 11.3 kB of additional disk space will be used. 173s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 strace arm64 6.13+ds-1ubuntu1 [499 kB] 173s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 pinentry-curses arm64 1.3.1-2ubuntu3 [39.2 kB] 173s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 174s Fetched 647 kB in 1s (638 kB/s) 174s (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 ... 117701 files and directories currently installed.) 174s Preparing to unpack .../strace_6.13+ds-1ubuntu1_arm64.deb ... 174s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 174s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_arm64.deb ... 174s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 174s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 175s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 175s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 175s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 175s Setting up strace (6.13+ds-1ubuntu1) ... 175s Processing triggers for man-db (2.13.0-1) ... 176s Reading package lists... 177s Building dependency tree... 177s Reading state information... 177s Solving dependencies... 178s The following packages will be REMOVED: 178s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 178s libunwind8* linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 178s linux-image-6.11.0-8-generic* linux-modules-6.11.0-8-generic* 178s linux-tools-6.11.0-8* linux-tools-6.11.0-8-generic* 179s 0 upgraded, 0 newly installed, 11 to remove and 5 not upgraded. 179s After this operation, 267 MB disk space will be freed. 179s (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 ... 117701 files and directories currently installed.) 179s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 179s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 179s Removing libpython3.12t64:arm64 (3.12.9-1) ... 179s Removing libpython3.12-stdlib:arm64 (3.12.9-1) ... 179s Removing libnsl2:arm64 (1.3.0-3build3) ... 179s Removing libpython3.12-minimal:arm64 (3.12.9-1) ... 179s Removing libunwind8:arm64 (1.6.2-3.1) ... 179s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 180s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 181s Removing linux-image-6.11.0-8-generic (6.11.0-8.8) ... 182s I: /boot/vmlinuz.old is now a symlink to vmlinuz-6.14.0-10-generic 182s I: /boot/initrd.img.old is now a symlink to initrd.img-6.14.0-10-generic 182s /etc/kernel/postrm.d/initramfs-tools: 182s update-initramfs: Deleting /boot/initrd.img-6.11.0-8-generic 182s /etc/kernel/postrm.d/zz-flash-kernel: 182s flash-kernel: Kernel 6.11.0-8-generic has been removed. 182s flash-kernel: A higher version (6.14.0-10-generic) is still installed, no reflashing required. 182s /etc/kernel/postrm.d/zz-update-grub: 182s Sourcing file `/etc/default/grub' 182s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg' 182s Generating grub configuration file ... 182s Found linux image: /boot/vmlinuz-6.14.0-10-generic 182s Found initrd image: /boot/initrd.img-6.14.0-10-generic 183s Warning: os-prober will not be executed to detect other bootable partitions. 183s Systems on them will not be added to the GRUB boot configuration. 183s Check GRUB_DISABLE_OS_PROBER documentation entry. 183s Adding boot menu entry for UEFI Firmware Settings ... 183s done 183s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 183s Processing triggers for libc-bin (2.41-1ubuntu1) ... 183s (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 ... 81650 files and directories currently installed.) 183s Purging configuration files for linux-image-6.11.0-8-generic (6.11.0-8.8) ... 183s Purging configuration files for libpython3.12-minimal:arm64 (3.12.9-1) ... 183s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 183s autopkgtest [17:01:29]: upgrading testbed (apt dist-upgrade and autopurge) 183s Reading package lists... 184s Building dependency tree... 184s Reading state information... 184s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 184s Starting 2 pkgProblemResolver with broken count: 0 184s Done 185s Entering ResolveByKeep 186s 186s Calculating upgrade... 186s The following packages will be upgraded: 186s libc-bin libc-dev-bin libc6 libc6-dev locales 186s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 186s Need to get 9530 kB of archives. 186s After this operation, 0 B of additional disk space will be used. 186s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6-dev arm64 2.41-1ubuntu2 [1750 kB] 188s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-dev-bin arm64 2.41-1ubuntu2 [24.0 kB] 189s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6 arm64 2.41-1ubuntu2 [2910 kB] 191s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-bin arm64 2.41-1ubuntu2 [600 kB] 192s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 locales all 2.41-1ubuntu2 [4246 kB] 197s Preconfiguring packages ... 197s Fetched 9530 kB in 11s (892 kB/s) 197s (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 ... 81647 files and directories currently installed.) 197s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_arm64.deb ... 197s Unpacking libc6-dev:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 198s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_arm64.deb ... 198s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 198s Preparing to unpack .../libc6_2.41-1ubuntu2_arm64.deb ... 198s Unpacking libc6:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 198s Setting up libc6:arm64 (2.41-1ubuntu2) ... 198s (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 ... 81647 files and directories currently installed.) 198s Preparing to unpack .../libc-bin_2.41-1ubuntu2_arm64.deb ... 198s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 198s Setting up libc-bin (2.41-1ubuntu2) ... 198s (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 ... 81647 files and directories currently installed.) 198s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 198s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 199s Setting up locales (2.41-1ubuntu2) ... 199s Generating locales (this might take a while)... 202s en_US.UTF-8... done 202s Generation complete. 202s Setting up libc-dev-bin (2.41-1ubuntu2) ... 202s Setting up libc6-dev:arm64 (2.41-1ubuntu2) ... 202s Processing triggers for man-db (2.13.0-1) ... 203s Processing triggers for systemd (257.3-1ubuntu3) ... 203s Reading package lists... 204s Building dependency tree... 204s Reading state information... 204s Starting pkgProblemResolver with broken count: 0 204s Starting 2 pkgProblemResolver with broken count: 0 204s Done 205s Solving dependencies... 205s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 205s autopkgtest [17:01:51]: rebooting testbed after setup commands that affected boot 230s autopkgtest [17:02:16]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP PREEMPT_DYNAMIC Wed Mar 12 15:45:31 UTC 2025 233s autopkgtest [17:02:19]: @@@@@@@@@@@@@@@@@@@@ apt-source stenographer 236s Get:1 http://ftpmaster.internal/ubuntu plucky/universe stenographer 1.0.1-7 (dsc) [2753 B] 236s Get:2 http://ftpmaster.internal/ubuntu plucky/universe stenographer 1.0.1-7 (tar) [149 kB] 236s Get:3 http://ftpmaster.internal/ubuntu plucky/universe stenographer 1.0.1-7 (diff) [15.1 kB] 236s gpgv: Signature made Wed Aug 7 05:05:27 2024 UTC 236s gpgv: using RSA key 5B34BA5AAB5507E903426E85E8D37AE2F09F4872 236s gpgv: Can't check signature: No public key 236s dpkg-source: warning: cannot verify inline signature for ./stenographer_1.0.1-7.dsc: no acceptable signature found 237s autopkgtest [17:02:23]: testing package stenographer version 1.0.1-7 237s autopkgtest [17:02:23]: build not needed 238s autopkgtest [17:02:24]: test run-example: preparing testbed 238s Reading package lists... 239s Building dependency tree... 239s Reading state information... 239s Starting pkgProblemResolver with broken count: 0 239s Starting 2 pkgProblemResolver with broken count: 0 239s Done 240s The following NEW packages will be installed: 240s libleveldb1d libsnappy1v5 net-tools stenographer stenographer-client 240s stenographer-common 240s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 240s Need to get 4237 kB of archives. 240s After this operation, 14.6 MB of additional disk space will be used. 240s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 libsnappy1v5 arm64 1.2.1-1 [30.4 kB] 240s Get:2 http://ftpmaster.internal/ubuntu plucky/universe arm64 libleveldb1d arm64 1.23-5build1 [124 kB] 240s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 net-tools arm64 2.10-1.1ubuntu1 [207 kB] 241s Get:4 http://ftpmaster.internal/ubuntu plucky/universe arm64 stenographer-common all 1.0.1-7 [21.0 kB] 241s Get:5 http://ftpmaster.internal/ubuntu plucky/universe arm64 stenographer arm64 1.0.1-7 [3850 kB] 245s Get:6 http://ftpmaster.internal/ubuntu plucky/universe arm64 stenographer-client all 1.0.1-7 [5288 B] 245s Fetched 4237 kB in 5s (901 kB/s) 245s Selecting previously unselected package libsnappy1v5:arm64. 245s (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 ... 81647 files and directories currently installed.) 245s Preparing to unpack .../0-libsnappy1v5_1.2.1-1_arm64.deb ... 245s Unpacking libsnappy1v5:arm64 (1.2.1-1) ... 245s Selecting previously unselected package libleveldb1d:arm64. 245s Preparing to unpack .../1-libleveldb1d_1.23-5build1_arm64.deb ... 245s Unpacking libleveldb1d:arm64 (1.23-5build1) ... 245s Selecting previously unselected package net-tools. 245s Preparing to unpack .../2-net-tools_2.10-1.1ubuntu1_arm64.deb ... 245s Unpacking net-tools (2.10-1.1ubuntu1) ... 245s Selecting previously unselected package stenographer-common. 245s Preparing to unpack .../3-stenographer-common_1.0.1-7_all.deb ... 245s Unpacking stenographer-common (1.0.1-7) ... 245s Selecting previously unselected package stenographer. 245s Preparing to unpack .../4-stenographer_1.0.1-7_arm64.deb ... 245s Unpacking stenographer (1.0.1-7) ... 246s Selecting previously unselected package stenographer-client. 246s Preparing to unpack .../5-stenographer-client_1.0.1-7_all.deb ... 246s Unpacking stenographer-client (1.0.1-7) ... 246s Setting up net-tools (2.10-1.1ubuntu1) ... 246s Setting up stenographer-common (1.0.1-7) ... 246s info: Selecting UID from range 100 to 999 ... 246s 246s info: Selecting GID from range 100 to 999 ... 246s info: Adding system user `stenographer' (UID 107) ... 246s info: Adding new group `stenographer' (GID 108) ... 246s info: Adding new user `stenographer' (UID 107) with group `stenographer' ... 246s info: Not creating home directory `/var/lib/stenographer'. 246s Generating CA state 251s Generating key/cert for 'client' 252s Generating key/cert for 'server' 254s Warning: Ignoring -days without -x509; not generating a certificate 254s Using configuration from /tmp/stenossl.IJ3CT5cKYyPK 254s Check that the request matches the signature 254s Signature ok 254s The Subject's Distinguished Name is as follows 254s countryName :PRINTABLE:'XX' 254s organizationName :ASN.1 12:'Stenographer' 254s commonName :ASN.1 12:'127.0.0.1_client' 254s Certificate is to be certified until Jul 30 17:02:38 2052 GMT (9999 days) 254s 254s Write out database with 1 new entries 254s Database updated 254s Warning: Ignoring -days without -x509; not generating a certificate 254s Using configuration from /tmp/stenossl.IJ3CT5cKYyPK 254s Check that the request matches the signature 254s Signature ok 254s The Subject's Distinguished Name is as follows 254s countryName :PRINTABLE:'XX' 254s organizationName :ASN.1 12:'Stenographer' 254s commonName :ASN.1 12:'127.0.0.1' 254s Certificate is to be certified until Jul 30 17:02:40 2052 GMT (9999 days) 254s 254s Write out database with 1 new entries 254s Database updated 254s Setting up stenographer-client (1.0.1-7) ... 254s Setting up libsnappy1v5:arm64 (1.2.1-1) ... 254s Setting up libleveldb1d:arm64 (1.23-5build1) ... 254s Setting up stenographer (1.0.1-7) ... 254s setcap on /usr/sbin/stenotype worked. 254s Processing triggers for man-db (2.13.0-1) ... 256s Processing triggers for libc-bin (2.41-1ubuntu2) ... 257s autopkgtest [17:02:43]: test run-example: [----------------------- 257s Filesystem info: 257s Filesystem Type Size Used Avail Use% Mounted on 257s /dev/vda1 ext4 19G 2.5G 16G 14% / 257s Kernel IP routing table 257s Destination Gateway Genmask Flags Metric Ref Use Iface 257s 0.0.0.0 10.145.243.1 0.0.0.0 UG 100 0 0 enp1s0 257s 10.145.243.0 0.0.0.0 255.255.255.0 U 100 0 0 enp1s0 257s 10.145.243.1 0.0.0.0 255.255.255.255 UH 100 0 0 enp1s0 257s 10.145.243.2 0.0.0.0 255.255.255.255 UH 100 0 0 enp1s0 257s 91.189.91.131 10.145.243.1 255.255.255.255 UGH 100 0 0 enp1s0 257s 91.189.91.132 10.145.243.1 255.255.255.255 UGH 100 0 0 enp1s0 257s 169.254.169.254 10.145.243.2 255.255.255.255 UGH 100 0 0 enp1s0 257s Using interface enp1s0 277s ● stenographer.service - packet capture to disk 277s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 277s Active: active (running) since Sat 2025-03-15 17:02:43 UTC; 20s ago 277s Invocation: 9610e1b9fc804ec49cb763a8277b4d35 277s Docs: https://github.com/google/stenographer 277s https://github.com/google/stenographer/blob/master/DESIGN.md 277s https://github.com/google/stenographer/blob/master/INSTALL.md 277s Main PID: 1547 (stenographer) 277s Tasks: 12 (limit: 4547) 277s Memory: 10.1M (peak: 10.5M) 277s CPU: 116ms 277s CGroup: /system.slice/stenographer.service 277s ├─1547 /usr/sbin/stenographer 277s └─1553 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer1800756731 --iface=enp1s0 277s 277s Mar 15 17:02:43 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 277s active 277s % Total % Received % Xferd Average Speed Time Time Time Current 277s Dload Upload Total Spent Left Speed 278s 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 271 100 271 0 0 776 0 --:--:-- --:--:-- --:--:-- 776 100 271 100 271 0 0 776 0 --:--:-- --:--:-- --:--:-- 776 458s ● stenographer.service - packet capture to disk 458s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 458s Active: active (running) since Sat 2025-03-15 17:02:43 UTC; 3min 20s ago 458s Invocation: 9610e1b9fc804ec49cb763a8277b4d35 458s Docs: https://github.com/google/stenographer 458s https://github.com/google/stenographer/blob/master/DESIGN.md 458s https://github.com/google/stenographer/blob/master/INSTALL.md 458s Main PID: 1547 (stenographer) 458s Tasks: 12 (limit: 4547) 458s Memory: 10.2M (peak: 10.7M) 458s CPU: 151ms 458s CGroup: /system.slice/stenographer.service 458s ├─1547 /usr/sbin/stenographer 458s └─1553 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer1800756731 --iface=enp1s0 458s 458s Mar 15 17:02:43 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 458s tcp 0 0 127.0.0.1:1234 0.0.0.0:* LISTEN 1547/stenographer 458s Running stenographer query 'after 5m ago', piping to 'tcpdump ' 458s reading from file /dev/stdin, link-type EN10MB (Ethernet), snapshot length 65536 458s 17:03:03.874208 IP autopkgtest.ssh > 10.136.6.184.38124: Flags [P.], seq 3852303197:3852304137, ack 43390870, win 388, options [nop,nop,TS val 2392385013 ecr 983827392], length 940 458s 17:03:03.879818 IP autopkgtest.ssh > 10.136.6.184.38124: Flags [P.], seq 940:984, ack 1, win 388, options [nop,nop,TS val 2392385019 ecr 983827392], length 44 458s 17:03:03.929416 IP autopkgtest.ssh > 10.136.6.184.38124: Flags [P.], seq 984:1260, ack 1, win 388, options [nop,nop,TS val 2392385068 ecr 983827392], length 276 458s 17:03:03.929825 IP autopkgtest.56069 > csb-recursive-nameserver1.canonical.com.domain: 2312+ [1au] A? squid.internal. (43) 458s 17:03:03.929913 IP autopkgtest.39917 > csb-recursive-nameserver1.canonical.com.domain: 28022+ [1au] AAAA? squid.internal. (43) 458s 17:03:03.930439 IP csb-recursive-nameserver1.canonical.com.domain > autopkgtest.56069: 2312 2/0/1 A 185.125.188.85, A 185.125.188.86 (75) 458s 17:03:03.930585 IP csb-recursive-nameserver1.canonical.com.domain > autopkgtest.39917: 28022 0/1/1 (116) 458s 17:03:03.930932 IP autopkgtest.33784 > internal-proxy-0.canonical.com.3128: Flags [S], seq 3646035913, win 64240, options [mss 1460,sackOK,TS val 2267573470 ecr 0,nop,wscale 7], length 0 458s 17:03:03.943675 IP 10.136.6.184.38124 > autopkgtest.ssh: Flags [.], ack 940, win 24561, options [nop,nop,TS val 983847305 ecr 2392385013], length 0 458s 17:03:03.944154 IP 10.136.6.184.38124 > autopkgtest.ssh: Flags [.], ack 984, win 24561, options [nop,nop,TS val 983847306 ecr 2392385019], length 0 458s 17:03:03.996694 IP 10.136.6.184.38124 > autopkgtest.ssh: Flags [.], ack 1260, win 24561, options [nop,nop,TS val 983847358 ecr 2392385068], length 0 458s 17:03:04.009140 IP internal-proxy-0.canonical.com.3128 > autopkgtest.33784: Flags [S.], seq 2112960804, ack 3646035914, win 62230, options [mss 8902,sackOK,TS val 1693689121 ecr 2267573470,nop,wscale 7], length 0 458s 17:03:04.009171 IP autopkgtest.33784 > internal-proxy-0.canonical.com.3128: Flags [.], ack 1, win 502, options [nop,nop,TS val 2267573548 ecr 1693689121], length 0 458s 17:03:04.009473 IP autopkgtest.33784 > internal-proxy-0.canonical.com.3128: Flags [P.], seq 1:130, ack 1, win 502, options [nop,nop,TS val 2267573548 ecr 1693689121], length 129 458s 17:03:04.080078 IP internal-proxy-0.canonical.com.3128 > autopkgtest.33784: Flags [.], ack 130, win 486, options [nop,nop,TS val 1693689189 ecr 2267573548], length 0 458s 17:03:04.080078 IP internal-proxy-0.canonical.com.3128 > autopkgtest.33784: Flags [.], ack 130, win 486, options [nop,nop,TS val 1693689189 ecr 2267573548], length 0 458s 17:03:04.278188 IP internal-proxy-0.canonical.com.3128 > autopkgtest.33784: Flags [P.], seq 1:531, ack 130, win 486, options [nop,nop,TS val 1693689388 ecr 2267573548], length 530 458s 17:03:04.278188 IP internal-proxy-0.canonical.com.3128 > autopkgtest.33784: Flags [P.], seq 531:802, ack 130, win 486, options [nop,nop,TS val 1693689388 ecr 2267573548], length 271 458s 17:03:04.278221 IP autopkgtest.33784 > internal-proxy-0.canonical.com.3128: Flags [.], ack 531, win 501, options [nop,nop,TS val 2267573817 ecr 1693689388], length 0 458s 17:03:04.278240 IP autopkgtest.33784 > internal-proxy-0.canonical.com.3128: Flags [.], ack 802, win 501, options [nop,nop,TS val 2267573817 ecr 1693689388], length 0 458s 17:03:04.278602 IP autopkgtest.33784 > internal-proxy-0.canonical.com.3128: Flags [F.], seq 130, ack 802, win 501, options [nop,nop,TS val 2267573817 ecr 1693689388], length 0 458s 17:03:04.278957 IP autopkgtest.ssh > 10.136.6.184.38124: Flags [P.], seq 1260:1464, ack 1, win 388, options [nop,nop,TS val 2392385418 ecr 983847358], length 204 458s 17:03:04.346118 IP 10.136.6.184.38124 > autopkgtest.ssh: Flags [.], ack 1464, win 24561, options [nop,nop,TS val 983847707 ecr 2392385418], length 0 458s 17:03:04.354445 IP internal-proxy-0.canonical.com.3128 > autopkgtest.33784: Flags [F.], seq 802, ack 131, win 486, options [nop,nop,TS val 1693689457 ecr 2267573817], length 0 458s 17:03:04.354477 IP autopkgtest.33784 > internal-proxy-0.canonical.com.3128: Flags [.], ack 803, win 501, options [nop,nop,TS val 2267573893 ecr 1693689457], length 0 459s 17:03:06.187124 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.236, length 28 459s 17:03:07.180801 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.236, length 28 459s 17:03:08.205330 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.236, length 28 459s 17:03:08.388071 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 459s 17:03:12.569580 IP autopkgtest.42446 > prod-ntp-4.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 459s 17:03:12.645553 IP prod-ntp-4.ntp1.ps5.canonical.com.ntp > autopkgtest.42446: NTPv4, Server, length 48 459s 17:03:32.377766 ARP, Request who-has 10.145.243.116 tell _gateway, length 28 459s 17:03:32.861729 ARP, Request who-has 10.145.243.116 tell _gateway, length 28 459s 17:03:34.043952 ARP, Request who-has 10.145.243.116 tell _gateway, length 28 459s 17:03:36.411635 ARP, Request who-has 10.145.243.116 tell _gateway, length 28 459s 17:03:41.017529 ARP, Request who-has 10.145.243.116 tell _gateway, length 28 459s 17:03:50.312371 ARP, Request who-has 10.145.243.116 tell _gateway, length 28 459s 17:04:08.426674 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 459s 17:04:09.057779 ARP, Request who-has 10.145.243.116 tell _gateway, length 28 459s 17:04:12.620828 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.233, length 28 459s 17:04:13.631768 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.233, length 28 459s 17:04:14.655823 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.233, length 28 459s 17:04:16.819535 IP autopkgtest.44055 > prod-ntp-4.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 459s 17:04:16.902810 IP prod-ntp-4.ntp1.ps5.canonical.com.ntp > autopkgtest.44055: NTPv4, Server, length 48 459s 17:04:22.176754 ARP, Request who-has _gateway tell autopkgtest, length 28 459s 17:04:22.177447 ARP, Reply _gateway is-at fa:16:3e:8a:f0:cc (oui Unknown), length 28 459s 17:04:27.124238 IP6 fe80::fc16:3eff:fe25:9fc3 > ip6-allrouters: ICMP6, router solicitation, length 16 459s 17:05:18.042233 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.31, length 28 459s 17:05:19.047876 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.31, length 28 459s 17:05:20.070760 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.31, length 28 459s 17:05:28.869955 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.182, length 28 459s 17:05:29.908087 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.182, length 28 459s 17:05:30.932097 ARP, Request who-has csb-recursive-nameserver1.canonical.com tell 10.145.243.182, length 28 459s autopkgtest [17:06:05]: test run-example: -----------------------] 460s autopkgtest [17:06:06]: test run-example: - - - - - - - - - - results - - - - - - - - - - 460s run-example PASS 460s autopkgtest [17:06:06]: @@@@@@@@@@@@@@@@@@@@ summary 460s run-example PASS 478s nova [W] Using flock in prodstack6-arm64 478s flock: timeout while waiting to get lock 478s Creating nova instance adt-plucky-arm64-stenographer-20250315-165826-juju-7f2275-prod-proposed-migration-environment-2-72b1371a-e58b-4e83-b2d8-86a7c2ab4a41 from image adt/ubuntu-plucky-arm64-server-20250315.img (UUID bd6e766c-b51f-4b53-86d6-23aa4d18f524)... 478s nova [W] Timed out waiting for 464f724a-0307-4954-8387-f12b7a641299 to get deleted.