0s autopkgtest [23:11:14]: starting date: 2024-03-06 0s autopkgtest [23:11:14]: git checkout: d9c0295 adt_testbed.py: supress warnings from apt using a shell pipeline 0s autopkgtest [23:11:14]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.5kayg5g_/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed=src:gawk,src:readline --apt-upgrade stenographer --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=gawk/1:5.2.1-2build2 readline/8.2-3.1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-25.secgroup --name adt-noble-arm64-stenographer-20240306-231114-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-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,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 108s autopkgtest [23:13:02]: @@@@@@@@@@@@@@@@@@@@ test bed setup 108s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 109s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [23.8 kB] 109s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [317 kB] 109s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [1809 kB] 109s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [3976 B] 109s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [432 kB] 109s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B] 109s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [20.3 kB] 109s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B] 109s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [2077 kB] 109s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B] 109s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [14.3 kB] 109s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B] 111s Fetched 4827 kB in 1s (4027 kB/s) 111s Reading package lists... 113s Reading package lists... 113s Building dependency tree... 113s Reading state information... 114s Calculating upgrade... 114s The following packages will be REMOVED: 114s libefiboot1 libefivar1 libreadline8 114s The following NEW packages will be installed: 114s libefiboot1t64 libefivar1t64 libreadline8t64 114s The following packages will be upgraded: 114s dmsetup gawk grub-common grub2-common libdevmapper1.02.1 readline-common 114s 6 upgraded, 3 newly installed, 3 to remove and 0 not upgraded. 114s Need to get 3799 kB of archives. 114s After this operation, 139 kB of additional disk space will be used. 114s Get:1 http://ftpmaster.internal/ubuntu noble/main arm64 libdevmapper1.02.1 arm64 2:1.02.185-3ubuntu1 [128 kB] 115s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 grub2-common arm64 2.12-1ubuntu4 [671 kB] 115s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 grub-common arm64 2.12-1ubuntu4 [2174 kB] 115s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 libefivar1t64 arm64 38-3.1 [55.1 kB] 115s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 libefiboot1t64 arm64 38-3.1 [40.5 kB] 115s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 readline-common all 8.2-3.1 [56.4 kB] 115s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libreadline8t64 arm64 8.2-3.1 [153 kB] 115s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 gawk arm64 1:5.2.1-2build2 [447 kB] 115s Get:9 http://ftpmaster.internal/ubuntu noble/main arm64 dmsetup arm64 2:1.02.185-3ubuntu1 [74.5 kB] 116s Preconfiguring packages ... 116s Fetched 3799 kB in 1s (5597 kB/s) 116s (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 ... 74660 files and directories currently installed.) 116s Preparing to unpack .../libdevmapper1.02.1_2%3a1.02.185-3ubuntu1_arm64.deb ... 116s Unpacking libdevmapper1.02.1:arm64 (2:1.02.185-3ubuntu1) over (2:1.02.185-2ubuntu1) ... 116s Preparing to unpack .../grub2-common_2.12-1ubuntu4_arm64.deb ... 116s Unpacking grub2-common (2.12-1ubuntu4) over (2.12-1ubuntu3) ... 116s Preparing to unpack .../grub-common_2.12-1ubuntu4_arm64.deb ... 117s Unpacking grub-common (2.12-1ubuntu4) over (2.12-1ubuntu3) ... 117s dpkg: libefivar1:arm64: dependency problems, but removing anyway as you requested: 117s mokutil depends on libefivar1 (>= 37). 117s libefiboot1:arm64 depends on libefivar1 (>= 38). 117s efibootmgr depends on libefivar1 (>= 38). 117s 117s (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 ... 74660 files and directories currently installed.) 117s Removing libefivar1:arm64 (38-3) ... 117s Selecting previously unselected package libefivar1t64:arm64. 117s (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 ... 74655 files and directories currently installed.) 117s Preparing to unpack .../libefivar1t64_38-3.1_arm64.deb ... 117s Unpacking libefivar1t64:arm64 (38-3.1) ... 117s dpkg: libefiboot1:arm64: dependency problems, but removing anyway as you requested: 117s efibootmgr depends on libefiboot1 (>= 38). 117s 117s (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 ... 74661 files and directories currently installed.) 117s Removing libefiboot1:arm64 (38-3) ... 117s Selecting previously unselected package libefiboot1t64:arm64. 117s (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 ... 74656 files and directories currently installed.) 117s Preparing to unpack .../libefiboot1t64_38-3.1_arm64.deb ... 117s Unpacking libefiboot1t64:arm64 (38-3.1) ... 117s Preparing to unpack .../readline-common_8.2-3.1_all.deb ... 117s Unpacking readline-common (8.2-3.1) over (8.2-3) ... 117s dpkg: libreadline8:arm64: dependency problems, but removing anyway as you requested: 117s parted depends on libreadline8 (>= 6.0). 117s libpython3.12-stdlib:arm64 depends on libreadline8 (>= 7.0~beta). 117s gpgsm depends on libreadline8 (>= 6.0). 117s gpgconf depends on libreadline8 (>= 6.0). 117s gpg depends on libreadline8 (>= 6.0). 117s gawk depends on libreadline8 (>= 6.0). 117s fdisk depends on libreadline8 (>= 6.0). 117s 117s (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 ... 74662 files and directories currently installed.) 117s Removing libreadline8:arm64 (8.2-3) ... 117s Selecting previously unselected package libreadline8t64:arm64. 117s (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 ... 74650 files and directories currently installed.) 117s Preparing to unpack .../libreadline8t64_8.2-3.1_arm64.deb ... 117s Adding 'diversion of /lib/aarch64-linux-gnu/libhistory.so.8 to /lib/aarch64-linux-gnu/libhistory.so.8.usr-is-merged by libreadline8t64' 117s Adding 'diversion of /lib/aarch64-linux-gnu/libhistory.so.8.2 to /lib/aarch64-linux-gnu/libhistory.so.8.2.usr-is-merged by libreadline8t64' 117s Adding 'diversion of /lib/aarch64-linux-gnu/libreadline.so.8 to /lib/aarch64-linux-gnu/libreadline.so.8.usr-is-merged by libreadline8t64' 117s Adding 'diversion of /lib/aarch64-linux-gnu/libreadline.so.8.2 to /lib/aarch64-linux-gnu/libreadline.so.8.2.usr-is-merged by libreadline8t64' 117s Unpacking libreadline8t64:arm64 (8.2-3.1) ... 117s Setting up readline-common (8.2-3.1) ... 117s Setting up libreadline8t64:arm64 (8.2-3.1) ... 117s (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 ... 74670 files and directories currently installed.) 117s Preparing to unpack .../gawk_1%3a5.2.1-2build2_arm64.deb ... 117s Unpacking gawk (1:5.2.1-2build2) over (1:5.2.1-2) ... 117s Preparing to unpack .../dmsetup_2%3a1.02.185-3ubuntu1_arm64.deb ... 117s Unpacking dmsetup (2:1.02.185-3ubuntu1) over (2:1.02.185-2ubuntu1) ... 117s Setting up gawk (1:5.2.1-2build2) ... 117s Setting up libefivar1t64:arm64 (38-3.1) ... 117s Setting up libdevmapper1.02.1:arm64 (2:1.02.185-3ubuntu1) ... 117s Setting up dmsetup (2:1.02.185-3ubuntu1) ... 117s Setting up libefiboot1t64:arm64 (38-3.1) ... 117s Setting up grub-common (2.12-1ubuntu4) ... 117s update-rc.d: warning: start and stop actions are no longer supported; falling back to defaults 118s Setting up grub2-common (2.12-1ubuntu4) ... 118s Processing triggers for man-db (2.12.0-3) ... 119s Processing triggers for install-info (7.1-3) ... 119s Processing triggers for initramfs-tools (0.142ubuntu19) ... 119s update-initramfs: Generating /boot/initrd.img-6.8.0-11-generic 119s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 136s System running in EFI mode, skipping. 136s Processing triggers for libc-bin (2.39-0ubuntu2) ... 137s Reading package lists... 137s Building dependency tree... 137s Reading state information... 137s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 138s sh: Attempting to set up Debian/Ubuntu apt sources automatically 138s sh: Distribution appears to be Ubuntu 139s Reading package lists... 139s Building dependency tree... 139s Reading state information... 140s eatmydata is already the newest version (131-1). 140s dbus is already the newest version (1.14.10-4ubuntu1). 140s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 140s Reading package lists... 140s Building dependency tree... 140s Reading state information... 141s rng-tools-debian is already the newest version (2.4). 141s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 141s Reading package lists... 141s Building dependency tree... 141s Reading state information... 142s haveged is already the newest version (1.9.14-1ubuntu1). 142s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 142s Reading package lists... 143s Building dependency tree... 143s Reading state information... 143s The following packages will be REMOVED: 143s cloud-init* python3-configobj* python3-debconf* 144s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 144s After this operation, 3248 kB disk space will be freed. 144s (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 ... 74670 files and directories currently installed.) 144s Removing cloud-init (24.1-0ubuntu1) ... 144s Removing python3-configobj (5.0.8-3) ... 144s Removing python3-debconf (1.5.86) ... 145s Processing triggers for man-db (2.12.0-3) ... 145s (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 ... 74281 files and directories currently installed.) 145s Purging configuration files for cloud-init (24.1-0ubuntu1) ... 146s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 146s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 146s Reading package lists... 146s Building dependency tree... 146s Reading state information... 147s linux-generic is already the newest version (6.8.0-11.11+1). 147s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 148s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 148s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 148s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 148s Hit:4 http://ftpmaster.internal/ubuntu noble-proposed InRelease 149s Reading package lists... 149s Reading package lists... 149s Building dependency tree... 149s Reading state information... 150s Calculating upgrade... 150s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 150s Reading package lists... 150s Building dependency tree... 150s Reading state information... 151s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 151s autopkgtest [23:13:45]: rebooting testbed after setup commands that affected boot 178s autopkgtest [23:14:12]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 02:53:31 UTC 2024 178s autopkgtest [23:14:12]: testbed dpkg architecture: arm64 180s autopkgtest [23:14:14]: @@@@@@@@@@@@@@@@@@@@ apt-source stenographer 183s Get:1 http://ftpmaster.internal/ubuntu noble/universe stenographer 1.0.1-3 (dsc) [2753 B] 183s Get:2 http://ftpmaster.internal/ubuntu noble/universe stenographer 1.0.1-3 (tar) [149 kB] 183s Get:3 http://ftpmaster.internal/ubuntu noble/universe stenographer 1.0.1-3 (diff) [13.9 kB] 183s gpgv: Signature made Wed Dec 13 08:47:49 2023 UTC 183s gpgv: using RSA key 5B34BA5AAB5507E903426E85E8D37AE2F09F4872 183s gpgv: Can't check signature: No public key 183s dpkg-source: warning: cannot verify inline signature for ./stenographer_1.0.1-3.dsc: no acceptable signature found 183s autopkgtest [23:14:17]: testing package stenographer version 1.0.1-3 183s autopkgtest [23:14:17]: build not needed 185s autopkgtest [23:14:19]: test run-example: preparing testbed 188s Reading package lists... 189s Building dependency tree... 189s Reading state information... 189s Correcting dependencies...Starting pkgProblemResolver with broken count: 0 189s Starting 2 pkgProblemResolver with broken count: 0 189s Done 189s Done 189s Starting pkgProblemResolver with broken count: 0 190s Starting 2 pkgProblemResolver with broken count: 0 190s Done 190s The following additional packages will be installed: 190s libleveldb1d libsnappy1v5 net-tools stenographer stenographer-client 190s stenographer-common 190s The following NEW packages will be installed: 190s libleveldb1d libsnappy1v5 net-tools stenographer stenographer-client 190s stenographer-common 190s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 190s 1 not fully installed or removed. 190s Need to get 3723 kB of archives. 190s After this operation, 12.4 MB of additional disk space will be used. 190s Get:1 http://ftpmaster.internal/ubuntu noble/main arm64 libsnappy1v5 arm64 1.1.10-1 [28.2 kB] 190s Get:2 http://ftpmaster.internal/ubuntu noble/universe arm64 libleveldb1d arm64 1.23-5 [122 kB] 191s Get:3 http://ftpmaster.internal/ubuntu noble/universe arm64 stenographer-common all 1.0.1-3 [20.4 kB] 191s Get:4 http://ftpmaster.internal/ubuntu noble/universe arm64 stenographer arm64 1.0.1-3 [3341 kB] 191s Get:5 http://ftpmaster.internal/ubuntu noble/universe arm64 stenographer-client all 1.0.1-3 [5290 B] 191s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 net-tools arm64 2.10-0.1ubuntu3 [206 kB] 192s Fetched 3723 kB in 1s (5235 kB/s) 192s Selecting previously unselected package libsnappy1v5:arm64. 192s (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 ... 74226 files and directories currently installed.) 192s Preparing to unpack .../0-libsnappy1v5_1.1.10-1_arm64.deb ... 192s Unpacking libsnappy1v5:arm64 (1.1.10-1) ... 192s Selecting previously unselected package libleveldb1d:arm64. 192s Preparing to unpack .../1-libleveldb1d_1.23-5_arm64.deb ... 192s Unpacking libleveldb1d:arm64 (1.23-5) ... 192s Selecting previously unselected package stenographer-common. 192s Preparing to unpack .../2-stenographer-common_1.0.1-3_all.deb ... 192s Unpacking stenographer-common (1.0.1-3) ... 192s Selecting previously unselected package stenographer. 192s Preparing to unpack .../3-stenographer_1.0.1-3_arm64.deb ... 192s Unpacking stenographer (1.0.1-3) ... 192s Selecting previously unselected package stenographer-client. 192s Preparing to unpack .../4-stenographer-client_1.0.1-3_all.deb ... 192s Unpacking stenographer-client (1.0.1-3) ... 192s Selecting previously unselected package net-tools. 192s Preparing to unpack .../5-net-tools_2.10-0.1ubuntu3_arm64.deb ... 192s Unpacking net-tools (2.10-0.1ubuntu3) ... 192s Setting up net-tools (2.10-0.1ubuntu3) ... 192s Setting up stenographer-common (1.0.1-3) ... 192s info: Selecting UID from range 100 to 999 ... 192s 192s info: Selecting GID from range 100 to 999 ... 192s info: Adding system user `stenographer' (UID 107) ... 192s info: Adding new group `stenographer' (GID 114) ... 192s info: Adding new user `stenographer' (UID 107) with group `stenographer' ... 192s info: Not creating home directory `/var/lib/stenographer'. 192s Generating CA state 201s Generating key/cert for 'client' 205s Generating key/cert for 'server' 210s Setting up stenographer-client (1.0.1-3) ... 210s Setting up libsnappy1v5:arm64 (1.1.10-1) ... 210s Setting up libleveldb1d:arm64 (1.23-5) ... 210s Setting up stenographer (1.0.1-3) ... 210s setcap on /usr/sbin/stenotype worked. 210s Setting up autopkgtest-satdep (0) ... 210s Processing triggers for man-db (2.12.0-3) ... 211s Processing triggers for libc-bin (2.39-0ubuntu2) ... 215s (Reading database ... 74311 files and directories currently installed.) 215s Removing autopkgtest-satdep (0) ... 216s autopkgtest [23:14:50]: test run-example: [----------------------- 217s Using interface enp1s0 217s ● stenographer.service - packet capture to disk 217s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 217s Active: active (running) since Wed 2024-03-06 23:14:51 UTC; 15ms ago 217s Docs: https://github.com/google/stenographer 217s https://github.com/google/stenographer/blob/master/DESIGN.md 217s https://github.com/google/stenographer/blob/master/INSTALL.md 217s Main PID: 1360 (stenographer) 217s Tasks: 1 (limit: 4558) 217s Memory: 344.0K (peak: 344.0K) 217s CPU: 2ms 217s CGroup: /system.slice/stenographer.service 217s └─1360 /usr/sbin/stenographer 217s 217s Mar 06 23:14:51 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 217s active 218s % Total % Received % Xferd Average Speed Time Time Time Current 218s Dload Upload Total Spent Left Speed 218s 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 271 100 271 0 0 618 0 --:--:-- --:--:-- --:--:-- 637 398s ● stenographer.service - packet capture to disk 398s Loaded: loaded (/usr/lib/systemd/system/stenographer.service; disabled; preset: enabled) 398s Active: active (running) since Wed 2024-03-06 23:14:51 UTC; 3min 1s ago 398s Docs: https://github.com/google/stenographer 398s https://github.com/google/stenographer/blob/master/DESIGN.md 398s https://github.com/google/stenographer/blob/master/INSTALL.md 398s Main PID: 1360 (stenographer) 398s Tasks: 14 (limit: 4558) 398s Memory: 9.5M (peak: 9.7M) 398s CPU: 781ms 398s CGroup: /system.slice/stenographer.service 398s ├─1360 /usr/sbin/stenographer 398s └─1369 /usr/sbin/stenotype --blocks=256 --seccomp=none --threads=1 --dir=/tmp/stenographer449665116 --iface=enp1s0 398s 398s Mar 06 23:14:51 autopkgtest systemd[1]: Started stenographer.service - packet capture to disk. 398s tcp 0 0 127.0.0.1:1234 0.0.0.0:* LISTEN 1360/stenographer 398s Running stenographer query 'after 5m ago', piping to 'tcpdump ' 399s reading from file /dev/stdin, link-type EN10MB (Ethernet), snapshot length 65536 399s 23:14:52.335060 IP 10.136.6.184.33482 > autopkgtest.ssh: Flags [.], ack 3330567336, win 24567, options [nop,nop,TS val 3106969317 ecr 3951173694], length 0 399s 23:14:52.335061 IP internal-proxy-0.canonical.com.3128 > autopkgtest.57518: Flags [S.], seq 728071930, ack 3529584692, win 62314, options [mss 8902,nop,nop,sackOK,nop,wscale 7], length 0 399s 23:14:52.335100 IP autopkgtest.57518 > internal-proxy-0.canonical.com.3128: Flags [.], ack 1, win 251, length 0 399s 23:14:52.345366 IP autopkgtest.57518 > internal-proxy-0.canonical.com.3128: Flags [P.], seq 1:129, ack 1, win 251, length 128 399s 23:14:52.414503 IP internal-proxy-0.canonical.com.3128 > autopkgtest.57518: Flags [.], ack 129, win 486, length 0 399s 23:14:52.611316 IP internal-proxy-0.canonical.com.3128 > autopkgtest.57518: Flags [P.], seq 1:531, ack 129, win 486, length 530 399s 23:14:52.611350 IP autopkgtest.57518 > internal-proxy-0.canonical.com.3128: Flags [.], ack 531, win 249, length 0 399s 23:14:52.611367 IP internal-proxy-0.canonical.com.3128 > autopkgtest.57518: Flags [P.], seq 531:802, ack 129, win 486, length 271 399s 23:14:52.611371 IP autopkgtest.57518 > internal-proxy-0.canonical.com.3128: Flags [.], ack 802, win 249, length 0 399s 23:14:52.611560 IP autopkgtest.57518 > internal-proxy-0.canonical.com.3128: Flags [F.], seq 129, ack 802, win 249, length 0 399s 23:14:52.611589 IP autopkgtest.ssh > 10.136.6.184.33482: Flags [P.], seq 1:125, ack 0, win 249, options [nop,nop,TS val 3951174048 ecr 3106969317], length 124 399s 23:14:52.675889 IP 10.136.6.184.33482 > autopkgtest.ssh: Flags [.], ack 125, win 24567, options [nop,nop,TS val 3106969670 ecr 3951174048], length 0 399s 23:14:52.676355 IP internal-proxy-0.canonical.com.3128 > autopkgtest.57518: Flags [F.], seq 802, ack 130, win 486, length 0 399s 23:14:52.676368 IP autopkgtest.57518 > internal-proxy-0.canonical.com.3128: Flags [.], ack 803, win 249, length 0 399s 23:14:52.817563 ARP, Request who-has 10.145.243.213 tell _gateway, length 28 399s 23:14:53.161679 IP6 fe80::fc16:3eff:fed6:e450 > ip6-allrouters: ICMP6, router solicitation, length 16 399s 23:14:57.429908 ARP, Request who-has 10.145.243.20 tell _gateway, length 28 399s 23:15:01.785515 ARP, Request who-has 10.145.243.213 tell _gateway, length 28 399s 23:15:07.674082 ARP, Request who-has 10.145.243.187 tell _gateway, length 28 399s 23:15:08.990762 IP autopkgtest.36423 > prod-ntp-4.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 399s 23:15:09.060326 IP prod-ntp-4.ntp1.ps5.canonical.com.ntp > autopkgtest.36423: NTPv4, Server, length 48 399s 23:15:09.355708 ARP, Request who-has 10.145.243.179 tell _gateway, length 28 399s 23:15:11.675283 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 399s 23:15:14.207287 ARP, Request who-has _gateway tell autopkgtest, length 28 399s 23:15:14.211917 ARP, Reply _gateway is-at fa:16:3e:8a:f0:cc (oui Unknown), length 28 399s 23:15:15.460348 ARP, Request who-has 10.145.243.174 tell _gateway, length 28 399s 23:15:15.460348 ARP, Request who-has 10.145.243.174 tell _gateway, length 28 399s 23:15:15.627137 ARP, Request who-has 10.145.243.174 tell _gateway, length 28 399s 23:15:15.914845 ARP, Request who-has 10.145.243.174 tell _gateway, length 28 399s 23:15:16.495820 ARP, Request who-has 10.145.243.174 tell _gateway, length 28 399s 23:15:17.612038 ARP, Request who-has 10.145.243.174 tell _gateway, length 28 399s 23:15:19.856019 ARP, Request who-has 10.145.243.174 tell _gateway, length 28 399s 23:15:19.963027 ARP, Request who-has 10.145.243.213 tell _gateway, length 28 399s 23:15:24.460951 ARP, Request who-has 10.145.243.174 tell _gateway, length 28 399s 23:15:30.784438 ARP, Request who-has 10.145.243.139 tell _gateway, length 28 399s 23:15:30.784439 ARP, Request who-has 10.145.243.139 tell _gateway, length 28 399s 23:15:30.952903 ARP, Request who-has 10.145.243.139 tell _gateway, length 28 399s 23:15:31.264511 ARP, Request who-has 10.145.243.139 tell _gateway, length 28 399s 23:15:31.839507 ARP, Request who-has 10.145.243.139 tell _gateway, length 28 399s 23:15:32.991713 ARP, Request who-has 10.145.243.139 tell _gateway, length 28 399s 23:15:33.420513 ARP, Request who-has 10.145.243.174 tell _gateway, length 28 400s 23:15:35.323765 ARP, Request who-has 10.145.243.139 tell _gateway, length 28 400s 23:15:39.932336 ARP, Request who-has 10.145.243.139 tell _gateway, length 28 400s 23:15:49.152599 ARP, Request who-has 10.145.243.139 tell _gateway, length 28 400s 23:15:50.253327 ARP, Request who-has 10.145.243.111 tell _gateway, length 28 400s 23:15:50.253327 ARP, Request who-has 10.145.243.111 tell _gateway, length 28 400s 23:15:50.417521 ARP, Request who-has 10.145.243.111 tell _gateway, length 28 400s 23:15:50.701287 ARP, Request who-has 10.145.243.111 tell _gateway, length 28 400s 23:15:51.277363 ARP, Request who-has 10.145.243.111 tell _gateway, length 28 400s 23:15:52.364987 ARP, Request who-has 10.145.243.174 tell _gateway, length 28 400s 23:15:52.396502 ARP, Request who-has 10.145.243.111 tell _gateway, length 28 400s 23:15:54.674098 ARP, Request who-has 10.145.243.111 tell _gateway, length 28 400s 23:15:56.659757 IP6 fe80::fc16:3eff:fed6:e450 > ip6-allrouters: ICMP6, router solicitation, length 16 400s 23:15:59.277082 ARP, Request who-has 10.145.243.111 tell _gateway, length 28 400s 23:16:00.551792 ARP, Request who-has 10.145.243.192 tell _gateway, length 28 400s 23:16:00.551792 ARP, Request who-has 10.145.243.192 tell _gateway, length 28 400s 23:16:00.712177 ARP, Request who-has 10.145.243.192 tell _gateway, length 28 400s 23:16:01.020432 ARP, Request who-has 10.145.243.192 tell _gateway, length 28 400s 23:16:01.601078 ARP, Request who-has 10.145.243.192 tell _gateway, length 28 400s 23:16:02.748600 ARP, Request who-has 10.145.243.192 tell _gateway, length 28 400s 23:16:05.020732 ARP, Request who-has 10.145.243.192 tell _gateway, length 28 400s 23:16:08.237937 ARP, Request who-has 10.145.243.111 tell _gateway, length 28 400s 23:16:09.116371 ARP, Request who-has 10.145.243.139 tell _gateway, length 28 400s 23:16:09.628249 ARP, Request who-has 10.145.243.192 tell _gateway, length 28 400s 23:16:13.225748 IP autopkgtest.36904 > prod-ntp-4.ntp1.ps5.canonical.com.ntp: NTPv4, Client, length 48 400s 23:16:13.307516 IP prod-ntp-4.ntp1.ps5.canonical.com.ntp > autopkgtest.36904: NTPv4, Server, length 48 400s 23:16:17.444013 ARP, Request who-has 10.145.243.249 tell _gateway, length 28 400s 23:16:17.444014 ARP, Request who-has 10.145.243.249 tell _gateway, length 28 400s 23:16:17.611118 ARP, Request who-has 10.145.243.249 tell _gateway, length 28 400s 23:16:17.926184 ARP, Request who-has 10.145.243.249 tell _gateway, length 28 400s 23:16:18.463256 ARP, Request who-has _gateway tell autopkgtest, length 28 400s 23:16:18.467226 ARP, Reply _gateway is-at fa:16:3e:8a:f0:cc (oui Unknown), length 28 400s 23:16:18.493452 ARP, Request who-has 10.145.243.249 tell _gateway, length 28 400s 23:16:18.843535 ARP, Request who-has 10.145.243.192 tell _gateway, length 28 400s 23:16:19.647318 ARP, Request who-has 10.145.243.249 tell _gateway, length 28 400s 23:16:21.915691 ARP, Request who-has 10.145.243.249 tell _gateway, length 28 400s 23:16:23.185862 IP6 autopkgtest > ip6-allrouters: ICMP6, router solicitation, length 16 400s 23:16:26.522467 ARP, Request who-has 10.145.243.249 tell _gateway, length 28 400s 23:16:27.003625 ARP, Request who-has 10.145.243.84 tell _gateway, length 28 400s 23:16:27.003625 ARP, Request who-has 10.145.243.84 tell _gateway, length 28 400s 23:16:27.170753 ARP, Request who-has 10.145.243.84 tell _gateway, length 28 400s 23:16:27.183157 ARP, Request who-has 10.145.243.111 tell _gateway, length 28 400s 23:16:27.466968 ARP, Request who-has 10.145.243.84 tell _gateway, length 28 400s 23:16:28.042655 ARP, Request who-has 10.145.243.84 tell _gateway, length 28 400s 23:16:29.007514 ARP, Request who-has 10.145.243.185 tell _gateway, length 28 400s 23:16:29.007514 ARP, Request who-has 10.145.243.185 tell _gateway, length 28 400s 23:16:29.164875 ARP, Request who-has 10.145.243.185 tell _gateway, length 28 400s 23:16:29.194366 ARP, Request who-has 10.145.243.84 tell _gateway, length 28 400s 23:16:29.469842 ARP, Request who-has 10.145.243.185 tell _gateway, length 28 400s 23:16:30.040999 ARP, Request who-has 10.145.243.185 tell _gateway, length 28 400s 23:16:31.164101 ARP, Request who-has 10.145.243.185 tell _gateway, length 28 400s 23:16:31.530732 ARP, Request who-has 10.145.243.84 tell _gateway, length 28 400s 23:16:33.433009 ARP, Request who-has 10.145.243.185 tell _gateway, length 28 400s 23:16:35.741493 ARP, Request who-has 10.145.243.249 tell _gateway, length 28 400s 23:16:36.137875 ARP, Request who-has 10.145.243.84 tell _gateway, length 28 400s 23:16:37.784441 ARP, Request who-has 10.145.243.192 tell _gateway, length 28 400s 23:16:38.040354 ARP, Request who-has 10.145.243.185 tell _gateway, length 28 400s autopkgtest [23:17:54]: test run-example: -----------------------] 401s autopkgtest [23:17:55]: test run-example: - - - - - - - - - - results - - - - - - - - - - 401s run-example PASS 401s autopkgtest [23:17:55]: @@@@@@@@@@@@@@@@@@@@ summary 401s run-example PASS 413s Creating nova instance adt-noble-arm64-stenographer-20240306-231114-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-arm64-server-20240306.img (UUID 21ba16c8-2789-4dc0-bdfe-098da8d25327)...