0s autopkgtest [07:17:05]: starting date and time: 2025-05-02 07:17:05+0000 0s autopkgtest [07:17:05]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [07:17:05]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.fh3k1ta0/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:e2fsprogs,src:fuse3 --apt-upgrade ext4magic --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=e2fsprogs/1.47.2-1ubuntu2 fuse3/3.17.1+git250416-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-arm64-7.secgroup --name adt-questing-arm64-ext4magic-20250502-071705-juju-7f2275-prod-proposed-migration-environment-20-c634b655-a1d2-4c98-9be3-26d3760a2df7 --image adt/ubuntu-questing-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 122s autopkgtest [07:19:07]: testbed dpkg architecture: arm64 122s autopkgtest [07:19:07]: testbed apt version: 3.0.0 123s autopkgtest [07:19:08]: @@@@@@@@@@@@@@@@@@@@ test bed setup 123s autopkgtest [07:19:08]: testbed release detected to be: None 124s autopkgtest [07:19:09]: updating testbed package index (apt update) 124s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB] 124s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 125s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 125s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 125s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [184 kB] 125s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB] 125s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2202 kB] 125s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 Packages [227 kB] 125s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe arm64 Packages [1472 kB] 125s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse arm64 Packages [16.5 kB] 125s Fetched 4269 kB in 1s (3335 kB/s) 126s Reading package lists... 127s autopkgtest [07:19:12]: upgrading testbed (apt dist-upgrade and autopurge) 127s Reading package lists... 128s Building dependency tree... 128s Reading state information... 128s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 128s Starting 2 pkgProblemResolver with broken count: 0 128s Done 130s Entering ResolveByKeep 131s 131s Calculating upgrade... 131s The following NEW packages will be installed: 131s libfuse3-4 131s The following packages will be upgraded: 131s e2fsprogs e2fsprogs-l10n fuse3 libcom-err2 libext2fs2t64 libss2 logsave 132s 7 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 132s Need to get 1034 kB of archives. 132s After this operation, 375 kB of additional disk space will be used. 132s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 logsave arm64 1.47.2-1ubuntu2 [26.3 kB] 132s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 e2fsprogs-l10n all 1.47.2-1ubuntu2 [7036 B] 132s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 libext2fs2t64 arm64 1.47.2-1ubuntu2 [231 kB] 132s Get:4 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 e2fsprogs arm64 1.47.2-1ubuntu2 [609 kB] 132s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 libcom-err2 arm64 1.47.2-1ubuntu2 [26.4 kB] 132s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 libss2 arm64 1.47.2-1ubuntu2 [17.6 kB] 132s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 libfuse3-4 arm64 3.17.1+git250416-1 [90.5 kB] 132s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 fuse3 arm64 3.17.1+git250416-1 [26.7 kB] 133s Fetched 1034 kB in 1s (1805 kB/s) 133s (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 ... 117820 files and directories currently installed.) 133s Preparing to unpack .../logsave_1.47.2-1ubuntu2_arm64.deb ... 133s Unpacking logsave (1.47.2-1ubuntu2) over (1.47.2-1ubuntu1) ... 133s Preparing to unpack .../e2fsprogs-l10n_1.47.2-1ubuntu2_all.deb ... 133s Unpacking e2fsprogs-l10n (1.47.2-1ubuntu2) over (1.47.2-1ubuntu1) ... 133s Preparing to unpack .../libext2fs2t64_1.47.2-1ubuntu2_arm64.deb ... 133s Leaving 'diversion of /lib/aarch64-linux-gnu/libe2p.so.2 to /lib/aarch64-linux-gnu/libe2p.so.2.usr-is-merged by libext2fs2t64' 133s Leaving 'diversion of /lib/aarch64-linux-gnu/libe2p.so.2.3 to /lib/aarch64-linux-gnu/libe2p.so.2.3.usr-is-merged by libext2fs2t64' 133s Leaving 'diversion of /lib/aarch64-linux-gnu/libext2fs.so.2 to /lib/aarch64-linux-gnu/libext2fs.so.2.usr-is-merged by libext2fs2t64' 133s Leaving 'diversion of /lib/aarch64-linux-gnu/libext2fs.so.2.4 to /lib/aarch64-linux-gnu/libext2fs.so.2.4.usr-is-merged by libext2fs2t64' 133s Unpacking libext2fs2t64:arm64 (1.47.2-1ubuntu2) over (1.47.2-1ubuntu1) ... 133s Setting up libext2fs2t64:arm64 (1.47.2-1ubuntu2) ... 133s (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 ... 117820 files and directories currently installed.) 133s Preparing to unpack .../e2fsprogs_1.47.2-1ubuntu2_arm64.deb ... 133s Unpacking e2fsprogs (1.47.2-1ubuntu2) over (1.47.2-1ubuntu1) ... 134s Preparing to unpack .../libcom-err2_1.47.2-1ubuntu2_arm64.deb ... 134s Unpacking libcom-err2:arm64 (1.47.2-1ubuntu2) over (1.47.2-1ubuntu1) ... 134s Preparing to unpack .../libss2_1.47.2-1ubuntu2_arm64.deb ... 134s Unpacking libss2:arm64 (1.47.2-1ubuntu2) over (1.47.2-1ubuntu1) ... 134s Selecting previously unselected package libfuse3-4:arm64. 134s Preparing to unpack .../libfuse3-4_3.17.1+git250416-1_arm64.deb ... 134s Unpacking libfuse3-4:arm64 (3.17.1+git250416-1) ... 134s Preparing to unpack .../fuse3_3.17.1+git250416-1_arm64.deb ... 134s Adding 'diversion of /bin/fusermount to /bin/fusermount.usr-is-merged by fuse3' 134s Adding 'diversion of /sbin/mount.fuse to /sbin/mount.fuse.usr-is-merged by fuse3' 134s Unpacking fuse3 (3.17.1+git250416-1) over (3.14.0-10) ... 134s Setting up libcom-err2:arm64 (1.47.2-1ubuntu2) ... 134s Setting up libss2:arm64 (1.47.2-1ubuntu2) ... 134s Setting up logsave (1.47.2-1ubuntu2) ... 134s Setting up libfuse3-4:arm64 (3.17.1+git250416-1) ... 134s Setting up e2fsprogs (1.47.2-1ubuntu2) ... 134s update-initramfs: deferring update (trigger activated) 135s Setting up fuse3 (3.17.1+git250416-1) ... 135s Installing new version of config file /etc/fuse.conf ... 135s Removing 'diversion of /bin/fusermount to /bin/fusermount.usr-is-merged by fuse3' 135s Removing 'diversion of /sbin/mount.fuse to /sbin/mount.fuse.usr-is-merged by fuse3' 135s update-initramfs: deferring update (trigger activated) 135s Setting up e2fsprogs-l10n (1.47.2-1ubuntu2) ... 135s Processing triggers for man-db (2.13.0-1) ... 136s Processing triggers for initramfs-tools (0.147ubuntu1) ... 136s update-initramfs: Generating /boot/initrd.img-6.14.0-15-generic 136s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 160s System running in EFI mode, skipping. 160s Processing triggers for libc-bin (2.41-6ubuntu1) ... 160s Reading package lists... 160s Building dependency tree... 160s Reading state information... 161s Starting pkgProblemResolver with broken count: 0 161s Starting 2 pkgProblemResolver with broken count: 0 161s Done 161s Solving dependencies... 162s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 162s autopkgtest [07:19:47]: rebooting testbed after setup commands that affected boot 196s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 203s autopkgtest [07:20:28]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP PREEMPT_DYNAMIC Sun Apr 6 14:37:51 UTC 2025 206s autopkgtest [07:20:31]: @@@@@@@@@@@@@@@@@@@@ apt-source ext4magic 208s Get:1 http://ftpmaster.internal/ubuntu questing/universe ext4magic 0.3.2-14build2 (dsc) [2149 B] 208s Get:2 http://ftpmaster.internal/ubuntu questing/universe ext4magic 0.3.2-14build2 (tar) [427 kB] 208s Get:3 http://ftpmaster.internal/ubuntu questing/universe ext4magic 0.3.2-14build2 (diff) [175 kB] 208s gpgv: Signature made Mon Apr 1 05:55:08 2024 UTC 208s gpgv: using RSA key A089FB36AAFBDAD5ACC1325069F790171A210984 208s gpgv: Can't check signature: No public key 208s dpkg-source: warning: cannot verify inline signature for ./ext4magic_0.3.2-14build2.dsc: no acceptable signature found 208s autopkgtest [07:20:33]: testing package ext4magic version 0.3.2-14build2 209s autopkgtest [07:20:34]: build not needed 210s autopkgtest [07:20:35]: test command1: preparing testbed 210s Reading package lists... 210s Building dependency tree... 210s Reading state information... 211s Starting pkgProblemResolver with broken count: 0 211s Starting 2 pkgProblemResolver with broken count: 0 211s Done 211s The following NEW packages will be installed: 211s ext4magic 212s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 212s Need to get 106 kB of archives. 212s After this operation, 233 kB of additional disk space will be used. 212s Get:1 http://ftpmaster.internal/ubuntu questing/universe arm64 ext4magic arm64 0.3.2-14build2 [106 kB] 212s Fetched 106 kB in 0s (287 kB/s) 212s Selecting previously unselected package ext4magic. 213s (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 ... 117830 files and directories currently installed.) 213s Preparing to unpack .../ext4magic_0.3.2-14build2_arm64.deb ... 213s Unpacking ext4magic (0.3.2-14build2) ... 213s Setting up ext4magic (0.3.2-14build2) ... 213s Processing triggers for man-db (2.13.0-1) ... 214s autopkgtest [07:20:39]: test command1: ext4magic -V 214s autopkgtest [07:20:39]: test command1: [----------------------- 215s ext4magic version : 0.3.2 215s libext2fs version : 1.47.2 215s CPU is little endian. 215s Expert Mode is activ 215s autopkgtest [07:20:40]: test command1: -----------------------] 216s command1 PASS 216s autopkgtest [07:20:41]: test command1: - - - - - - - - - - results - - - - - - - - - - 216s autopkgtest [07:20:41]: test command2: preparing testbed 216s Reading package lists... 216s Building dependency tree... 216s Reading state information... 217s Starting pkgProblemResolver with broken count: 0 217s Starting 2 pkgProblemResolver with broken count: 0 217s Done 218s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 219s autopkgtest [07:20:44]: test command2: ext4magic debian/tests/test.img -M -d $AUTOPKGTEST_TMP 219s autopkgtest [07:20:44]: test command2: [----------------------- 220s Warning: Activate magic-scan or disaster-recovery function, may be some command line options ignored 220s "/tmp/autopkgtest.23z16k/autopkgtest_tmp" accept for recoverdir 220s Filesystem in use: debian/tests/test.img 220s 220s Using internal Journal at Inode 8 220s Activ Time after : Mon Dec 10 13:06:19 2018 220s Activ Time before : Fri May 2 07:20:44 2025 220s Inode 2 is allocated 220s -------- /tmp/autopkgtest.23z16k/autopkgtest_tmp/lost+found 220s -------- /tmp/autopkgtest.23z16k/autopkgtest_tmp/openlogo-50.png 220s -------- /tmp/autopkgtest.23z16k/autopkgtest_tmp/Debian25years-DanielLenharo.png 220s -------- /tmp/autopkgtest.23z16k/autopkgtest_tmp/ 220s MAGIC-1 : start lost directory search 220s MAGIC-2 : start lost file search 220s MAGIC-2 : start lost in journal search 220s -------- /tmp/autopkgtest.23z16k/autopkgtest_tmp/MAGIC-2/application/octet-stream/I_0000000263.unknown 220s -------- /tmp/autopkgtest.23z16k/autopkgtest_tmp/MAGIC-2/application/octet-stream/I_0000000271.unknown 220s MAGIC-3 : start ext4-magic-scan search 220s ext4magic : EXIT_SUCCESS 220s autopkgtest [07:20:45]: test command2: -----------------------] 221s autopkgtest [07:20:46]: test command2: - - - - - - - - - - results - - - - - - - - - - 221s command2 PASS 221s autopkgtest [07:20:46]: @@@@@@@@@@@@@@@@@@@@ summary 221s command1 PASS 221s command2 PASS 239s nova [W] Using flock in prodstack6-arm64 239s Creating nova instance adt-questing-arm64-ext4magic-20250502-071705-juju-7f2275-prod-proposed-migration-environment-20-c634b655-a1d2-4c98-9be3-26d3760a2df7 from image adt/ubuntu-questing-arm64-server-20250502.img (UUID a0b7b7fd-ad05-4ea9-97eb-0f52dbbe98e1)... 239s nova [W] Timed out waiting for 50ce7047-11c5-42ff-8994-12028d163ea5 to get deleted.