0s autopkgtest [23:22:39]: starting date and time: 2025-07-07 23:22:39+0000 0s autopkgtest [23:22:39]: git checkout: 508d4a25 a-v-ssh wait_for_ssh: demote "ssh connection failed" to a debug message 0s autopkgtest [23:22:39]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.3uzsnsp2/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:containerd-app --apt-upgrade containerd-app --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=containerd-app/2.1.3-0ubuntu1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-amd64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-14.secgroup --name adt-questing-amd64-containerd-app-20250707-232239-juju-7f2275-prod-proposed-migration-environment-2-f3174385-4d2c-49fb-8110-5922bdd87567 --image adt/ubuntu-questing-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 97s Creating nova instance adt-questing-amd64-containerd-app-20250707-232239-juju-7f2275-prod-proposed-migration-environment-2-f3174385-4d2c-49fb-8110-5922bdd87567 from image adt/ubuntu-questing-amd64-server-20250707.img (UUID 4588178a-8ca7-4b44-aac8-789fb940340e)... 188s autopkgtest [23:25:47]: testbed dpkg architecture: amd64 188s autopkgtest [23:25:47]: testbed apt version: 3.1.3 189s autopkgtest [23:25:48]: @@@@@@@@@@@@@@@@@@@@ test bed setup 201s autopkgtest [23:26:00]: testbed release detected to be: None 201s autopkgtest [23:26:00]: updating testbed package index (apt update) 202s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [249 kB] 202s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 202s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 202s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 202s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [15.8 kB] 202s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [30.2 kB] 202s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [182 kB] 202s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main i386 Packages [39.1 kB] 202s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/main amd64 Packages [53.1 kB] 202s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/universe i386 Packages [102 kB] 202s Get:11 http://ftpmaster.internal/ubuntu questing-proposed/universe amd64 Packages [169 kB] 202s Get:12 http://ftpmaster.internal/ubuntu questing-proposed/multiverse i386 Packages [8856 B] 202s Get:13 http://ftpmaster.internal/ubuntu questing-proposed/multiverse amd64 Packages [17.5 kB] 202s Fetched 866 kB in 1s (1521 kB/s) 203s Reading package lists... 210s autopkgtest [23:26:09]: upgrading testbed (apt dist-upgrade and autopurge) 220s Reading package lists... 220s Building dependency tree... 220s Reading state information... 220s Calculating upgrade... 221s The following packages will be upgraded: 221s apparmor libapparmor1 libnss-systemd libpam-systemd libsystemd-shared 221s libsystemd0 libudev1 libxml2-16 systemd systemd-cryptsetup systemd-resolved 221s systemd-sysv systemd-timesyncd udev 221s 14 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 221s Need to get 9700 kB of archives. 221s After this operation, 47.1 kB of additional disk space will be used. 221s Get:1 http://ftpmaster.internal/ubuntu questing/main amd64 libsystemd0 amd64 257.7-1ubuntu1 [526 kB] 221s Get:2 http://ftpmaster.internal/ubuntu questing/main amd64 libnss-systemd amd64 257.7-1ubuntu1 [173 kB] 221s Get:3 http://ftpmaster.internal/ubuntu questing/main amd64 systemd-sysv amd64 257.7-1ubuntu1 [11.9 kB] 221s Get:4 http://ftpmaster.internal/ubuntu questing/main amd64 systemd-resolved amd64 257.7-1ubuntu1 [328 kB] 221s Get:5 http://ftpmaster.internal/ubuntu questing/main amd64 libpam-systemd amd64 257.7-1ubuntu1 [257 kB] 221s Get:6 http://ftpmaster.internal/ubuntu questing/main amd64 libsystemd-shared amd64 257.7-1ubuntu1 [2292 kB] 221s Get:7 http://ftpmaster.internal/ubuntu questing/main amd64 systemd amd64 257.7-1ubuntu1 [2980 kB] 221s Get:8 http://ftpmaster.internal/ubuntu questing/main amd64 systemd-timesyncd amd64 257.7-1ubuntu1 [41.5 kB] 221s Get:9 http://ftpmaster.internal/ubuntu questing/main amd64 systemd-cryptsetup amd64 257.7-1ubuntu1 [123 kB] 221s Get:10 http://ftpmaster.internal/ubuntu questing/main amd64 udev amd64 257.7-1ubuntu1 [1416 kB] 221s Get:11 http://ftpmaster.internal/ubuntu questing/main amd64 libudev1 amd64 257.7-1ubuntu1 [205 kB] 221s Get:12 http://ftpmaster.internal/ubuntu questing/main amd64 libapparmor1 amd64 4.1.1-0ubuntu3 [55.9 kB] 221s Get:13 http://ftpmaster.internal/ubuntu questing/main amd64 libxml2-16 amd64 2.14.4+dfsg-0exp1 [606 kB] 221s Get:14 http://ftpmaster.internal/ubuntu questing/main amd64 apparmor amd64 4.1.1-0ubuntu3 [686 kB] 222s Preconfiguring packages ... 222s Fetched 9700 kB in 1s (12.5 MB/s) 222s (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 ... 120968 files and directories currently installed.) 222s Preparing to unpack .../libsystemd0_257.7-1ubuntu1_amd64.deb ... 222s Unpacking libsystemd0:amd64 (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 222s Setting up libsystemd0:amd64 (257.7-1ubuntu1) ... 222s (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 ... 120968 files and directories currently installed.) 222s Preparing to unpack .../libnss-systemd_257.7-1ubuntu1_amd64.deb ... 222s Unpacking libnss-systemd:amd64 (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 222s Preparing to unpack .../systemd-sysv_257.7-1ubuntu1_amd64.deb ... 222s Unpacking systemd-sysv (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 222s Preparing to unpack .../systemd-resolved_257.7-1ubuntu1_amd64.deb ... 222s Unpacking systemd-resolved (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 222s Preparing to unpack .../libpam-systemd_257.7-1ubuntu1_amd64.deb ... 222s Unpacking libpam-systemd:amd64 (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 222s Preparing to unpack .../libsystemd-shared_257.7-1ubuntu1_amd64.deb ... 222s Unpacking libsystemd-shared:amd64 (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 222s Setting up libsystemd-shared:amd64 (257.7-1ubuntu1) ... 222s (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 ... 120968 files and directories currently installed.) 222s Preparing to unpack .../systemd_257.7-1ubuntu1_amd64.deb ... 222s Unpacking systemd (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 222s Preparing to unpack .../systemd-timesyncd_257.7-1ubuntu1_amd64.deb ... 222s Unpacking systemd-timesyncd (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 222s Preparing to unpack .../systemd-cryptsetup_257.7-1ubuntu1_amd64.deb ... 222s Unpacking systemd-cryptsetup (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 222s Preparing to unpack .../udev_257.7-1ubuntu1_amd64.deb ... 222s Unpacking udev (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 222s Preparing to unpack .../libudev1_257.7-1ubuntu1_amd64.deb ... 222s Unpacking libudev1:amd64 (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 222s Setting up libudev1:amd64 (257.7-1ubuntu1) ... 222s (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 ... 120969 files and directories currently installed.) 222s Preparing to unpack .../libapparmor1_4.1.1-0ubuntu3_amd64.deb ... 222s Unpacking libapparmor1:amd64 (4.1.1-0ubuntu3) over (4.1.1-0ubuntu2) ... 222s Preparing to unpack .../libxml2-16_2.14.4+dfsg-0exp1_amd64.deb ... 222s Unpacking libxml2-16:amd64 (2.14.4+dfsg-0exp1) over (2.14.3+dfsg-0exp3) ... 223s Preparing to unpack .../apparmor_4.1.1-0ubuntu3_amd64.deb ... 223s Unpacking apparmor (4.1.1-0ubuntu3) over (4.1.1-0ubuntu2) ... 223s Setting up libapparmor1:amd64 (4.1.1-0ubuntu3) ... 223s Setting up libxml2-16:amd64 (2.14.4+dfsg-0exp1) ... 223s Setting up systemd (257.7-1ubuntu1) ... 223s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 223s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 224s Setting up apparmor (4.1.1-0ubuntu3) ... 224s Installing new version of config file /etc/apparmor.d/lsusb ... 224s Installing new version of config file /etc/apparmor.d/mbsync ... 224s Reloading AppArmor profiles 225s Setting up systemd-cryptsetup (257.7-1ubuntu1) ... 225s Setting up systemd-timesyncd (257.7-1ubuntu1) ... 226s systemd-time-wait-sync.service is a disabled or a static unit not running, not starting it. 226s Setting up udev (257.7-1ubuntu1) ... 226s Creating group 'clock' with GID 987. 226s Setting up systemd-resolved (257.7-1ubuntu1) ... 227s Setting up systemd-sysv (257.7-1ubuntu1) ... 227s Setting up libnss-systemd:amd64 (257.7-1ubuntu1) ... 227s Setting up libpam-systemd:amd64 (257.7-1ubuntu1) ... 227s Processing triggers for libc-bin (2.41-6ubuntu2) ... 227s Processing triggers for man-db (2.13.1-1) ... 228s Processing triggers for dbus (1.16.2-2ubuntu1) ... 228s Processing triggers for shared-mime-info (2.4-5build2) ... 228s Processing triggers for procps (2:4.0.4-8ubuntu2) ... 228s Processing triggers for initramfs-tools (0.149ubuntu1) ... 228s update-initramfs: Generating /boot/initrd.img-6.15.0-3-generic 228s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 236s Reading package lists... 236s Building dependency tree... 236s Reading state information... 236s Solving dependencies... 236s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 237s autopkgtest [23:26:36]: rebooting testbed after setup commands that affected boot 296s autopkgtest [23:27:35]: testbed running kernel: Linux 6.15.0-3-generic #3-Ubuntu SMP PREEMPT_DYNAMIC Wed Jun 4 08:34:48 UTC 2025 324s autopkgtest [23:28:03]: @@@@@@@@@@@@@@@@@@@@ apt-source containerd-app 326s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main containerd-app 2.1.3-0ubuntu1 (dsc) [2146 B] 326s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main containerd-app 2.1.3-0ubuntu1 (tar) [10.6 MB] 326s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/main containerd-app 2.1.3-0ubuntu1 (diff) [13.9 kB] 326s gpgv: Signature made Mon Jul 7 18:12:56 2025 UTC 326s gpgv: using RSA key 439884E6862A429C290DF63B033C4CA276024834 326s gpgv: issuer "athos.ribeiro@canonical.com" 326s gpgv: Can't check signature: No public key 326s dpkg-source: warning: cannot verify inline signature for ./containerd-app_2.1.3-0ubuntu1.dsc: no acceptable signature found 327s autopkgtest [23:28:06]: testing package containerd-app version 2.1.3-0ubuntu1 345s autopkgtest [23:28:24]: build not needed 352s autopkgtest [23:28:31]: test basic-smoke: preparing testbed 352s Reading package lists... 352s Building dependency tree... 352s Reading state information... 352s Solving dependencies... 353s The following NEW packages will be installed: 353s containerd runc 353s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 353s Need to get 36.5 MB of archives. 353s After this operation, 137 MB of additional disk space will be used. 353s Get:1 http://ftpmaster.internal/ubuntu questing/main amd64 runc amd64 1.3.0-0ubuntu1 [9441 kB] 353s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main amd64 containerd amd64 2.1.3-0ubuntu1 [27.1 MB] 355s Fetched 36.5 MB in 2s (20.9 MB/s) 355s Selecting previously unselected package runc. 355s (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 ... 120971 files and directories currently installed.) 355s Preparing to unpack .../runc_1.3.0-0ubuntu1_amd64.deb ... 355s Unpacking runc (1.3.0-0ubuntu1) ... 355s Selecting previously unselected package containerd. 355s Preparing to unpack .../containerd_2.1.3-0ubuntu1_amd64.deb ... 355s Unpacking containerd (2.1.3-0ubuntu1) ... 355s Setting up runc (1.3.0-0ubuntu1) ... 355s Setting up containerd (2.1.3-0ubuntu1) ... 355s Created symlink '/etc/systemd/system/multi-user.target.wants/containerd.service' → '/usr/lib/systemd/system/containerd.service'. 356s Processing triggers for man-db (2.13.1-1) ... 364s autopkgtest [23:28:43]: test basic-smoke: [----------------------- 364s + systemctl stop containerd 364s + export HTTP_PROXY=http://egress.ps7.internal:3128/ 364s + HTTP_PROXY=http://egress.ps7.internal:3128/ 364s + export HTTPS_PROXY=http://egress.ps7.internal:3128/ 364s + HTTPS_PROXY=http://egress.ps7.internal:3128/ 364s + ctr images pull docker.io/library/busybox:latest 364s + containerd 364s ctr: cannot access socket /run/containerd/containerd.sock: stat /run/containerd/containerd.sock: no such file or directory 364s time="2025-07-07T23:28:42.828965088Z" level=info msg="starting containerd" revision= version=2.1.3 364s /tmp/autopkgtest.OJeehe/wrapper.sh: Killing leaked background processes: 1516 364s time="2025-07-07T23:28:42.836568356Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 364s time="2025-07-07T23:28:42.836671882Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 364s time="2025-07-07T23:28:42.836720985Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 364s time="2025-07-07T23:28:42.836779884Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 364s time="2025-07-07T23:28:42.836830029Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.836880965Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.837028457Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.837173765Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.837181346Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.837188176Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.837192833Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.837328216Z" level=info msg="skip loading plugin" error="EROFS unsupported, please `modprobe erofs`: skip plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.837337190Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.837352623Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.837413134Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.837428597Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 364s time="2025-07-07T23:28:42.837434065Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 364s time="2025-07-07T23:28:42.837463119Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 364s time="2025-07-07T23:28:42.837728116Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 364s time="2025-07-07T23:28:42.837746985Z" level=info msg="metadata content store policy set" policy=shared 364s time="2025-07-07T23:28:42.839358082Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 364s time="2025-07-07T23:28:42.839384972Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 364s time="2025-07-07T23:28:42.839423290Z" level=info msg="skip loading plugin" error="could not find mkfs.erofs: exec: \"mkfs.erofs\": executable file not found in $PATH: skip plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 364s time="2025-07-07T23:28:42.839432484Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 364s time="2025-07-07T23:28:42.839445253Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 364s time="2025-07-07T23:28:42.839455668Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 364s time="2025-07-07T23:28:42.839467787Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 364s time="2025-07-07T23:28:42.839476480Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 364s time="2025-07-07T23:28:42.839486204Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 364s time="2025-07-07T23:28:42.839496329Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 364s time="2025-07-07T23:28:42.839505744Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 364s time="2025-07-07T23:28:42.839511723Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 364s time="2025-07-07T23:28:42.839517251Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 364s time="2025-07-07T23:28:42.839540416Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 364s time="2025-07-07T23:28:42.839583030Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 364s time="2025-07-07T23:28:42.839592193Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.839603370Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.839609760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.839615368Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.839621657Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.839628578Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.839634206Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.839639915Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.839645744Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 364s time="2025-07-07T23:28:42.839666925Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 364s time="2025-07-07T23:28:42.839684662Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 364s time="2025-07-07T23:28:42.839745433Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" 364s time="2025-07-07T23:28:42.839757121Z" level=info msg="Start snapshots syncer" 364s time="2025-07-07T23:28:42.839776159Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 364s time="2025-07-07T23:28:42.839900566Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\"},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":false,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" 364s time="2025-07-07T23:28:42.839955088Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 364s time="2025-07-07T23:28:42.840010861Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 364s time="2025-07-07T23:28:42.840048308Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.840066425Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.840076820Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.840083440Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 364s time="2025-07-07T23:28:42.840090351Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.840096470Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.840103140Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.840113425Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.840119635Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 364s time="2025-07-07T23:28:42.840140606Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 364s time="2025-07-07T23:28:42.840147727Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 364s time="2025-07-07T23:28:42.840152624Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 364s time="2025-07-07T23:28:42.840157391Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 364s time="2025-07-07T23:28:42.840161728Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 364s time="2025-07-07T23:28:42.840170651Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.840180276Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 364s time="2025-07-07T23:28:42.840196210Z" level=info msg="runtime interface created" 364s time="2025-07-07T23:28:42.840200586Z" level=info msg="created NRI interface" 364s time="2025-07-07T23:28:42.840205684Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 364s time="2025-07-07T23:28:42.840210731Z" level=info msg="Connect containerd service" 364s time="2025-07-07T23:28:42.840225664Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" 364s time="2025-07-07T23:28:42.841010772Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" 364s PID TTY STAT TIME COMMAND 364s 1516 ? Sl 0:00 containerd 365s autopkgtest [23:28:44]: test basic-smoke: -----------------------] 365s autopkgtest [23:28:44]: test basic-smoke: - - - - - - - - - - results - - - - - - - - - - 365s basic-smoke FAIL non-zero exit status 1 365s autopkgtest [23:28:44]: @@@@@@@@@@@@@@@@@@@@ summary 365s basic-smoke FAIL non-zero exit status 1