0s autopkgtest [23:22:46]: starting date and time: 2025-07-07 23:22:46+0000 0s autopkgtest [23:22:46]: git checkout: 508d4a25 a-v-ssh wait_for_ssh: demote "ssh connection failed" to a debug message 0s autopkgtest [23:22:46]: host juju-7f2275-prod-proposed-migration-environment-21; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.c_wc1hp6/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-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-21@sto01-ppc64el-18.secgroup --name adt-questing-ppc64el-containerd-app-20250707-232246-juju-7f2275-prod-proposed-migration-environment-21-138695aa-0c31-44c0-8b66-37b5cba3f2bb --image adt/ubuntu-questing-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-21 --net-id=net_prod-autopkgtest-workers-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-questing-ppc64el-containerd-app-20250707-232246-juju-7f2275-prod-proposed-migration-environment-21-138695aa-0c31-44c0-8b66-37b5cba3f2bb from image adt/ubuntu-questing-ppc64el-server-20250707.img (UUID 8474c3c3-f147-4740-a7c9-57b5279c46a3)... 53s autopkgtest [23:23:38]: testbed dpkg architecture: ppc64el 53s autopkgtest [23:23:39]: testbed apt version: 3.1.3 54s autopkgtest [23:23:40]: @@@@@@@@@@@@@@@@@@@@ test bed setup 54s autopkgtest [23:23:40]: testbed release detected to be: None 55s autopkgtest [23:23:41]: updating testbed package index (apt update) 56s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [249 kB] 56s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 56s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 56s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 56s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [30.2 kB] 56s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [15.8 kB] 56s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [182 kB] 56s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el Packages [50.3 kB] 56s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe ppc64el Packages [145 kB] 56s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse ppc64el Packages [5356 B] 56s Fetched 678 kB in 0s (1590 kB/s) 57s Reading package lists... 57s autopkgtest [23:23:43]: upgrading testbed (apt dist-upgrade and autopurge) 58s Reading package lists... 58s Building dependency tree... 58s Reading state information... 58s Calculating upgrade... 58s The following packages will be upgraded: 58s apparmor libapparmor1 libnss-systemd libpam-systemd libsystemd-shared 58s libsystemd0 libudev1 libxml2-16 systemd systemd-cryptsetup systemd-resolved 58s systemd-sysv systemd-timesyncd udev 58s 14 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 58s Need to get 10.8 MB of archives. 58s After this operation, 79.9 kB of additional disk space will be used. 58s Get:1 http://ftpmaster.internal/ubuntu questing/main ppc64el libsystemd0 ppc64el 257.7-1ubuntu1 [662 kB] 58s Get:2 http://ftpmaster.internal/ubuntu questing/main ppc64el libnss-systemd ppc64el 257.7-1ubuntu1 [224 kB] 58s Get:3 http://ftpmaster.internal/ubuntu questing/main ppc64el systemd-sysv ppc64el 257.7-1ubuntu1 [11.9 kB] 58s Get:4 http://ftpmaster.internal/ubuntu questing/main ppc64el systemd-resolved ppc64el 257.7-1ubuntu1 [382 kB] 58s Get:5 http://ftpmaster.internal/ubuntu questing/main ppc64el libpam-systemd ppc64el 257.7-1ubuntu1 [341 kB] 58s Get:6 http://ftpmaster.internal/ubuntu questing/main ppc64el libsystemd-shared ppc64el 257.7-1ubuntu1 [2590 kB] 58s Get:7 http://ftpmaster.internal/ubuntu questing/main ppc64el systemd ppc64el 257.7-1ubuntu1 [3149 kB] 58s Get:8 http://ftpmaster.internal/ubuntu questing/main ppc64el systemd-timesyncd ppc64el 257.7-1ubuntu1 [44.0 kB] 58s Get:9 http://ftpmaster.internal/ubuntu questing/main ppc64el systemd-cryptsetup ppc64el 257.7-1ubuntu1 [131 kB] 58s Get:10 http://ftpmaster.internal/ubuntu questing/main ppc64el udev ppc64el 257.7-1ubuntu1 [1428 kB] 58s Get:11 http://ftpmaster.internal/ubuntu questing/main ppc64el libudev1 ppc64el 257.7-1ubuntu1 [234 kB] 58s Get:12 http://ftpmaster.internal/ubuntu questing/main ppc64el libapparmor1 ppc64el 4.1.1-0ubuntu3 [61.4 kB] 58s Get:13 http://ftpmaster.internal/ubuntu questing/main ppc64el libxml2-16 ppc64el 2.14.4+dfsg-0exp1 [691 kB] 58s Get:14 http://ftpmaster.internal/ubuntu questing/main ppc64el apparmor ppc64el 4.1.1-0ubuntu3 [813 kB] 59s Preconfiguring packages ... 59s Fetched 10.8 MB in 0s (23.5 MB/s) 59s (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 ... 117869 files and directories currently installed.) 59s Preparing to unpack .../libsystemd0_257.7-1ubuntu1_ppc64el.deb ... 59s Unpacking libsystemd0:ppc64el (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 59s Setting up libsystemd0:ppc64el (257.7-1ubuntu1) ... 59s (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 ... 117869 files and directories currently installed.) 59s Preparing to unpack .../libnss-systemd_257.7-1ubuntu1_ppc64el.deb ... 59s Unpacking libnss-systemd:ppc64el (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 59s Preparing to unpack .../systemd-sysv_257.7-1ubuntu1_ppc64el.deb ... 59s Unpacking systemd-sysv (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 59s Preparing to unpack .../systemd-resolved_257.7-1ubuntu1_ppc64el.deb ... 59s Unpacking systemd-resolved (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 59s Preparing to unpack .../libpam-systemd_257.7-1ubuntu1_ppc64el.deb ... 59s Unpacking libpam-systemd:ppc64el (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 59s Preparing to unpack .../libsystemd-shared_257.7-1ubuntu1_ppc64el.deb ... 59s Unpacking libsystemd-shared:ppc64el (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 59s Setting up libsystemd-shared:ppc64el (257.7-1ubuntu1) ... 60s (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 ... 117869 files and directories currently installed.) 60s Preparing to unpack .../systemd_257.7-1ubuntu1_ppc64el.deb ... 60s Unpacking systemd (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 60s Preparing to unpack .../systemd-timesyncd_257.7-1ubuntu1_ppc64el.deb ... 60s Unpacking systemd-timesyncd (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 60s Preparing to unpack .../systemd-cryptsetup_257.7-1ubuntu1_ppc64el.deb ... 60s Unpacking systemd-cryptsetup (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 60s Preparing to unpack .../udev_257.7-1ubuntu1_ppc64el.deb ... 60s Unpacking udev (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 60s Preparing to unpack .../libudev1_257.7-1ubuntu1_ppc64el.deb ... 60s Unpacking libudev1:ppc64el (257.7-1ubuntu1) over (257.6-1ubuntu1) ... 60s Setting up libudev1:ppc64el (257.7-1ubuntu1) ... 60s (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 ... 117870 files and directories currently installed.) 60s Preparing to unpack .../libapparmor1_4.1.1-0ubuntu3_ppc64el.deb ... 60s Unpacking libapparmor1:ppc64el (4.1.1-0ubuntu3) over (4.1.1-0ubuntu2) ... 60s Preparing to unpack .../libxml2-16_2.14.4+dfsg-0exp1_ppc64el.deb ... 60s Unpacking libxml2-16:ppc64el (2.14.4+dfsg-0exp1) over (2.14.3+dfsg-0exp3) ... 60s Preparing to unpack .../apparmor_4.1.1-0ubuntu3_ppc64el.deb ... 61s Unpacking apparmor (4.1.1-0ubuntu3) over (4.1.1-0ubuntu2) ... 62s Setting up libapparmor1:ppc64el (4.1.1-0ubuntu3) ... 62s Setting up libxml2-16:ppc64el (2.14.4+dfsg-0exp1) ... 62s Setting up systemd (257.7-1ubuntu1) ... 62s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 62s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 62s Setting up apparmor (4.1.1-0ubuntu3) ... 62s Installing new version of config file /etc/apparmor.d/lsusb ... 62s Installing new version of config file /etc/apparmor.d/mbsync ... 63s Reloading AppArmor profiles 65s Setting up systemd-cryptsetup (257.7-1ubuntu1) ... 65s Setting up systemd-timesyncd (257.7-1ubuntu1) ... 65s systemd-time-wait-sync.service is a disabled or a static unit not running, not starting it. 65s Setting up udev (257.7-1ubuntu1) ... 66s Creating group 'clock' with GID 987. 66s Setting up systemd-resolved (257.7-1ubuntu1) ... 67s Setting up systemd-sysv (257.7-1ubuntu1) ... 67s Setting up libnss-systemd:ppc64el (257.7-1ubuntu1) ... 67s Setting up libpam-systemd:ppc64el (257.7-1ubuntu1) ... 67s Processing triggers for libc-bin (2.41-6ubuntu2) ... 67s Processing triggers for man-db (2.13.1-1) ... 68s Processing triggers for dbus (1.16.2-2ubuntu1) ... 68s Processing triggers for shared-mime-info (2.4-5build2) ... 69s Processing triggers for procps (2:4.0.4-8ubuntu2) ... 69s Processing triggers for initramfs-tools (0.149ubuntu1) ... 69s update-initramfs: Generating /boot/initrd.img-6.15.0-3-generic 80s Reading package lists... 80s Building dependency tree... 80s Reading state information... 80s Solving dependencies... 80s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 80s autopkgtest [23:24:06]: rebooting testbed after setup commands that affected boot 107s autopkgtest [23:24:33]: testbed running kernel: Linux 6.15.0-3-generic #3-Ubuntu SMP Wed Jun 4 08:35:52 UTC 2025 109s autopkgtest [23:24:35]: @@@@@@@@@@@@@@@@@@@@ apt-source containerd-app 112s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main containerd-app 2.1.3-0ubuntu1 (dsc) [2146 B] 112s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main containerd-app 2.1.3-0ubuntu1 (tar) [10.6 MB] 112s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/main containerd-app 2.1.3-0ubuntu1 (diff) [13.9 kB] 113s gpgv: Signature made Mon Jul 7 18:12:56 2025 UTC 113s gpgv: using RSA key 439884E6862A429C290DF63B033C4CA276024834 113s gpgv: issuer "athos.ribeiro@canonical.com" 113s gpgv: Can't check signature: No public key 113s dpkg-source: warning: cannot verify inline signature for ./containerd-app_2.1.3-0ubuntu1.dsc: no acceptable signature found 113s autopkgtest [23:24:39]: testing package containerd-app version 2.1.3-0ubuntu1 114s autopkgtest [23:24:40]: build not needed 119s autopkgtest [23:24:45]: test basic-smoke: preparing testbed 119s Reading package lists... 120s Building dependency tree... 120s Reading state information... 120s Solving dependencies... 120s The following NEW packages will be installed: 120s containerd runc 120s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 120s Need to get 32.7 MB of archives. 120s After this operation, 137 MB of additional disk space will be used. 120s Get:1 http://ftpmaster.internal/ubuntu questing/main ppc64el runc ppc64el 1.3.0-0ubuntu1 [8490 kB] 121s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main ppc64el containerd ppc64el 2.1.3-0ubuntu1 [24.2 MB] 123s Fetched 32.7 MB in 3s (10.3 MB/s) 123s Selecting previously unselected package runc. 124s (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 ... 117872 files and directories currently installed.) 124s Preparing to unpack .../runc_1.3.0-0ubuntu1_ppc64el.deb ... 124s Unpacking runc (1.3.0-0ubuntu1) ... 124s Selecting previously unselected package containerd. 124s Preparing to unpack .../containerd_2.1.3-0ubuntu1_ppc64el.deb ... 124s Unpacking containerd (2.1.3-0ubuntu1) ... 124s Setting up runc (1.3.0-0ubuntu1) ... 124s Setting up containerd (2.1.3-0ubuntu1) ... 124s Created symlink '/etc/systemd/system/multi-user.target.wants/containerd.service' → '/usr/lib/systemd/system/containerd.service'. 125s Processing triggers for man-db (2.13.1-1) ... 128s autopkgtest [23:24:54]: test basic-smoke: [----------------------- 129s + systemctl stop containerd 129s + export HTTP_PROXY=http://egress.ps7.internal:3128/ 129s + HTTP_PROXY=http://egress.ps7.internal:3128/ 129s + export HTTPS_PROXY=http://egress.ps7.internal:3128/ 129s + HTTPS_PROXY=http://egress.ps7.internal:3128/ 129s + ctr images pull docker.io/library/busybox:latest 129s + containerd 129s ctr: cannot access socket /run/containerd/containerd.sock: stat /run/containerd/containerd.sock: no such file or directory 129s time="2025-07-07T23:24:54.115107396Z" level=info msg="starting containerd" revision= version=2.1.3 129s /tmp/autopkgtest.vNxmq5/wrapper.sh: Killing leaked background processes: 1626 129s time="2025-07-07T23:24:54.129018363Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 129s time="2025-07-07T23:24:54.129134138Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 129s time="2025-07-07T23:24:54.129197621Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 129s time="2025-07-07T23:24:54.129300490Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 129s time="2025-07-07T23:24:54.129378257Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 129s time="2025-07-07T23:24:54.129406232Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 129s time="2025-07-07T23:24:54.129418541Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 129s time="2025-07-07T23:24:54.129569263Z" 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 129s time="2025-07-07T23:24:54.129584367Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 129s time="2025-07-07T23:24:54.129598455Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 129s time="2025-07-07T23:24:54.129609501Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 129s time="2025-07-07T23:24:54.129794353Z" 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 129s time="2025-07-07T23:24:54.129806904Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 129s time="2025-07-07T23:24:54.129830095Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 129s time="2025-07-07T23:24:54.129938269Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 129s time="2025-07-07T23:24:54.129964552Z" 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 129s time="2025-07-07T23:24:54.129988656Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 129s time="2025-07-07T23:24:54.130010646Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 129s time="2025-07-07T23:24:54.130248333Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 129s time="2025-07-07T23:24:54.130267853Z" level=info msg="metadata content store policy set" policy=shared 129s time="2025-07-07T23:24:54.130540654Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 129s time="2025-07-07T23:24:54.130657923Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 129s time="2025-07-07T23:24:54.130781818Z" 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 129s time="2025-07-07T23:24:54.130848343Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 129s time="2025-07-07T23:24:54.130907152Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 129s time="2025-07-07T23:24:54.130975826Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 129s time="2025-07-07T23:24:54.131042468Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 129s time="2025-07-07T23:24:54.131103560Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 129s time="2025-07-07T23:24:54.131164339Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 129s time="2025-07-07T23:24:54.131220142Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 129s time="2025-07-07T23:24:54.131285558Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 129s time="2025-07-07T23:24:54.131345187Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 129s time="2025-07-07T23:24:54.131400107Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 129s time="2025-07-07T23:24:54.131466458Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 129s time="2025-07-07T23:24:54.131554105Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 129s time="2025-07-07T23:24:54.131634115Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.131690750Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.131742582Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.131818482Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.131885546Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.131900986Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.131915291Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.131938613Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.131952558Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 129s time="2025-07-07T23:24:54.131980156Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 129s time="2025-07-07T23:24:54.132005107Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 129s time="2025-07-07T23:24:54.132050798Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" 129s time="2025-07-07T23:24:54.132063343Z" level=info msg="Start snapshots syncer" 129s time="2025-07-07T23:24:54.132134949Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 129s time="2025-07-07T23:24:54.132482632Z" 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\"}" 129s time="2025-07-07T23:24:54.132578931Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 129s time="2025-07-07T23:24:54.132713468Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 129s time="2025-07-07T23:24:54.132845451Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.132916064Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.132979005Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.133039158Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 129s time="2025-07-07T23:24:54.133102166Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.133161707Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.133216107Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.133288816Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.133343777Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 129s time="2025-07-07T23:24:54.133446765Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 129s time="2025-07-07T23:24:54.133535605Z" 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 129s time="2025-07-07T23:24:54.133598087Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 129s time="2025-07-07T23:24:54.133616005Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 129s time="2025-07-07T23:24:54.133627273Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 129s time="2025-07-07T23:24:54.133639863Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.133652816Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 129s time="2025-07-07T23:24:54.133667476Z" level=info msg="runtime interface created" 129s time="2025-07-07T23:24:54.133681111Z" level=info msg="created NRI interface" 129s time="2025-07-07T23:24:54.133693251Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 129s time="2025-07-07T23:24:54.133703634Z" level=info msg="Connect containerd service" 129s time="2025-07-07T23:24:54.133729427Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" 129s time="2025-07-07T23:24:54.134252666Z" 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" 129s PID TTY STAT TIME COMMAND 129s 1626 ? Sl 0:00 containerd 129s autopkgtest [23:24:55]: test basic-smoke: -----------------------] 130s autopkgtest [23:24:56]: test basic-smoke: - - - - - - - - - - results - - - - - - - - - - 130s basic-smoke FAIL non-zero exit status 1 130s autopkgtest [23:24:56]: @@@@@@@@@@@@@@@@@@@@ summary 130s basic-smoke FAIL non-zero exit status 1