0s autopkgtest [22:29:39]: starting date and time: 2025-03-15 22:29:39+0000 0s autopkgtest [22:29:39]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [22:29:39]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.cmq1nh9l/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:grpc --apt-upgrade opensnitch --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=grpc/1.51.1-6 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-3.secgroup --name adt-plucky-arm64-opensnitch-20250315-222938-juju-7f2275-prod-proposed-migration-environment-2-c37d663b-89ff-4aae-909e-4ac275fd964d --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 113s autopkgtest [22:31:32]: testbed dpkg architecture: arm64 114s autopkgtest [22:31:33]: testbed apt version: 2.9.33 114s autopkgtest [22:31:33]: @@@@@@@@@@@@@@@@@@@@ test bed setup 115s autopkgtest [22:31:34]: testbed release detected to be: None 116s autopkgtest [22:31:35]: updating testbed package index (apt update) 116s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 117s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 117s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 117s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 117s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [14.5 kB] 117s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [44.1 kB] 117s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [369 kB] 117s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [73.9 kB] 117s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 c-n-f Metadata [1820 B] 117s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 c-n-f Metadata [116 B] 117s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [344 kB] 117s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 c-n-f Metadata [14.0 kB] 117s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [14.9 kB] 117s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 c-n-f Metadata [268 B] 117s Fetched 1002 kB in 1s (1137 kB/s) 118s Reading package lists... 119s Reading package lists... 119s Building dependency tree... 119s Reading state information... 120s Calculating upgrade... 120s Calculating upgrade... 120s The following packages will be upgraded: 120s pinentry-curses python3-jinja2 strace 120s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 120s Need to get 647 kB of archives. 120s After this operation, 11.3 kB of additional disk space will be used. 120s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 strace arm64 6.13+ds-1ubuntu1 [499 kB] 121s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 pinentry-curses arm64 1.3.1-2ubuntu3 [39.2 kB] 121s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 121s Fetched 647 kB in 1s (1176 kB/s) 122s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 117701 files and directories currently installed.) 122s Preparing to unpack .../strace_6.13+ds-1ubuntu1_arm64.deb ... 122s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 122s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_arm64.deb ... 122s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 122s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 122s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 122s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 122s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 122s Setting up strace (6.13+ds-1ubuntu1) ... 122s Processing triggers for man-db (2.13.0-1) ... 123s Reading package lists... 123s Building dependency tree... 123s Reading state information... 124s Solving dependencies... 124s The following packages will be REMOVED: 124s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 124s libunwind8* linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 124s linux-image-6.11.0-8-generic* linux-modules-6.11.0-8-generic* 124s linux-tools-6.11.0-8* linux-tools-6.11.0-8-generic* 124s 0 upgraded, 0 newly installed, 11 to remove and 0 not upgraded. 124s After this operation, 267 MB disk space will be freed. 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 ... 117701 files and directories currently installed.) 124s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 124s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 124s Removing libpython3.12t64:arm64 (3.12.9-1) ... 124s Removing libpython3.12-stdlib:arm64 (3.12.9-1) ... 125s Removing libnsl2:arm64 (1.3.0-3build3) ... 125s Removing libpython3.12-minimal:arm64 (3.12.9-1) ... 125s Removing libunwind8:arm64 (1.6.2-3.1) ... 125s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 125s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 127s Removing linux-image-6.11.0-8-generic (6.11.0-8.8) ... 127s I: /boot/vmlinuz.old is now a symlink to vmlinuz-6.14.0-10-generic 127s I: /boot/initrd.img.old is now a symlink to initrd.img-6.14.0-10-generic 127s /etc/kernel/postrm.d/initramfs-tools: 127s update-initramfs: Deleting /boot/initrd.img-6.11.0-8-generic 127s /etc/kernel/postrm.d/zz-flash-kernel: 127s flash-kernel: Kernel 6.11.0-8-generic has been removed. 127s flash-kernel: A higher version (6.14.0-10-generic) is still installed, no reflashing required. 127s /etc/kernel/postrm.d/zz-update-grub: 127s Sourcing file `/etc/default/grub' 127s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg' 127s Generating grub configuration file ... 128s Found linux image: /boot/vmlinuz-6.14.0-10-generic 128s Found initrd image: /boot/initrd.img-6.14.0-10-generic 128s Warning: os-prober will not be executed to detect other bootable partitions. 128s Systems on them will not be added to the GRUB boot configuration. 128s Check GRUB_DISABLE_OS_PROBER documentation entry. 128s Adding boot menu entry for UEFI Firmware Settings ... 128s done 128s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 128s Processing triggers for libc-bin (2.41-1ubuntu1) ... 129s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 81650 files and directories currently installed.) 129s Purging configuration files for linux-image-6.11.0-8-generic (6.11.0-8.8) ... 129s Purging configuration files for libpython3.12-minimal:arm64 (3.12.9-1) ... 129s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 129s autopkgtest [22:31:48]: upgrading testbed (apt dist-upgrade and autopurge) 129s Reading package lists... 129s Building dependency tree... 129s Reading state information... 130s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 130s Starting 2 pkgProblemResolver with broken count: 0 130s Done 131s Entering ResolveByKeep 131s 131s Calculating upgrade... 132s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 132s Reading package lists... 132s Building dependency tree... 132s Reading state information... 133s Starting pkgProblemResolver with broken count: 0 133s Starting 2 pkgProblemResolver with broken count: 0 133s Done 133s Solving dependencies... 134s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 134s autopkgtest [22:31:53]: rebooting testbed after setup commands that affected boot 157s autopkgtest [22:32:16]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP PREEMPT_DYNAMIC Wed Mar 12 15:45:31 UTC 2025 160s autopkgtest [22:32:19]: @@@@@@@@@@@@@@@@@@@@ apt-source opensnitch 163s Get:1 http://ftpmaster.internal/ubuntu plucky/universe opensnitch 1.5.8.1-2 (dsc) [2668 B] 163s Get:2 http://ftpmaster.internal/ubuntu plucky/universe opensnitch 1.5.8.1-2 (tar) [1054 kB] 163s Get:3 http://ftpmaster.internal/ubuntu plucky/universe opensnitch 1.5.8.1-2 (diff) [12.2 kB] 163s gpgv: Signature made Fri Aug 2 07:14:42 2024 UTC 163s gpgv: using RSA key D41A7AD07DF6C5FCA7489F1C29EEE2D6ECF442F9 163s gpgv: issuer "gibmat@debian.org" 163s gpgv: Can't check signature: No public key 163s dpkg-source: warning: cannot verify inline signature for ./opensnitch_1.5.8.1-2.dsc: no acceptable signature found 163s autopkgtest [22:32:22]: testing package opensnitch version 1.5.8.1-2 164s autopkgtest [22:32:23]: build not needed 164s autopkgtest [22:32:23]: test test-resources.sh: preparing testbed 164s Reading package lists... 165s Building dependency tree... 165s Reading state information... 165s Starting pkgProblemResolver with broken count: 0 165s Starting 2 pkgProblemResolver with broken count: 0 165s Done 166s The following NEW packages will be installed: 166s libnetfilter-queue1 opensnitch 166s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 166s Need to get 3559 kB of archives. 166s After this operation, 11.8 MB of additional disk space will be used. 166s Get:1 http://ftpmaster.internal/ubuntu plucky/universe arm64 libnetfilter-queue1 arm64 1.0.5-4build1 [14.9 kB] 166s Get:2 http://ftpmaster.internal/ubuntu plucky/universe arm64 opensnitch arm64 1.5.8.1-2 [3544 kB] 168s Fetched 3559 kB in 2s (1679 kB/s) 169s Selecting previously unselected package libnetfilter-queue1:arm64. 169s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 81647 files and directories currently installed.) 169s Preparing to unpack .../libnetfilter-queue1_1.0.5-4build1_arm64.deb ... 169s Unpacking libnetfilter-queue1:arm64 (1.0.5-4build1) ... 169s Selecting previously unselected package opensnitch. 169s Preparing to unpack .../opensnitch_1.5.8.1-2_arm64.deb ... 169s Unpacking opensnitch (1.5.8.1-2) ... 169s Setting up libnetfilter-queue1:arm64 (1.0.5-4build1) ... 169s Setting up opensnitch (1.5.8.1-2) ... 169s Created symlink '/etc/systemd/system/multi-user.target.wants/opensnitch.service' → '/usr/lib/systemd/system/opensnitch.service'. 170s Processing triggers for man-db (2.13.0-1) ... 170s Processing triggers for libc-bin (2.41-1ubuntu1) ... 171s autopkgtest [22:32:30]: test test-resources.sh: [----------------------- 171s installed OK: /etc/opensnitchd 171s installed OK: /etc/opensnitchd/system-fw.json 171s installed OK: /etc/opensnitchd/default-config.json 171s installed OK: /etc/opensnitchd/rules/ 172s autopkgtest [22:32:31]: test test-resources.sh: -----------------------] 172s autopkgtest [22:32:31]: test test-resources.sh: - - - - - - - - - - results - - - - - - - - - - 172s test-resources.sh PASS (superficial) 173s autopkgtest [22:32:32]: test test-fw-rules.sh: preparing testbed 173s Reading package lists... 173s Building dependency tree... 173s Reading state information... 174s Starting pkgProblemResolver with broken count: 0 174s Starting 2 pkgProblemResolver with broken count: 0 174s Done 174s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 175s autopkgtest [22:32:34]: test test-fw-rules.sh: [----------------------- 176s [+] PATH: /usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin 176s [+] loaded modules: 176s tcp_diag 12288 0 - Live 0xffffd804071e2000 176s inet_diag 28672 1 tcp_diag, Live 0xffffd804071d8000 176s nf_conntrack_netlink 57344 0 - Live 0xffffd804071c5000 176s xt_conntrack 12288 2 - Live 0xffffd8040718c000 176s nf_conntrack 204800 2 nf_conntrack_netlink,xt_conntrack, Live 0xffffd80407191000 176s nf_defrag_ipv6 24576 1 nf_conntrack, Live 0xffffd80407182000 176s nf_defrag_ipv4 12288 1 nf_conntrack, Live 0xffffd80407178000 176s xt_NFQUEUE 12288 4 - Live 0xffffd80407172000 176s nfnetlink_queue 32768 2 - Live 0xffffd8040715d000 176s xt_TCPMSS 12288 1 - Live 0xffffd80407157000 176s xt_tcpudp 20480 0 - Live 0xffffd8040714e000 176s nft_compat 24576 7 - Live 0xffffd80407164000 176s nf_tables 352256 43 nft_compat, Live 0xffffd804070f4000 176s cfg80211 1310720 0 - Live 0xffffd80406fb0000 176s aes_ce_blk 36864 0 - Live 0xffffd80406fa8000 176s aes_ce_cipher 12288 1 aes_ce_blk, Live 0xffffd80406f98000 176s polyval_ce 12288 0 - Live 0xffffd80406f9c000 176s polyval_generic 12288 1 polyval_ce, Live 0xffffd80406f92000 176s ghash_ce 24576 0 - Live 0xffffd80406f87000 176s sm4 12288 0 - Live 0xffffd80406f7e000 176s sha2_ce 20480 0 - Live 0xffffd80406f71000 176s sha256_arm64 24576 1 sha2_ce, Live 0xffffd80406f75000 176s sha1_ce 12288 0 - Live 0xffffd80406f6b000 176s binfmt_misc 28672 1 - Live 0xffffd80406f60000 176s nls_iso8859_1 12288 1 - Live 0xffffd80406f5a000 176s input_leds 12288 0 - Live 0xffffd80406f54000 176s sch_fq_codel 24576 2 - Live 0xffffd80406f4b000 176s efi_pstore 12288 0 - Live 0xffffd80406f45000 176s dm_multipath 49152 0 - Live 0xffffd80406f35000 176s nfnetlink 24576 8 nf_conntrack_netlink,nfnetlink_queue,nft_compat,nf_tables, Live 0xffffd80406f26000 176s vsock_loopback 12288 0 - Live 0xffffd80406f2f000 176s vmw_vsock_virtio_transport_common 61440 1 vsock_loopback, Live 0xffffd80406f0e000 176s vmw_vsock_vmci_transport 45056 0 - Live 0xffffd80406f17000 176s vmw_vmci 106496 1 vmw_vsock_vmci_transport, Live 0xffffd80406ef5000 176s vsock 61440 5 vsock_loopback,vmw_vsock_virtio_transport_common,vmw_vsock_vmci_transport, Live 0xffffd80406eb8000 176s dmi_sysfs 24576 0 - Live 0xffffd80406edd000 176s qemu_fw_cfg 24576 0 - Live 0xffffd80406ea1000 176s ip_tables 36864 0 - Live 0xffffd80406ec2000 176s x_tables 65536 6 xt_conntrack,xt_NFQUEUE,xt_TCPMSS,xt_tcpudp,nft_compat,ip_tables, Live 0xffffd80406ea6000 176s autofs4 61440 2 - Live 0xffffd80406e94000 176s btrfs 1982464 0 - Live 0xffffd80406caf000 176s blake2b_generic 24576 0 - Live 0xffffd80406ca6000 176s xor 12288 1 btrfs, Live 0xffffd80406c9c000 176s xor_neon 16384 1 xor, Live 0xffffd80406c90000 176s raid6_pq 110592 1 btrfs, Live 0xffffd80406c2e000 176s hid_generic 12288 0 - Live 0xffffd80406c05000 176s usbhid 77824 0 - Live 0xffffd80406c62000 176s hid 274432 2 hid_generic,usbhid, Live 0xffffd80406be3000 176s arm_smccc_trng 12288 0 - Live 0xffffd80406bdf000 176s virtio_rng 12288 0 - Live 0xffffd80406c35000 176s virtio_gpu 98304 0 - Live 0xffffd80406c0e000 176s virtio_dma_buf 12288 1 virtio_gpu, Live 0xffffd80406bd9000 176s [+] opensnitchd log: 176s [2025-03-15 22:32:29]  IMP  Start writing logs to /var/log/opensnitchd.log 176s [2025-03-15 22:32:29]  ERR  eBPF Failed to load /etc/opensnitchd/opensnitch.o: open /etc/opensnitchd/opensnitch.o: no such file or directory 176s [2025-03-15 22:32:29]  WAR  error starting ebpf monitor method: open /etc/opensnitchd/opensnitch.o: no such file or directory 176s [2025-03-15 22:32:29]  WAR  Unable to set new process monitor method from disk: open /etc/opensnitchd/opensnitch.o: no such file or directory 176s Chain OUTPUT (policy ACCEPT) 176s target prot opt source destination 176s opensnitch-filter-OUTPUT all -- anywhere anywhere 176s NFQUEUE all -- anywhere anywhere ctstate NEW,RELATED NFQUEUE num 0 bypass 176s NFQUEUE all -- anywhere anywhere ctstate NEW,RELATED NFQUEUE num 0 bypass 176s [+] Interception rule (iptables): OK 176s autopkgtest [22:32:35]: test test-fw-rules.sh: -----------------------] 176s autopkgtest [22:32:35]: test test-fw-rules.sh: - - - - - - - - - - results - - - - - - - - - - 176s test-fw-rules.sh PASS 177s autopkgtest [22:32:36]: @@@@@@@@@@@@@@@@@@@@ summary 177s test-resources.sh PASS (superficial) 177s test-fw-rules.sh PASS 195s nova [W] Using flock in prodstack6-arm64 195s Creating nova instance adt-plucky-arm64-opensnitch-20250315-222938-juju-7f2275-prod-proposed-migration-environment-2-c37d663b-89ff-4aae-909e-4ac275fd964d from image adt/ubuntu-plucky-arm64-server-20250315.img (UUID bd6e766c-b51f-4b53-86d6-23aa4d18f524)... 195s nova [W] Timed out waiting for e79fdcb7-5f8a-487a-bdf5-2dd4511a2796 to get deleted.