0s autopkgtest [00:39:14]: starting date and time: 2025-06-20 00:39:14+0000 0s autopkgtest [00:39:14]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [00:39:14]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.dmtm0vt1/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:procps --apt-upgrade dahdi-linux --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=procps/2:4.0.4-8ubuntu1 -- 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-21.secgroup --name adt-questing-amd64-dahdi-linux-20250619-233448-juju-7f2275-prod-proposed-migration-environment-2-42d09514-0402-40fc-9b40-a389222131ad --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/ 45s autopkgtest [00:39:59]: testbed dpkg architecture: amd64 45s autopkgtest [00:39:59]: testbed apt version: 3.1.2 45s autopkgtest [00:39:59]: @@@@@@@@@@@@@@@@@@@@ test bed setup 45s autopkgtest [00:39:59]: testbed release detected to be: None 46s autopkgtest [00:40:00]: updating testbed package index (apt update) 46s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [249 kB] 46s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 46s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 46s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 46s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/restricted Sources [6836 B] 46s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [16.8 kB] 46s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [444 kB] 46s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [31.8 kB] 46s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/main amd64 Packages [70.5 kB] 46s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/main i386 Packages [34.7 kB] 46s Get:11 http://ftpmaster.internal/ubuntu questing-proposed/restricted i386 Packages [3816 B] 46s Get:12 http://ftpmaster.internal/ubuntu questing-proposed/restricted amd64 Packages [18.7 kB] 46s Get:13 http://ftpmaster.internal/ubuntu questing-proposed/universe amd64 Packages [394 kB] 46s Get:14 http://ftpmaster.internal/ubuntu questing-proposed/universe i386 Packages [145 kB] 46s Get:15 http://ftpmaster.internal/ubuntu questing-proposed/multiverse amd64 Packages [29.6 kB] 46s Get:16 http://ftpmaster.internal/ubuntu questing-proposed/multiverse i386 Packages [7020 B] 46s Fetched 1452 kB in 1s (2634 kB/s) 47s Reading package lists... 48s autopkgtest [00:40:02]: upgrading testbed (apt dist-upgrade and autopurge) 48s Reading package lists... 48s Building dependency tree... 48s Reading state information... 48s Calculating upgrade... 48s The following packages will be upgraded: 48s bash gcc-15-base libatomic1 libgcc-s1 libproc2-0 libstdc++6 procps 48s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 48s Need to get 2526 kB of archives. 48s After this operation, 31.7 kB disk space will be freed. 48s Get:1 http://ftpmaster.internal/ubuntu questing/main amd64 bash amd64 5.2.37-2ubuntu4 [801 kB] 48s Get:2 http://ftpmaster.internal/ubuntu questing/main amd64 libatomic1 amd64 15.1.0-8ubuntu1 [10.5 kB] 48s Get:3 http://ftpmaster.internal/ubuntu questing/main amd64 gcc-15-base amd64 15.1.0-8ubuntu1 [55.5 kB] 48s Get:4 http://ftpmaster.internal/ubuntu questing/main amd64 libstdc++6 amd64 15.1.0-8ubuntu1 [813 kB] 48s Get:5 http://ftpmaster.internal/ubuntu questing/main amd64 libgcc-s1 amd64 15.1.0-8ubuntu1 [78.1 kB] 48s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main amd64 libproc2-0 amd64 2:4.0.4-8ubuntu1 [58.9 kB] 48s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main amd64 procps amd64 2:4.0.4-8ubuntu1 [709 kB] 49s Fetched 2526 kB in 0s (6052 kB/s) 49s (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 ... 81475 files and directories currently installed.) 49s Preparing to unpack .../bash_5.2.37-2ubuntu4_amd64.deb ... 49s Unpacking bash (5.2.37-2ubuntu4) over (5.2.37-2ubuntu1) ... 49s Setting up bash (5.2.37-2ubuntu4) ... 49s Installing new version of config file /etc/bash.bashrc ... 49s update-alternatives: using /usr/share/man/man7/bash-builtins.7.gz to provide /usr/share/man/man7/builtins.7.gz (builtins.7.gz) in auto mode 49s (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 ... 81475 files and directories currently installed.) 49s Preparing to unpack .../libatomic1_15.1.0-8ubuntu1_amd64.deb ... 49s Unpacking libatomic1:amd64 (15.1.0-8ubuntu1) over (15.1.0-5ubuntu1) ... 49s Preparing to unpack .../gcc-15-base_15.1.0-8ubuntu1_amd64.deb ... 49s Unpacking gcc-15-base:amd64 (15.1.0-8ubuntu1) over (15.1.0-5ubuntu1) ... 49s Setting up gcc-15-base:amd64 (15.1.0-8ubuntu1) ... 49s (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 ... 81475 files and directories currently installed.) 49s Preparing to unpack .../libstdc++6_15.1.0-8ubuntu1_amd64.deb ... 49s Unpacking libstdc++6:amd64 (15.1.0-8ubuntu1) over (15.1.0-5ubuntu1) ... 49s Setting up libstdc++6:amd64 (15.1.0-8ubuntu1) ... 49s (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 ... 81475 files and directories currently installed.) 49s Preparing to unpack .../libgcc-s1_15.1.0-8ubuntu1_amd64.deb ... 49s Unpacking libgcc-s1:amd64 (15.1.0-8ubuntu1) over (15.1.0-5ubuntu1) ... 49s Setting up libgcc-s1:amd64 (15.1.0-8ubuntu1) ... 49s (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 ... 81475 files and directories currently installed.) 49s Preparing to unpack .../libproc2-0_2%3a4.0.4-8ubuntu1_amd64.deb ... 49s Unpacking libproc2-0:amd64 (2:4.0.4-8ubuntu1) over (2:4.0.4-7ubuntu1) ... 49s Preparing to unpack .../procps_2%3a4.0.4-8ubuntu1_amd64.deb ... 50s Unpacking procps (2:4.0.4-8ubuntu1) over (2:4.0.4-7ubuntu1) ... 50s Setting up libproc2-0:amd64 (2:4.0.4-8ubuntu1) ... 50s Setting up libatomic1:amd64 (15.1.0-8ubuntu1) ... 50s Setting up procps (2:4.0.4-8ubuntu1) ... 50s Processing triggers for install-info (7.1.1-1) ... 50s Processing triggers for libc-bin (2.41-6ubuntu2) ... 50s Processing triggers for systemd (257.6-1ubuntu1) ... 50s Processing triggers for man-db (2.13.1-1) ... 51s Processing triggers for debianutils (5.23.1) ... 51s Reading package lists... 52s Building dependency tree... 52s Reading state information... 52s Solving dependencies... 52s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 52s autopkgtest [00:40:06]: rebooting testbed after setup commands that affected boot 56s autopkgtest-virt-ssh [00:40:10]: copydown destination failed, status 255 60s autopkgtest-virt-ssh [00:40:14]: ------- nova console-log 92d66376-e66e-4dd1-bfd4-aea6b31d32fd (adt-questing-amd64-dahdi-linux-20250619-233448-juju-7f2275-prod-proposed-migration-environment-2-42d09514-0402-40fc-9b40-a389222131ad) ------ 60s [ 0.000000] Linux version 6.14.0-15-generic (buildd@lcy02-amd64-022) (x86_64-linux-gnu-gcc-14 (Ubuntu 14.2.0-19ubuntu2) 14.2.0, GNU ld (GNU Binutils for Ubuntu) 2.44) #15-Ubuntu SMP PREEMPT_DYNAMIC Sun Apr 6 15:05:05 UTC 2025 (Ubuntu 6.14.0-15.15-generic 6.14.0) 60s [ 0.000000] Command line: BOOT_IMAGE=/vmlinuz-6.14.0-15-generic root=UUID=5a33bdfc-ef95-4523-bad4-c54b854623bc ro console=tty0 console=hvc0 console=ttyS0 60s [ 0.000000] KERNEL supported cpus: 60s [ 0.000000] Intel GenuineIntel 60s [ 0.000000] AMD AuthenticAMD 60s [ 0.000000] Hygon HygonGenuine 60s [ 0.000000] Centaur CentaurHauls 60s [ 0.000000] zhaoxin Shanghai 60s [ 0.000000] BIOS-provided physical RAM map: 60s [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable 60s [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved 60s [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved 60s [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdcfff] usable 60s [ 0.000000] BIOS-e820: [mem 0x00000000bffdd000-0x00000000bfffffff] reserved 60s [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved 60s [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved 60s [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable 60s [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved 60s [ 0.000000] NX (Execute Disable) protection: active 60s [ 0.000000] APIC: Static calls initialized 60s [ 0.000000] SMBIOS 3.0.0 present. 60s [ 0.000000] DMI: OpenStack Foundation OpenStack Nova, BIOS 1.16.3-debian-1.16.3-2~backport22.04.202412060920~ubuntu22.04.1 04/01/2014 60s [ 0.000000] DMI: Memory slots populated: 1/1 60s [ 0.000000] Hypervisor detected: KVM 60s [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 60s [ 0.000000] kvm-clock: using sched offset of 2072892628 cycles 60s [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns 60s [ 0.000005] tsc: Detected 2396.400 MHz processor 60s [ 0.000847] last_pfn = 0x140000 max_arch_pfn = 0x400000000 60s [ 0.000887] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs 60s [ 0.000890] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT 60s [ 0.000947] last_pfn = 0xbffdd max_arch_pfn = 0x400000000 60s [ 0.003208] found SMP MP-table at [mem 0x000f53c0-0x000f53cf] 60s [ 0.003222] Using GB pages for direct mapping 60s [ 0.003353] RAMDISK: [mem 0x2f64b000-0x33b1cfff] 60s [ 0.003801] ACPI: Early table checksum verification disabled 60s [ 0.003804] ACPI: RSDP 0x00000000000F5130 000014 (v00 BOCHS ) 60s [ 0.003810] ACPI: RSDT 0x00000000BFFE1C3F 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) 60s [ 0.003815] ACPI: FACP 0x00000000BFFE1A5B 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) 60s [ 0.003819] ACPI: DSDT 0x00000000BFFE0040 001A1B (v01 BOCHS BXPC 00000001 BXPC 00000001) 60s [ 0.003821] ACPI: FACS 0x00000000BFFE0000 000040 60s [ 0.003822] ACPI: APIC 0x00000000BFFE1ACF 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) 60s [ 0.003824] ACPI: SRAT 0x00000000BFFE1B4F 0000C8 (v01 BOCHS BXPC 00000001 BXPC 00000001) 60s [ 0.003826] ACPI: WAET 0x00000000BFFE1C17 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) 60s [ 0.003828] ACPI: Reserving FACP table memory at [mem 0xbffe1a5b-0xbffe1ace] 60s [ 0.003829] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe1a5a] 60s [ 0.003829] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] 60s [ 0.003830] ACPI: Reserving APIC table memory at [mem 0xbffe1acf-0xbffe1b4e] 60s [ 0.003831] ACPI: Reserving SRAT table memory at [mem 0xbffe1b4f-0xbffe1c16] 60s [ 0.003831] ACPI: Reserving WAET table memory at [mem 0xbffe1c17-0xbffe1c3e] 60s [ 0.003889] ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x0009ffff] 60s [ 0.003891] ACPI: SRAT: Node 0 PXM 0 [mem 0x00100000-0xbfffffff] 60s [ 0.003892] ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x13fffffff] 60s [ 0.003895] NUMA: Node 0 [mem 0x00001000-0x0009ffff] + [mem 0x00100000-0xbfffffff] -> [mem 0x00001000-0xbfffffff] 60s [ 0.003896] NUMA: Node 0 [mem 0x00001000-0xbfffffff] + [mem 0x100000000-0x13fffffff] -> [mem 0x00001000-0x13fffffff] 60s [ 0.003905] NODE_DATA(0) allocated [mem 0x13ffd3680-0x13fffdfff] 60s [ 0.004093] Zone ranges: 60s [ 0.004094] DMA [mem 0x0000000000001000-0x0000000000ffffff] 60s [ 0.004095] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] 60s [ 0.004096] Normal [mem 0x0000000100000000-0x000000013fffffff] 60s [ 0.004097] Device empty 60s [ 0.004098] Movable zone start for each node 60s [ 0.004100] Early memory node ranges 60s [ 0.004101] node 0: [mem 0x0000000000001000-0x000000000009efff] 60s [ 0.004102] node 0: [mem 0x0000000000100000-0x00000000bffdcfff] 60s [ 0.004103] node 0: [mem 0x0000000100000000-0x000000013fffffff] 60s [ 0.004104] Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] 60s [ 0.004109] On node 0, zone DMA: 1 pages in unavailable ranges 60s [ 0.004126] On node 0, zone DMA: 97 pages in unavailable ranges 60s [ 0.008366] On node 0, zone Normal: 35 pages in unavailable ranges 60s [ 0.008758] ACPI: PM-Timer IO Port: 0x608 60s [ 0.008767] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) 60s [ 0.008795] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 60s [ 0.008798] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) 60s [ 0.008799] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) 60s [ 0.008800] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) 60s [ 0.008801] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) 60s [ 0.008801] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) 60s [ 0.008804] ACPI: Using ACPI (MADT) for SMP configuration information 60s [ 0.008808] CPU topo: Max. logical packages: 2 60s [ 0.008809] CPU topo: Max. logical dies: 2 60s [ 0.008809] CPU topo: Max. dies per package: 1 60s [ 0.008813] CPU topo: Max. threads per core: 1 60s [ 0.008813] CPU topo: Num. cores per package: 1 60s [ 0.008814] CPU topo: Num. threads per package: 1 60s [ 0.008814] CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs 60s [ 0.008827] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() 60s [ 0.008846] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] 60s [ 0.008847] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x0009ffff] 60s [ 0.008848] PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000effff] 60s [ 0.008849] PM: hibernation: Registered nosave memory: [mem 0x000f0000-0x000fffff] 60s [ 0.008849] PM: hibernation: Registered nosave memory: [mem 0xbffdd000-0xbfffffff] 60s [ 0.008850] PM: hibernation: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] 60s [ 0.008851] PM: hibernation: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] 60s [ 0.008851] PM: hibernation: Registered nosave memory: [mem 0xff000000-0xfffbffff] 60s [ 0.008852] PM: hibernation: Registered nosave memory: [mem 0xfffc0000-0xffffffff] 60s [ 0.008853] [mem 0xc0000000-0xfeffbfff] available for PCI devices 60s [ 0.008854] Booting paravirtualized kernel on KVM 60s [ 0.008855] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns 60s [ 0.008862] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 60s [ 0.008963] percpu: Embedded 88 pages/cpu s237568 r8192 d114688 u1048576 60s [ 0.008989] kvm-guest: PV spinlocks disabled, no host support 60s [ 0.008990] Kernel command line: BOOT_IMAGE=/vmlinuz-6.14.0-15-generic root=UUID=5a33bdfc-ef95-4523-bad4-c54b854623bc ro console=tty0 console=hvc0 console=ttyS0 60s [ 0.009039] Unknown kernel command line parameters "BOOT_IMAGE=/vmlinuz-6.14.0-15-generic", will be passed to user space. 60s [ 0.009050] random: crng init done 60s [ 0.009050] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes 60s [ 0.009174] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) 60s [ 0.009238] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) 60s [ 0.009261] Fallback order for Node 0: 0 60s [ 0.009263] Built 1 zonelists, mobility grouping on. Total pages: 1048443 60s [ 0.009264] Policy zone: Normal 60s [ 0.009270] mem auto-init: stack:all(zero), heap alloc:on, heap free:off 60s [ 0.009273] software IO TLB: area num 2. 60s [ 0.019783] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 60s [ 0.019815] ftrace: allocating 60578 entries in 237 pages 60s [ 0.044946] ftrace: allocated 237 pages with 6 groups 60s [ 0.045787] Dynamic Preempt: voluntary 60s [ 0.045825] rcu: Preemptible hierarchical RCU implementation. 60s [ 0.045826] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=2. 60s [ 0.045827] Trampoline variant of Tasks RCU enabled. 60s [ 0.045828] Rude variant of Tasks RCU enabled. 60s [ 0.045828] Tracing variant of Tasks RCU enabled. 60s [ 0.045829] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. 60s [ 0.045830] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 60s [ 0.045837] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. 60s [ 0.045838] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. 60s [ 0.045839] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. 60s [ 0.049817] NR_IRQS: 524544, nr_irqs: 440, preallocated irqs: 16 60s [ 0.050043] rcu: srcu_init: Setting srcu_struct sizes based on contention. 60s [ 0.060426] Console: colour VGA+ 80x25 60s [ 0.060431] printk: legacy console [tty0] enabled 60s [ 0.104051] printk: legacy console [ttyS0] enabled 60s [ 0.213782] ACPI: Core revision 20240827 60s [ 0.214646] APIC: Switch to symmetric I/O mode setup 60s [ 0.215774] x2apic enabled 60s [ 0.216649] APIC: Switched APIC routing to: physical x2apic 60s [ 0.218810] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 60s [ 0.219882] tsc: Marking TSC unstable due to TSCs unsynchronized 60s [ 0.220932] Calibrating delay loop (skipped) preset value.. 4792.80 BogoMIPS (lpj=2396400) 60s [ 0.222447] x86/cpu: User Mode Instruction Prevention (UMIP) activated 60s [ 0.223998] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 60s [ 0.224930] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 60s [ 0.225933] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization 60s [ 0.227357] Spectre V2 : Mitigation: Retpolines 60s [ 0.228185] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch 60s [ 0.229356] Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT 60s [ 0.230929] Spectre V2 : Enabling Speculation Barrier for firmware calls 60s [ 0.231930] RETBleed: Mitigation: untrained return thunk 60s [ 0.232932] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier 60s [ 0.234361] Speculative Store Bypass: Vulnerable 60s [ 0.235180] Speculative Return Stack Overflow: IBPB-extending microcode not applied! 60s [ 0.236930] Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. 60s [ 0.236931] Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode 60s [ 0.243936] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' 60s [ 0.245338] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' 60s [ 0.246929] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' 60s [ 0.247930] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 60s [ 0.248930] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. 60s [ 0.281188] Freeing SMP alternatives memory: 48K 60s [ 0.281932] pid_max: default: 32768 minimum: 301 60s [ 0.282977] LSM: initializing lsm=lockdown,capability,landlock,yama,apparmor,ima,evm 60s [ 0.284369] landlock: Up and running. 60s [ 0.284931] Yama: becoming mindful. 60s [ 0.285645] AppArmor: AppArmor initialized 60s [ 0.286223] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 60s [ 0.287935] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 60s [ 0.391809] smpboot: CPU0: AMD EPYC-Rome Processor (family: 0x17, model: 0x31, stepping: 0x0) 60s [ 0.392740] Performance Events: Fam17h+ core perfctr, AMD PMU driver. 60s [ 0.393933] ... version: 0 60s [ 0.394681] ... bit width: 48 60s [ 0.395173] ... generic registers: 6 60s [ 0.396175] ... value mask: 0000ffffffffffff 60s [ 0.397211] ... max period: 00007fffffffffff 60s [ 0.397930] ... fixed-purpose events: 0 60s [ 0.398930] ... event mask: 000000000000003f 60s [ 0.399975] signal: max sigframe size: 1776 60s [ 0.400799] rcu: Hierarchical SRCU implementation. 60s [ 0.401196] rcu: Max phase no-delay instances is 400. 60s [ 0.402263] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level 60s [ 0.407823] smp: Bringing up secondary CPUs ... 60s [ 0.408344] smpboot: x86: Booting SMP configuration: 60s [ 0.409201] .... node #0, CPUs: #1 60s [ 0.410018] smp: Brought up 1 node, 2 CPUs 60s [ 0.411933] smpboot: Total of 2 processors activated (9585.60 BogoMIPS) 60s [ 0.413419] Memory: 3923560K/4193772K available (21770K kernel code, 4579K rwdata, 15936K rodata, 5096K init, 4468K bss, 263308K reserved, 0K cma-reserved) 60s [ 0.414676] devtmpfs: initialized 60s [ 0.415233] x86/mm: Memory block size: 128MB 60s [ 0.417130] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns 60s [ 0.418944] futex hash table entries: 512 (order: 3, 32768 bytes, linear) 60s [ 0.420004] pinctrl core: initialized pinctrl subsystem 60s [ 0.421095] PM: RTC time: 00:39:31, date: 2025-06-20 60s [ 0.422666] NET: Registered PF_NETLINK/PF_ROUTE protocol family 60s [ 0.423959] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations 60s [ 0.425285] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations 60s [ 0.426953] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations 60s [ 0.428360] audit: initializing netlink subsys (disabled) 60s [ 0.429244] audit: type=2000 audit(1750379972.250:1): state=initialized audit_enabled=0 res=1 60s [ 0.429244] thermal_sys: Registered thermal governor 'fair_share' 60s [ 0.430931] thermal_sys: Registered thermal governor 'bang_bang' 60s [ 0.431931] thermal_sys: Registered thermal governor 'step_wise' 60s [ 0.432931] thermal_sys: Registered thermal governor 'user_space' 60s [ 0.433931] thermal_sys: Registered thermal governor 'power_allocator' 60s [ 0.435247] EISA bus registered 60s [ 0.436941] cpuidle: using governor ladder 60s [ 0.437705] cpuidle: using governor menu 60s [ 0.439071] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 60s [ 0.440395] PCI: Using configuration type 1 for base access 60s [ 0.441217] PCI: Using configuration type 1 for extended access 60s [ 0.442407] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. 60s [ 0.456382] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages 60s [ 0.457277] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page 60s [ 0.459249] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages 60s [ 0.459930] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page 60s [ 0.461929] ACPI: Added _OSI(Module Device) 60s [ 0.462180] ACPI: Added _OSI(Processor Device) 60s [ 0.463193] ACPI: Added _OSI(3.0 _SCP Extensions) 60s [ 0.464200] ACPI: Added _OSI(Processor Aggregator Device) 60s [ 0.466971] ACPI: 1 ACPI AML tables successfully acquired and loaded 60s [ 0.470543] ACPI: Interpreter enabled 60s [ 0.470951] ACPI: PM: (supports S0 S3 S4 S5) 60s [ 0.472187] ACPI: Using IOAPIC for interrupt routing 60s [ 0.473421] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug 60s [ 0.474931] PCI: Using E820 reservations for host bridge windows 60s [ 0.476377] ACPI: Enabled 2 GPEs in block 00 to 0F 60s [ 0.481104] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) 60s [ 0.481935] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI EDR HPX-Type3] 60s [ 0.484394] acpiphp: Slot [3] registered 60s [ 0.484954] acpiphp: Slot [4] registered 60s [ 0.485710] acpiphp: Slot [5] registered 60s [ 0.486193] acpiphp: Slot [6] registered 60s [ 0.487191] acpiphp: Slot [7] registered 60s [ 0.488189] acpiphp: Slot [8] registered 60s [ 0.488948] acpiphp: Slot [9] registered 60s [ 0.489696] acpiphp: Slot [10] registered 60s [ 0.490193] acpiphp: Slot [11] registered 60s [ 0.491193] acpiphp: Slot [12] registered 60s [ 0.491948] acpiphp: Slot [13] registered 60s [ 0.492711] acpiphp: Slot [14] registered 60s [ 0.493188] acpiphp: Slot [15] registered 60s [ 0.494191] acpiphp: Slot [16] registered 60s [ 0.494948] acpiphp: Slot [17] registered 60s [ 0.495948] acpiphp: Slot [18] registered 60s [ 0.496718] acpiphp: Slot [19] registered 60s [ 0.497195] acpiphp: Slot [20] registered 60s [ 0.498188] acpiphp: Slot [21] registered 60s [ 0.498949] acpiphp: Slot [22] registered 60s [ 0.499721] acpiphp: Slot [23] registered 60s [ 0.500193] acpiphp: Slot [24] registered 60s [ 0.501187] acpiphp: Slot [25] registered 60s [ 0.502190] acpiphp: Slot [26] registered 60s [ 0.503206] acpiphp: Slot [27] registered 60s [ 0.503948] acpiphp: Slot [28] registered 60s [ 0.504948] acpiphp: Slot [29] registered 60s [ 0.505735] acpiphp: Slot [30] registered 60s [ 0.506198] acpiphp: Slot [31] registered 60s [ 0.507189] PCI host bridge to bus 0000:00 60s [ 0.507934] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] 60s [ 0.509264] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] 60s [ 0.510256] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] 60s [ 0.511343] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] 60s [ 0.512931] pci_bus 0000:00: root bus resource [mem 0xc000000000-0xc07fffffff window] 60s [ 0.514353] pci_bus 0000:00: root bus resource [bus 00-ff] 60s [ 0.515378] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint 60s [ 0.517394] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint 60s [ 0.519477] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint 60s [ 0.521606] pci 0000:00:01.1: BAR 4 [io 0xc180-0xc18f] 60s [ 0.523242] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk 60s [ 0.523931] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk 60s [ 0.524931] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk 60s [ 0.526251] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk 60s [ 0.527425] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint 60s [ 0.529237] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI 60s [ 0.530337] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB 60s [ 0.532481] pci 0000:00:02.0: [1b36:0100] type 00 class 0x030000 conventional PCI endpoint 60s [ 0.537945] pci 0000:00:02.0: BAR 0 [mem 0xf4000000-0xf7ffffff] 60s [ 0.538940] pci 0000:00:02.0: BAR 1 [mem 0xf8000000-0xfbffffff] 60s [ 0.540240] pci 0000:00:02.0: BAR 2 [mem 0xfc090000-0xfc091fff] 60s [ 0.541233] pci 0000:00:02.0: BAR 3 [io 0xc140-0xc15f] 60s [ 0.542222] pci 0000:00:02.0: ROM [mem 0xfc080000-0xfc08ffff pref] 60s [ 0.543287] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] 60s [ 0.545190] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint 60s [ 0.547415] pci 0000:00:03.0: BAR 0 [io 0xc080-0xc0bf] 60s [ 0.548214] pci 0000:00:03.0: BAR 1 [mem 0xfc092000-0xfc092fff] 60s [ 0.549255] pci 0000:00:03.0: BAR 4 [mem 0xc000000000-0xc000003fff 64bit pref] 60s [ 0.550342] pci 0000:00:03.0: ROM [mem 0xfc000000-0xfc07ffff pref] 60s [ 0.553650] pci 0000:00:04.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint 60s [ 0.556939] pci 0000:00:04.0: BAR 0 [io 0xc0c0-0xc0ff] 60s [ 0.557218] pci 0000:00:04.0: BAR 1 [mem 0xfc093000-0xfc093fff] 60s [ 0.558250] pci 0000:00:04.0: BAR 4 [mem 0xc000004000-0xc000007fff 64bit pref] 60s [ 0.562227] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint 60s [ 0.564549] pci 0000:00:05.0: BAR 0 [io 0xc000-0xc07f] 60s [ 0.566215] pci 0000:00:05.0: BAR 1 [mem 0xfc094000-0xfc094fff] 60s [ 0.566943] pci 0000:00:05.0: BAR 4 [mem 0xc000008000-0xc00000bfff 64bit pref] 60s [ 0.569906] pci 0000:00:06.0: [1af4:1002] type 00 class 0x00ff00 conventional PCI endpoint 60s [ 0.572175] pci 0000:00:06.0: BAR 0 [io 0xc100-0xc13f] 60s [ 0.572963] pci 0000:00:06.0: BAR 4 [mem 0xc00000c000-0xc00000ffff 64bit pref] 60s [ 0.576082] pci 0000:00:07.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint 60s [ 0.581776] pci 0000:00:07.0: BAR 0 [io 0xc160-0xc17f] 60s [ 0.582215] pci 0000:00:07.0: BAR 1 [mem 0xfc095000-0xfc095fff] 60s [ 0.584253] pci 0000:00:07.0: BAR 4 [mem 0xc000010000-0xc000013fff 64bit pref] 60s [ 0.594211] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 60s [ 0.595398] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 60s [ 0.596364] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 60s [ 0.597366] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 60s [ 0.599012] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 60s [ 0.600952] iommu: Default domain type: Translated 60s [ 0.601201] iommu: DMA domain TLB invalidation policy: lazy mode 60s [ 0.602463] SCSI subsystem initialized 60s [ 0.603971] ACPI: bus type USB registered 60s [ 0.604192] usbcore: registered new interface driver usbfs 60s [ 0.605222] usbcore: registered new interface driver hub 60s [ 0.606217] usbcore: registered new device driver usb 60s [ 0.606955] pps_core: LinuxPPS API ver. 1 registered 60s [ 0.607930] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti 60s [ 0.609395] PTP clock support registered 60s [ 0.610970] EDAC MC: Ver: 3.0.0 60s [ 0.611932] NetLabel: Initializing 60s [ 0.612161] NetLabel: domain hash size = 128 60s [ 0.613186] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 60s [ 0.614240] NetLabel: unlabeled traffic allowed by default 60s [ 0.615270] mctp: management component transport protocol core 60s [ 0.616227] NET: Registered PF_MCTP protocol family 60s [ 0.617220] PCI: Using ACPI for IRQ routing 60s [ 0.618114] pci 0000:00:02.0: vgaarb: setting as boot VGA device 60s [ 0.618929] pci 0000:00:02.0: vgaarb: bridge control possible 60s [ 0.618929] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none 60s [ 0.621933] vgaarb: loaded 60s [ 0.622979] clocksource: Switched to clocksource kvm-clock 60s [ 0.625045] VFS: Disk quotas dquot_6.6.0 60s [ 0.625794] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 60s [ 0.627214] AppArmor: AppArmor Filesystem Enabled 60s [ 0.628122] pnp: PnP ACPI init 60s [ 0.629117] pnp: PnP ACPI: found 5 devices 60s [ 0.636019] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns 60s [ 0.637667] NET: Registered PF_INET protocol family 60s [ 0.638603] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) 60s [ 0.655573] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) 60s [ 0.657159] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 60s [ 0.658609] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) 60s [ 0.660154] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) 60s [ 0.661833] TCP: Hash tables configured (established 32768 bind 32768) 60s [ 0.663033] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear) 60s [ 0.664402] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) 60s [ 0.665637] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) 60s [ 0.667087] NET: Registered PF_UNIX/PF_LOCAL protocol family 60s [ 0.668112] NET: Registered PF_XDP protocol family 60s [ 0.668998] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] 60s [ 0.670089] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] 60s [ 0.671176] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] 60s [ 0.672367] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] 60s [ 0.673632] pci_bus 0000:00: resource 8 [mem 0xc000000000-0xc07fffffff window] 60s [ 0.675014] pci 0000:00:01.0: PIIX3: Enabling Passive Release 60s [ 0.676056] pci 0000:00:00.0: Limiting direct PCI/PCI transfers 60s [ 0.677164] PCI: CLS 0 bytes, default 64 60s [ 0.677997] Trying to unpack rootfs image as initramfs... 60s [ 0.679021] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) 60s [ 0.680257] software IO TLB: mapped [mem 0x00000000bbfdd000-0x00000000bffdd000] (64MB) 60s [ 0.706177] Initialise system trusted keyrings 60s [ 0.707050] Key type blacklist registered 60s [ 0.707876] workingset: timestamp_bits=36 max_order=20 bucket_order=0 60s [ 0.709028] zbud: loaded 60s [ 0.709855] squashfs: version 4.0 (2009/01/31) Phillip Lougher 60s [ 0.711057] fuse: init (API version 7.42) 60s [ 0.712658] integrity: Platform Keyring initialized 60s [ 0.713568] integrity: Machine keyring initialized 60s [ 0.727251] Key type asymmetric registered 60s [ 0.728061] Asymmetric key parser 'x509' registered 60s [ 0.728984] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) 60s [ 0.730406] io scheduler mq-deadline registered 60s [ 0.732054] ledtrig-cpu: registered to indicate activity on CPUs 60s [ 0.733191] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 60s [ 0.734514] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 60s [ 0.735964] ACPI: button: Power Button [PWRF] 60s [ 0.777789] ACPI: \_SB_.LNKC: Enabled at IRQ 11 60s [ 0.820554] ACPI: \_SB_.LNKD: Enabled at IRQ 10 60s [ 0.843405] Freeing initrd memory: 70472K 60s [ 0.863012] ACPI: \_SB_.LNKA: Enabled at IRQ 10 60s [ 0.905513] ACPI: \_SB_.LNKB: Enabled at IRQ 11 60s [ 0.949328] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled 60s [ 0.974096] 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A 60s [ 0.990450] Linux agpgart interface v0.103 60s [ 0.992841] loop: module loaded 60s [ 0.993626] virtio_blk virtio2: 2/0/0 default/read/poll queues 60s [ 0.995423] virtio_blk virtio2: [vda] 41943040 512-byte logical blocks (21.5 GB/20.0 GiB) 60s [ 0.998777] vda: vda1 vda13 vda14 vda15 60s [ 1.000707] scsi host0: ata_piix 60s [ 1.001531] scsi host1: ata_piix 60s [ 1.002226] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc180 irq 14 lpm-pol 0 60s [ 1.003643] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc188 irq 15 lpm-pol 0 60s [ 1.005102] ACPI: bus type drm_connector registered 60s [ 1.006270] tun: Universal TUN/TAP device driver, 1.6 60s [ 1.009541] PPP generic driver version 2.4.2 60s [ 1.010504] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 60s [ 1.013414] serio: i8042 KBD port at 0x60,0x64 irq 1 60s [ 1.014348] serio: i8042 AUX port at 0x60,0x64 irq 12 60s [ 1.015412] mousedev: PS/2 mouse device common for all mice 60s [ 1.016709] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 60s [ 1.018339] rtc_cmos 00:04: RTC can wake from S4 60s [ 1.019765] rtc_cmos 00:04: registered as rtc0 60s [ 1.020668] rtc_cmos 00:04: setting system clock to 2025-06-20T00:39:32 UTC (1750379972) 60s [ 1.022219] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram 60s [ 1.023401] i2c_dev: i2c /dev entries driver 60s [ 1.024236] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 60s [ 1.026359] device-mapper: uevent: version 1.0.3 60s [ 1.027267] device-mapper: ioctl: 4.49.0-ioctl (2025-01-17) initialised: dm-devel@lists.linux.dev 60s [ 1.028904] platform eisa.0: Probing EISA bus 0 60s [ 1.029748] platform eisa.0: EISA: Cannot allocate resource for mainboard 60s [ 1.030964] platform eisa.0: Cannot allocate resource for EISA slot 1 60s [ 1.032116] platform eisa.0: Cannot allocate resource for EISA slot 2 60s [ 1.033257] platform eisa.0: Cannot allocate resource for EISA slot 3 60s [ 1.034400] platform eisa.0: Cannot allocate resource for EISA slot 4 60s [ 1.035603] platform eisa.0: Cannot allocate resource for EISA slot 5 60s [ 1.036747] platform eisa.0: Cannot allocate resource for EISA slot 6 60s [ 1.037903] platform eisa.0: Cannot allocate resource for EISA slot 7 60s [ 1.039050] platform eisa.0: Cannot allocate resource for EISA slot 8 60s [ 1.040196] platform eisa.0: EISA: Detected 0 cards 60s [ 1.041096] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled 60s [ 1.043350] drop_monitor: Initializing network drop monitor service 60s [ 1.044583] NET: Registered PF_INET6 protocol family 60s [ 1.052336] Segment Routing with IPv6 60s [ 1.053092] In-situ OAM (IOAM) with IPv6 60s [ 1.053860] NET: Registered PF_PACKET protocol family 60s [ 1.054854] Key type dns_resolver registered 60s [ 1.055979] IPI shorthand broadcast: enabled 60s [ 1.059162] sched_clock: Marking stable (893005285, 165880259)->(1062950382, -4064838) 60s [ 1.060775] registered taskstats version 1 60s [ 1.061836] Loading compiled-in X.509 certificates 60s [ 1.063392] Loaded X.509 cert 'Build time autogenerated kernel key: efe648a0727ac2b39d88d55659f8e6c0c5f80041' 60s [ 1.065875] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 60s [ 1.068121] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 60s [ 1.069899] blacklist: Loading compiled-in revocation X.509 certificates 60s [ 1.071102] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 60s [ 1.073534] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 60s [ 1.075400] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 60s [ 1.077306] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 60s [ 1.079149] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 60s [ 1.081048] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 60s [ 1.082942] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 60s [ 1.084829] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 60s [ 1.092116] Demotion targets for Node 0: null 60s [ 1.096529] Key type .fscrypt registered 60s [ 1.097297] Key type fscrypt-provisioning registered 60s [ 1.114043] Key type encrypted registered 60s [ 1.114849] AppArmor: AppArmor sha256 policy hashing enabled 60s [ 1.115956] ima: No TPM chip found, activating TPM-bypass! 60s [ 1.116974] Loading compiled-in module X.509 certificates 60s [ 1.118500] Loaded X.509 cert 'Build time autogenerated kernel key: efe648a0727ac2b39d88d55659f8e6c0c5f80041' 60s [ 1.120273] ima: Allocated hash algorithm: sha256 60s [ 1.121159] ima: No architecture policies found 60s [ 1.122022] evm: Initialising EVM extended attributes: 60s [ 1.122968] evm: security.selinux 60s [ 1.123630] evm: security.SMACK64 60s [ 1.124293] evm: security.SMACK64EXEC 60s [ 1.125005] evm: security.SMACK64TRANSMUTE 60s [ 1.125778] evm: security.SMACK64MMAP 60s [ 1.126494] evm: security.apparmor 60s [ 1.127171] evm: security.ima 60s [ 1.127773] evm: security.capability 60s [ 1.128472] evm: HMAC attrs: 0x1 60s [ 1.129406] PM: Magic number: 13:631:658 60s [ 1.134657] RAS: Correctable Errors collector initialized. 60s [ 1.150451] clk: Disabling unused clocks 60s [ 1.151239] PM: genpd: Disabling unused power domains 60s [ 1.162683] Freeing unused decrypted memory: 2028K 60s [ 1.164495] Freeing unused kernel image (initmem) memory: 5096K 60s [ 1.165409] Write protecting the kernel read-only data: 38912k 60s [ 1.166719] Freeing unused kernel image (text/rodata gap) memory: 756K 60s [ 1.167879] Freeing unused kernel image (rodata/data gap) memory: 448K 60s [ 1.224604] x86/mm: Checked W+X mappings: passed, no W+X pages found. 60s [ 1.225584] Run /init as init process 60s Loading, please wait... 60s Starting systemd-udevd version 257.6-1ubuntu1 60s [ 1.352699] virtio_net virtio0 ens3: renamed from eth0 60s [ 1.362749] FDC 0 is a S82078B 60s [ 1.364575] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 60s [ 1.366139] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 60s Begin: Loading essential drivers ... done. 60s Begin: Running /scripts/init-premount ... done. 60s Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. 60s Begin: Running /scripts/local-premount ... [ 2.544889] raid6: avx2x4 gen() 49401 MB/s 60s [ 2.561889] raid6: avx2x2 gen() 47207 MB/s 60s [ 2.578889] raid6: avx2x1 gen() 39783 MB/s 60s [ 2.579591] raid6: using algorithm avx2x4 gen() 49401 MB/s 60s [ 2.596891] raid6: .... xor() 5385 MB/s, rmw enabled 60s [ 2.597662] raid6: using avx2x2 recovery algorithm 60s [ 2.599434] xor: automatically using best checksumming function avx 60s [ 2.675432] Btrfs loaded, zoned=yes, fsverity=yes 60s Scanning for Btrfs filesystems 60s done. 60s Begin: Will now check root file system ... fsck from util-linux 2.41 60s [/usr/sbin/fsck.ext4 (1) -- /dev/vda1] fsck.ext4 -a -C0 /dev/vda1 60s cloudimg-rootfs: clean, 92171/2383360 files, 817703/4952315 blocks 60s done. 60s [ 2.742380] EXT4-fs (vda1): orphan cleanup on readonly fs 60s [ 2.743409] EXT4-fs (vda1): mounted filesystem 5a33bdfc-ef95-4523-bad4-c54b854623bc ro with ordered data mode. Quota mode: none. 60s done. 60s Begin: Running /scripts/local-bottom ... done. 60s Begin: Running /scripts/init-bottom ... done. 60s [ 2.898150] systemd[1]: Inserted module 'autofs4' 60s [!p]104[?7h[ 2.921739] systemd[1]: systemd 257.6-1ubuntu1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK +BTF -XKBCOMMON -UTMP +SYSVINIT +LIBARCHIVE) 60s [ 2.926380] systemd[1]: Detected virtualization kvm. 60s [ 2.927148] systemd[1]: Detected architecture x86-64. 60s 60s [0;1;39mWelcome to [0m[1mUbuntu Questing Quokka (development branch)[0m[0;1;39m![0m 60s 60s [ 2.931902] systemd[1]: Hostname set to . 60s [ 3.003137] systemd[1]: bpf-restrict-fs: BPF LSM hook not enabled in the kernel, BPF LSM not supported. 60s [ 3.046215] Guest personality initialized and is inactive 60s [ 3.047253] VMCI host device registered (name=vmci, major=10, minor=122) 60s [ 3.048416] Initialized host personality 60s [ 3.051468] NET: Registered PF_VSOCK protocol family 60s [ 3.196267] systemd[1]: Queued start job for default target graphical.target. 60s [ 3.212575] systemd[1]: Created slice system-autopkgtest.slice - Slice /system/autopkgtest. 60s [[0;32m OK [0m] Created slice [0;1;39msystem-autopkgtest.slice[0m - Slice /system/autopkgtest. 60s [ 3.215457] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. 60s [[0;32m OK [0m] Created slice [0;1;39msystem-modprobe.slice[0m - Slice /system/modprobe. 60s [ 3.218119] systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. 60s [[0;32m OK [0m] Created slice [0;1;39msystem-serial\x2dget���slice[0m - Slice /system/serial-getty. 60s [ 3.221159] systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. 60s [[0;32m OK [0m] Created slice [0;1;39msystem-systemd\x2dfs���slice[0m - Slice /system/systemd-fsck. 60s [ 3.224018] systemd[1]: Created slice user.slice - User and Session Slice. 60s [[0;32m OK [0m] Created slice [0;1;39muser.slice[0m - User and Session Slice. 60s [ 3.225972] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. 60s [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-wall.���[0md Requests to Wall Directory Watch. 60s [ 3.228980] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. 60s [[0;32m OK [0m] Set up automount [0;1;39mproc-sys-fs-binfm���[0mormats File System Automount Point. 60s [ 3.232006] systemd[1]: Expecting device dev-disk-by\x2dlabel-BOOT.device - /dev/disk/by-label/BOOT... 60s Expecting device [0;1;39mdev-disk-by\x2dla���device[0m - /dev/disk/by-label/BOOT... 60s [ 3.235039] systemd[1]: Expecting device dev-disk-by\x2dlabel-UEFI.device - /dev/disk/by-label/UEFI... 60s Expecting device [0;1;39mdev-disk-by\x2dla���device[0m - /dev/disk/by-label/UEFI... 60s [ 3.237614] systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... 60s Expecting device [0;1;39mdev-ttyS0.device[0m - /dev/ttyS0... 60s [ 3.239521] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. 60s [[0;32m OK [0m] Reached target [0;1;39mintegritysetup.targ���[0m Local Integrity Protected Volumes. 60s [ 3.242004] systemd[1]: Reached target remote-fs.target - Remote File Systems. 60s [[0;32m OK [0m] Reached target [0;1;39mremote-fs.target[0m - Remote File Systems. 60s [ 3.244260] systemd[1]: Reached target slices.target - Slice Units. 60s [[0;32m OK [0m] Reached target [0;1;39mslices.target[0m - Slice Units. 60s [ 3.246167] systemd[1]: Reached target swap.target - Swaps. 60s [[0;32m OK [0m] Reached target [0;1;39mswap.target[0m - Swaps. 60s [ 3.247849] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. 60s [[0;32m OK [0m] Reached target [0;1;39mveritysetup.target[0m - Local Verity Protected Volumes. 60s [ 3.250333] systemd[1]: Listening on syslog.socket - Syslog Socket. 60s [[0;32m OK [0m] Listening on [0;1;39msyslog.socket[0m - Syslog Socket. 60s [ 3.253182] systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. 60s [[0;32m OK [0m] Listening on [0;1;39msystemd-creds.socket[0m - Credential Encryption/Decryption. 60s [ 3.255721] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. 60s [[0;32m OK [0m] Listening on [0;1;39msystemd-initctl.socke���[0m- initctl Compatibility Named Pipe. 60s [ 3.258213] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). 60s [[0;32m OK [0m] Listening on [0;1;39msystemd-journald-dev-���socket[0m - Journal Socket (/dev/log). 60s [ 3.260987] systemd[1]: Listening on systemd-journald.socket - Journal Sockets. 60s [[0;32m OK [0m] Listening on [0;1;39msystemd-journald.socket[0m - Journal Sockets. 60s [ 3.263927] systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. 60s [[0;32m OK [0m] Listening on [0;1;39msystemd-networkd.socket[0m - Network Service Netlink Socket. 60s [ 3.266311] systemd[1]: systemd-pcrextend.socket - TPM PCR Measurements was skipped because of an unmet condition check (ConditionSecurity=measured-uki). 60s [ 3.268446] systemd[1]: systemd-pcrlock.socket - Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). 60s [ 3.270511] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. 60s [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-control.socket[0m - udev Control Socket. 60s [ 3.272935] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. 60s [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-kernel.socket[0m - udev Kernel Socket. 60s [ 3.276567] systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... 60s Mounting [0;1;39mdev-hugepages.mount[0m - Huge Pages File System... 60s [ 3.280026] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... 60s Mounting [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System... 60s [ 3.288727] systemd[1]: Mounting run-lock.mount - Legacy Locks Directory /run/lock... 60s Mounting [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock... 60s [ 3.295968] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... 60s Mounting [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System... 60s [ 3.300630] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... 60s Mounting [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System... 60s [ 3.306032] systemd[1]: Starting systemd-journald.service - Journal Service... 60s Starting [0;1;39msystemd-journald.service[0m - Journal Service... 60s [ 3.310011] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout... 60s Starting [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout... 60s [ 3.314229] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... 60s Starting [0;1;39mkmod-static-nodes.service[0m���eate List of Static Device Nodes... 60s [ 3.323047] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... 60s Starting [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs... 60s [ 3.327602] systemd[1]: Starting modprobe@dm_multipath.service - Load Kernel Module dm_multipath... 60s Starting [0;1;39mmodprobe@dm_multipath.ser���[0m Load Kernel Module dm_multipath... 60s [ 3.333321] systemd-journald[278]: Collecting audit messages is disabled. 60s [ 3.337262] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... 60s Starting [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm... 60s [ 3.343162] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... 60s Starting [0;1;39mmodprobe@efi_pstore.servi���[0m - Load Kernel Module efi_pstore... 60s [ 3.349074] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... 60s Starting [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse... 60s [ 3.351938] systemd[1]: netplan-ovs-cleanup.service - OpenVSwitch configuration for cleanup was skipped because of an unmet condition check (ConditionFileIsExecutable=/usr/bin/ovs-vsctl). 60s [ 3.356994] systemd[1]: systemd-fsck-root.service - File System Check on Root Device was skipped because of an unmet condition check (ConditionPathExists=!/run/initramfs/fsck-root). 60s [ 3.359496] systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). 60s [ 3.369083] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... 60s Starting [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules... 60s [ 3.373029] systemd[1]: systemd-pcrmachine.service - TPM PCR Machine ID Measurement was skipped because of an unmet condition check (ConditionSecurity=measured-uki). 60s [ 3.381086] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... 60s Starting [0;1;39msystemd-remount-fs.servic���[0munt Root and Kernel File Systems... 60s [ 3.386080] systemd[1]: systemd-tpm2-setup-early.service - Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). 60s [ 3.391051] systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... 60s Starting [0;1;39msystemd-udev-load-credent���[0mLoad udev Rules from Credentials... 60s [ 3.396283] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... 60s [ 3.398083] EXT4-fs (vda1): re-mounted 5a33bdfc-ef95-4523-bad4-c54b854623bc r/w. Quota mode: none. 60s Starting [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices... 60s [ 3.404049] systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. 60s [[0;32m OK [0m] Mounted [0;1;39mdev-hugepages.mount[0m - Huge Pages File System. 60s [ 3.406183] systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. 60s [[0;32m OK [0m] Mounted [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System. 60s [ 3.409112] systemd[1]: Started systemd-journald.service - Journal Service. 60s [[0;32m OK [0m] Started [0;1;39msystemd-journald.service[0m - Journal Service. 60s [[0;32m OK [0m] Mounted [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock. 60s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System. 60s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System. 60s [[0;32m OK [0m] Finished [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout. 60s [[0;32m OK [0m] Finished [0;1;39mkmod-static-nodes.service[0m���Create List of Static Device Nodes. 60s [[0;32m OK [0m] Finished [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs. 60s [[0;32m OK [0m] Finished [0;1;39mmodprobe@dm_multipath.ser���[0m - Load Kernel Module dm_multipath. 60s [[0;32m OK [0m] Finished [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm. 60s [[0;32m OK [0m] Finished [0;1;39mmodprobe@efi_pstore.service[0m - Load Kernel Module efi_pstore. 60s [[0;32m OK [0m] Finished [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-remount-fs.servic���[0mmount Root and Kernel File Systems. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-udev-load-credent���[0m- Load udev Rules from Credentials. 60s Mounting [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System... 60s Mounting [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System... 60s Starting [0;1;39mmultipathd.service[0m - Devi���pper Multipath Device Controller... 60s Starting [0;1;39mcloud-init-main.service[0m - Cloud-init: Single Process... 60s Starting [0;1;39msystemd-journal-flush.ser���[0msh Journal to Persistent Storage... 60s Starting [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed... 60s Starting [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables... 60s Starting [0;1;39msystemd-tmpfiles-setup-de���[0m Device Nodes in /dev gracefully... 60s [[0;32m OK [0m] Mounted [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System. 60s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System. 60s [ 3.487304] systemd-journald[278]: Received client request to flush runtime journal. 60s [[0;32m OK [0m] Started [0;1;39mmultipathd.service[0m - Devic���Mapper Multipath Device Controller. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mic Device Nodes in /dev gracefully. 60s Starting [0;1;39msystemd-resolved.service[0m - Network Name Resolution... 60s Starting [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization... 60s Starting [0;1;39msystemd-tmpfiles-setup-de���[0meate Static Device Nodes in /dev... 60s [[0;32m OK [0m] Finished [0;1;39msystemd-journal-flush.ser���[0mlush Journal to Persistent Storage. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mCreate Static Device Nodes in /dev. 60s [[0;32m OK [0m] Reached target [0;1;39mlocal-fs-pre.target[0m���Preparation for Local File Systems. 60s Starting [0;1;39msystemd-udevd.service[0m - R���ager for Device Events and Files... 60s [[0;32m OK [0m] Started [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization. 60s [[0;32m OK [0m] Reached target [0;1;39mtime-set.target[0m - System Time Set. 60s [[0;32m OK [0m] Started [0;1;39msystemd-resolved.service[0m - Network Name Resolution. 60s [[0;32m OK [0m] Reached target [0;1;39mnss-lookup.target[0m - Host and Network Name Lookups. 60s [[0;32m OK [0m] Started [0;1;39msystemd-udevd.service[0m - Ru���anager for Device Events and Files. 60s [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-conso���[0mequests to Console Directory Watch. 60s [[0;32m OK [0m] Reached target [0;1;39mcryptsetup.target[0m - Local Encrypted Volumes. 60s [[0;32m OK [0m] Found device [0;1;39mdev-ttyS0.device[0m - /dev/ttyS0. 60s [[0;32m OK [0m] Found device [0;1;39mdev-disk-by\x2dlabel-���I.device[0m - /dev/disk/by-label/UEFI. 60s [[0;32m OK [0m] Found device [0;1;39mdev-disk-by\x2dlabel-���T.device[0m - /dev/disk/by-label/BOOT. 60s Starting [0;1;39msystemd-fsck@dev-disk-by\���[0mCheck on /dev/disk/by-label/BOOT... 60s Starting [0;1;39msystemd-fsck@dev-disk-by\���[0mCheck on /dev/disk/by-label/UEFI... 60s [[0;32m OK [0m] Started [0;1;39mcloud-init-main.service[0m - Cloud-init: Single Process. 60s Starting [0;1;39mcloud-init-local.service[0m ���-init: Local Stage (pre-network)... 60s [[0;32m OK [0m] Finished [0;1;39msystemd-fsck@dev-disk-by\���[0mm Check on /dev/disk/by-label/UEFI. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-fsck@dev-disk-by\���[0mm Check on /dev/disk/by-label/BOOT. 60s [ 4.029519] cloud-init[432]: Cloud-init v. 25.2~4geb9c1239-0ubuntu1 running 'init-local' at Fri, 20 Jun 2025 00:39:35 +0000. Up 3.98 seconds. 60s [[0;32m OK [0m] Listening on [0;1;39msystemd-rfkill.socket[0m���ll Switch Status /dev/rfkill Watch. 60s Mounting [0;1;39mboot.mount[0m - /boot... 60s [[0;32m OK [0m] Mounted [0;1;39mboot.mount[0m - /boot. 60s Mounting [0;1;39mboot-efi.mount[0m - /boot/efi... 60s [[0;32m OK [0m] Mounted [0;1;39mboot-efi.mount[0m - /boot/efi. 60s [[0;32m OK [0m] Reached target [0;1;39mlocal-fs.target[0m - Local File Systems. 60s [[0;32m OK [0m] Listening on [0;1;39msystemd-sysext.socket[0m��� System Extension Image Management. 60s Starting [0;1;39mapparmor.service[0m - Load AppArmor profiles... 60s Starting [0;1;39mconsole-setup.service[0m - Set console font and keymap... 60s Starting [0;1;39mplymouth-read-write.servi���[0mymouth To Write Out Runtime Data... 60s Starting [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats... 60s Starting [0;1;39msystemd-tmpfiles-setup.se���[0mate System Files and Directories... 60s Starting [0;1;39mufw.service[0m - Uncomplicated firewall... 60s [[0;32m OK [0m] Finished [0;1;39mconsole-setup.service[0m - Set console font and keymap. 60s [[0;32m OK [0m] Finished [0;1;39mplymouth-read-write.servi���[0mPlymouth To Write Out Runtime Data. 60s [[0;32m OK [0m] Finished [0;1;39mufw.service[0m - Uncomplicated firewall. 60s Mounting [0;1;39mproc-sys-fs-binfmt_misc.m���[0mcutable File Formats File System... 60s [[0;32m OK [0m] Mounted [0;1;39mproc-sys-fs-binfmt_misc.mo���[0mxecutable File Formats File System. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup.se���[0mreate System Files and Directories. 60s [[0;32m OK [0m] Finished [0;1;39mapparmor.service[0m - Load AppArmor profiles. 60s [ 7.690701] sh[423]: Completed socket interaction for boot stage local 60s [[0;32m OK [0m] Finished [0;1;39mcloud-init-local.service[0m ���ud-init: Local Stage (pre-network). 60s [[0;32m OK [0m] Reached target [0;1;39mnetwork-pre.target[0m - Preparation for Network. 60s Starting [0;1;39mcloud-init-network.service[0m - Cloud-init: Network Stage... 60s Starting [0;1;39msystemd-networkd.service[0m - Network Configuration... 60s [ 7.758635] cloud-init[432]: Cloud-init v. 25.2~4geb9c1239-0ubuntu1 running 'init' at Fri, 20 Jun 2025 00:39:39 +0000. Up 7.73 seconds. 60s [ 7.766533] cloud-init[432]: ci-info: +++++++++++++++++++++++++++Net device info++++++++++++++++++++++++++++ 60s [ 7.767724] cloud-init[432]: ci-info: +--------+-------+-----------+-----------+-------+-------------------+ 60s [ 7.768887] cloud-init[432]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 60s [ 7.770067] cloud-init[432]: ci-info: +--------+-------+-----------+-----------+-------+-------------------+ 60s [ 7.772062] cloud-init[432]: ci-info: | ens3 | False | . | . | . | fa:16:3e:71:a2:f9 | 60s [ 7.773203] cloud-init[432]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 60s [ 7.774367] cloud-init[432]: ci-info: | lo | True | ::1/128 | . | host | . | 60s [ 7.776064] cloud-init[432]: ci-info: +--------+-------+-----------+-----------+-------+-------------------+ 60s [ 7.778060] cloud-init[432]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 60s [ 7.779044] cloud-init[432]: ci-info: +-------+-------------+---------+-----------+-------+ 60s [ 7.780068] cloud-init[432]: ci-info: | Route | Destination | Gateway | Interface | Flags | 60s [ 7.781056] cloud-init[432]: ci-info: +-------+-------------+---------+-----------+-------+ 60s [ 7.783065] cloud-init[432]: ci-info: +-------+-------------+---------+-----------+-------+ 60s [[0;32m OK [0m] Started [0;1;39msystemd-networkd.service[0m - Network Configuration. 60s [[0;32m OK [0m] Reached target [0;1;39mnetwork.target[0m - Network. 60s Starting [0;1;39msystemd-networkd-persiste���[0mtent Storage in systemd-networkd... 60s Starting [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured... 60s [[0;32m OK [0m] Finished [0;1;39msystemd-networkd-persiste���[0mistent Storage in systemd-networkd. 60s [ 7.857521] cloud-init[432]: 2025-06-20 00:39:39,502 - loggers.py[DEPRECATED]: Deprecated cloud-config provided: apt_update: Deprecated in version 22.2. Use **package_update** instead., apt_upgrade: Deprecated in version 22.2. Use **package_upgrade** instead. 60s [ 7.860256] cloud-init[432]: 2025-06-20 00:39:39,502 - schema.py[WARNING]: cloud-config failed schema validation! You may run 'sudo cloud-init schema --system' to check the details. 60s [ 8.118645] sh[730]: Completed socket interaction for boot stage network 60s [[0;32m OK [0m] Finished [0;1;39mcloud-init-network.service[0m - Cloud-init: Network Stage. 60s [[0;32m OK [0m] Reached target [0;1;39mcloud-config.target[0m - Cloud-config availability. 60s [[0;32m OK [0m] Reached target [0;1;39msysinit.target[0m - System Initialization. 60s [[0;32m OK [0m] Started [0;1;39mapt-daily.timer[0m - Daily apt download activities. 60s [[0;32m OK [0m] Started [0;1;39mapt-daily-upgrade.timer[0m - ���y apt upgrade and clean activities. 60s [[0;32m OK [0m] Started [0;1;39mdpkg-db-backup.timer[0m - Daily dpkg database backup timer. 60s [[0;32m OK [0m] Started [0;1;39me2scrub_all.timer[0m - Period���Metadata Check for All Filesystems. 60s [[0;32m OK [0m] Started [0;1;39mfstrim.timer[0m - Discard unused filesystem blocks once a week. 60s [[0;32m OK [0m] Started [0;1;39mfwupd-refresh.timer[0m - Refresh fwupd metadata regularly. 60s [[0;32m OK [0m] Started [0;1;39mlogrotate.timer[0m - Daily rotation of log files. 60s [[0;32m OK [0m] Started [0;1;39mman-db.timer[0m - Daily man-db regeneration. 60s [[0;32m OK [0m] Started [0;1;39mmotd-news.timer[0m - Message of the Day. 60s [[0;32m OK [0m] Started [0;1;39msysstat-collect.timer[0m - Ru���y accounting tool every 10 minutes. 60s [[0;32m OK [0m] Started [0;1;39msysstat-rotate.timer[0m - Rot���tem activity data file at midnight. 60s [[0;32m OK [0m] Started [0;1;39msysstat-summary.timer[0m - Ge��� of yesterday's process accounting. 60s [[0;32m OK [0m] Started [0;1;39msystemd-tmpfiles-clean.tim���[0my Cleanup of Temporary Directories. 60s [[0;32m OK [0m] Reached target [0;1;39mboot-complete.target[0m - Boot Completion Check. 60s [[0;32m OK [0m] Reached target [0;1;39mpaths.target[0m - Path Units. 60s [[0;32m OK [0m] Reached target [0;1;39mtimers.target[0m - Timer Units. 60s [[0;32m OK [0m] Listening on [0;1;39mcloud-init-hotplugd.s���t[0m - cloud-init hotplug hook socket. 60s [[0;32m OK [0m] Listening on [0;1;39mdbus.socket[0m - D-Bus System Message Bus Socket. 60s Starting [0;1;39mlxd-installer.socket[0m - He���er to install lxd snap on demand... 60s [[0;32m OK [0m] Listening on [0;1;39mssh.socket[0m - OpenBSD Secure Shell server socket. 60s [[0;32m OK [0m] Listening on [0;1;39msshd-unix-local.socke���[0mtemd-ssh-generator, AF_UNIX Local). 60s [[0;32m OK [0m] Listening on [0;1;39msshd-vsock.socket[0m - O��� (systemd-ssh-generator, AF_VSOCK). 60s [[0;32m OK [0m] Reached target [0;1;39mssh-access.target[0m - SSH Access Available. 60s [[0;32m OK [0m] Listening on [0;1;39msystemd-hostnamed.socket[0m - Hostname Service Socket. 60s [[0;32m OK [0m] Listening on [0;1;39muuidd.socket[0m - UUID daemon activation socket. 60s [[0;32m OK [0m] Listening on [0;1;39mlxd-installer.socket[0m ���lper to install lxd snap on demand. 60s [[0;32m OK [0m] Reached target [0;1;39msockets.target[0m - Socket Units. 60s [[0;32m OK [0m] Reached target [0;1;39mbasic.target[0m - Basic System. 60s Starting [0;1;39mapport.service[0m - automatic crash report generation... 60s [[0;32m OK [0m] Started [0;1;39mautopkgtest@ttyS1.service[0m - autopkgtest root shell on ttyS1. 60s [[0;32m OK [0m] Started [0;1;39mcron.service[0m - Regular background program processing daemon. 60s Starting [0;1;39mdbus.service[0m - D-Bus System Message Bus... 60s [[0;32m OK [0m] Started [0;1;39mdmesg.service[0m - Save initial kernel messages after boot. 60s Starting [0;1;39mdpkg-db-backup.service[0m - ���ily dpkg database backup service... 60s Starting [0;1;39me2scrub_reap.service[0m - Re���ne ext4 Metadata Check Snapshots... 60s Starting [0;1;39mgrub-common.service[0m - Record successful boot for GRUB... 60s Starting [0;1;39mrng-tools-debian.service[0m ���gatherer daemon (Debian variant)... 60s Starting [0;1;39mrsyslog.service[0m - System Logging Service... 60s Starting [0;1;39msysstat.service[0m - Resets System Activity Logs... 60s Starting [0;1;39msystemd-logind.service[0m - User Login Management... 60s Starting [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions... 60s Starting [0;1;39mudisks2.service[0m - Disk Manager... 60s [[0;32m OK [0m] Finished [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions. 60s Starting [0;1;39mplymouth-quit-wait.servic���[0md until boot process finishes up... 60s Starting [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen... 60s [[0;32m OK [0m] Finished [0;1;39msysstat.service[0m - Resets System Activity Logs. 60s [[0;32m OK [0m] Finished [0;1;39mplymouth-quit-wait.servic���[0mold until boot process finishes up. 60s [[0;32m OK [0m] Started [0;1;39mserial-getty@ttyS0.service[0m - Serial Getty on ttyS0. 60s Starting [0;1;39msetvtrgb.service[0m - Set console scheme... 60s [[0;32m OK [0m] Started [0;1;39mdbus.service[0m - D-Bus System Message Bus. 60s [[0;32m OK [0m] Finished [0;1;39mgrub-common.service[0m - Record successful boot for GRUB. 60s [[0;32m OK [0m] Finished [0;1;39me2scrub_reap.service[0m - Re���line ext4 Metadata Check Snapshots. 60s [[0;32m OK [0m] Finished [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen. 60s Starting [0;1;39mgrub-initrd-fallback.service[0m - GRUB failed boot detection... 60s [[0;32m OK [0m] Finished [0;1;39msetvtrgb.service[0m - Set console scheme. 60s [[0;32m OK [0m] Created slice [0;1;39msystem-getty.slice[0m - Slice /system/getty. 60s [[0;32m OK [0m] Started [0;1;39mgetty@tty1.service[0m - Getty on tty1. 60s [[0;32m OK [0m] Reached target [0;1;39mgetty.target[0m - Login Prompts. 60s [[0;32m OK [0m] Finished [0;1;39mgrub-initrd-fallback.service[0m - GRUB failed boot detection. 60s [[0;32m OK [0m] Started [0;1;39msystemd-logind.service[0m - User Login Management. 60s [[0;32m OK [0m] Started [0;1;39mudisks2.service[0m - Disk Manager. 60s [[0;32m OK [0m] Started [0;1;39mrsyslog.service[0m - System Logging Service. 60s [[0;32m OK [0m] Finished [0;1;39mdpkg-db-backup.service[0m - Daily dpkg database backup service. 60s [[0;32m OK [0m] Finished [0;1;39mapport.service[0m - automatic crash report generation. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-networkd-wait-onl���[0m Wait for Network to be Configured. 60s [[0;32m OK [0m] Reached target [0;1;39mnetwork-online.target[0m - Network is Online. 60s Starting [0;1;39mcloud-config.service[0m - Cloud-init: Config Stage... 60s Starting [0;1;39mpollinate.service[0m - Polli���e pseudo random number generator... 60s [ 9.863524] cloud-init[432]: Cloud-init v. 25.2~4geb9c1239-0ubuntu1 running 'modules:config' at Fri, 20 Jun 2025 00:39:41 +0000. Up 9.80 seconds. 60s [ 9.876636] cloud-init[432]: 2025-06-20 00:39:41,521 - lifecycle.py[DEPRECATED]: The following config key(s): ['apt_mirror', 'apt_preserve_sources_list'] is deprecated in 22.1 and scheduled to be removed in 27.1. 60s [ 9.878971] cloud-init[432]: 2025-06-20 00:39:41,521 - lifecycle.py[DEPRECATED]: Support for combined old and new apt module keys is deprecated in 22.1 and scheduled to be removed in 27.1. 60s [ 9.932278] sh[931]: Completed socket interaction for boot stage config 60s [[0;32m OK [0m] Finished [0;1;39mcloud-config.service[0m - Cloud-init: Config Stage. 60s [!p]104[?7h[6n[32766;32766H[6n[!p]104[?7h[6n[32766;32766H[6n 60s Ubuntu Questing Quokka (development branch) autopkgtest ttyS0 60s 60s autopkgtest login: [ 19.972866] cloud-init[432]: Cloud-init v. 25.2~4geb9c1239-0ubuntu1 running 'modules:final' at Fri, 20 Jun 2025 00:39:51 +0000. Up 19.92 seconds. 60s [ 20.120033] cloud-init[432]: Get:1 http://ftpmaster.internal/ubuntu questing InRelease [249 kB] 60s [ 20.155252] cloud-init[432]: Get:2 http://ftpmaster.internal/ubuntu questing-updates InRelease [110 kB] 60s [ 20.192126] cloud-init[432]: Get:3 http://ftpmaster.internal/ubuntu questing-security InRelease [110 kB] 60s [ 20.227191] cloud-init[432]: Get:4 http://ftpmaster.internal/ubuntu questing/universe Sources [21.3 MB] 60s [ 20.789416] cloud-init[432]: Get:5 http://ftpmaster.internal/ubuntu questing/multiverse Sources [309 kB] 60s [ 20.823375] cloud-init[432]: Get:6 http://ftpmaster.internal/ubuntu questing/main Sources [1385 kB] 60s [ 20.869909] cloud-init[432]: Get:7 http://ftpmaster.internal/ubuntu questing/main i386 Packages [1081 kB] 60s [ 20.935079] cloud-init[432]: Get:8 http://ftpmaster.internal/ubuntu questing/main amd64 Packages [1444 kB] 60s [ 21.068022] cloud-init[432]: Get:9 http://ftpmaster.internal/ubuntu questing/universe amd64 Packages [16.0 MB] 60s [ 21.315948] cloud-init[432]: Get:10 http://ftpmaster.internal/ubuntu questing/universe i386 Packages [8921 kB] 60s [ 21.452590] cloud-init[432]: Get:11 http://ftpmaster.internal/ubuntu questing/multiverse i386 Packages [131 kB] 60s [ 21.486056] cloud-init[432]: Get:12 http://ftpmaster.internal/ubuntu questing/multiverse amd64 Packages [277 kB] 60s [ 23.750285] cloud-init[432]: Fetched 51.3 MB in 4s (14.1 MB/s) 60s [ 24.360858] cloud-init[432]: Reading package lists... 60s ci-info: ++++++++++++++++++++++++++++++++++++++++++++++++++++++Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu+++++++++++++++++++++++++++++++++++++++++++++++++++++++ 60s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 60s ci-info: | Keytype | Fingerprint (sha256) | Options | Comment | 60s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 60s ci-info: | ssh-rsa | 87:eb:11:e6:d9:4d:64:37:d3:15:bc:fb:70:01:fb:c2:54:4a:7c:f0:03:f0:ca:42:74:a2:5a:a0:67:8b:da:f8 | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-2 | 60s ci-info: | ssh-rsa | 91:43:c5:c0:08:13:e1:4c:d2:84:a3:93:cc:b6:92:94:24:03:c7:0a:60:b3:34:9d:7f:63:f7:38:37:6f:9d:18 | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-23 | 60s ci-info: | ssh-rsa | 17:cc:c2:f5:cd:5f:39:1f:0e:64:fd:e4:94:c3:c0:26:c7:b4:8c:54:0d:46:63:3c:16:ae:6f:e1:3e:a2:15:de | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-21 | 60s ci-info: | ssh-rsa | e8:35:e0:40:84:e9:20:46:36:c3:0d:24:8f:f7:02:62:a2:c6:f7:f5:5c:ed:3f:df:2b:54:8b:69:97:eb:98:5e | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-15 | 60s ci-info: | ssh-rsa | 2a:d9:03:84:6a:0e:d7:a1:c3:3d:2c:94:92:f9:7f:cd:87:dd:2b:3e:c8:1b:1c:8c:69:cc:32:78:8b:3a:64:69 | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-20 | 60s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 60s <14>Jun 20 00:39:56 cloud-init: ############################################################# 60s <14>Jun 20 00:39:56 cloud-init: -----BEGIN SSH HOST KEY FINGERPRINTS----- 60s <14>Jun 20 00:39:56 cloud-init: 256 SHA256:PuCumQPbrocxdVvtNgbrPCtWZkT3B5XpYGjS8TF4lN8 root@autopkgtest (ECDSA) 60s <14>Jun 20 00:39:56 cloud-init: 256 SHA256:UwGLI++Jz15sAGC00zo+ekWt5d3lZwSqEaagw3niBFc root@autopkgtest (ED25519) 60s <14>Jun 20 00:39:56 cloud-init: 3072 SHA256:e5sT2BrbNwR4YjwgxypxU9nqSyccgua8slOPCVs350s root@autopkgtest (RSA) 60s <14>Jun 20 00:39:56 cloud-init: -----END SSH HOST KEY FINGERPRINTS----- 60s <14>Jun 20 00:39:56 cloud-init: ############################################################# 60s -----BEGIN SSH HOST KEY KEYS----- 60s ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBDJUwuPksyWvTyfUK1K7hfnfNi3HUVuJwDzuV1CECRYKC3plZ4YxztK7OiCXQgxR5c4TD/2PojWZDITYZ7npj40= root@autopkgtest 60s ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFGB1vocEZ8I8R9eos2kea43xszrsYynR2e4ciB4QQNu root@autopkgtest 60s ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDD54YHON0qBuKd6fClaEifl1B5g+JbREy5+SQdGGzw1fs+bNmSAe/iFVov4pDxEdr+oHsvOjWfMaGWAvMaeYMZcboIRSY4SYgcaa1KFOYmYFVyrDiQNka1XhVXhVFACPnuIZD9MPPABhUYXvKRq/LVOm64F4eJD/EJ3Qkz6Oqrfnyn0eRse+aYRoNrQ7p65sRxAQceBTbwBJQ+67/dJe7C0hAmTUTV7uHeMG/dDz7CRbZqAdlN6aQyY/6Qx34dhqmsjzhKvS3YxIyu/YNV0c1hITpbbWocEwSayboGi3ktZLl9qwSZFFqBffJXHFVfq7FBo0Ux1RQCiZnGp/Z5FXArSI5gvrs/baNoJ0CEkRyjKZAfVjf1rjqFuWzu1JJLQ0idbmmhL5fvLVLI+iCJDI+2zfVtyCOA2MStzmeIRbXs0Cj3UqYh38LVuSMD0QZCZLnIYZEummOvL4psL+6jALqtW3dnGUInAN9c/E1J+j9Ax4XpZ6/AaLTUR7ShvouzuV8= root@autopkgtest 60s -----END SSH HOST KEY KEYS----- 60s [ 24.442844] cloud-init[432]: Cloud-init v. 25.2~4geb9c1239-0ubuntu1 finished at Fri, 20 Jun 2025 00:39:56 +0000. Datasource DataSourceOpenStackLocal [net,ver=2]. Up 24.42 seconds 60s [ 24.444702] cloud-init[432]: Generating public/private rsa key pair. 60s [ 24.445501] cloud-init[432]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key 60s [ 24.446485] cloud-init[432]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub 60s [ 24.447486] cloud-init[432]: The key fingerprint is: 60s [ 24.448114] cloud-init[432]: SHA256:e5sT2BrbNwR4YjwgxypxU9nqSyccgua8slOPCVs350s root@autopkgtest 60s [ 24.449219] cloud-init[432]: The key's randomart image is: 60s [ 24.449887] cloud-init[432]: +---[RSA 3072]----+ 60s [ 24.450474] cloud-init[432]: | o.o | 60s [ 24.451060] cloud-init[432]: | . + = . | 60s [ 24.451635] cloud-init[432]: | + = + . | 60s [ 24.452223] cloud-init[432]: | + o o * o | 60s [ 24.452795] cloud-init[432]: | + . + oS* . | 60s [ 24.453382] cloud-init[432]: |. = o * +.o . | 60s [ 24.453965] cloud-init[432]: | = * =E+.=.o | 60s [ 24.454549] cloud-init[432]: |+ + ..o o.ooo | 60s [ 24.455133] cloud-init[432]: |.+ .. oo . | 60s [ 24.455707] cloud-init[432]: +----[SHA256]-----+ 60s [ 24.456300] cloud-init[432]: Generating public/private ecdsa key pair. 60s [ 24.457077] cloud-init[432]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key 60s [ 24.458101] cloud-init[432]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub 60s [ 24.459101] cloud-init[432]: The key fingerprint is: 60s [ 24.459715] cloud-init[432]: SHA256:PuCumQPbrocxdVvtNgbrPCtWZkT3B5XpYGjS8TF4lN8 root@autopkgtest 60s [ 24.460729] cloud-init[432]: The key's randomart image is: 60s [ 24.461394] cloud-init[432]: +---[ECDSA 256]---+ 60s [ 24.461976] cloud-init[432]: | ..=+o.o | 60s [ 24.462558] cloud-init[432]: | o *.*oo | 60s [ 24.463140] cloud-init[432]: | . = +.= . | 60s [ 24.463709] cloud-init[432]: | . . + . . + E| 60s [ 24.464294] cloud-init[432]: | . ..+S+ . | 60s [ 24.464861] cloud-init[432]: | + ..o= = | 60s [ 24.465437] cloud-init[432]: | B .*oo . | 60s [ 24.466028] cloud-init[432]: | o ++o +. | 60s [ 24.466596] cloud-init[432]: | .+=+...o | 60s [ 24.467207] cloud-init[432]: +----[SHA256]-----+ 60s [ 24.467783] cloud-init[432]: Generating public/private ed25519 key pair. 60s [ 24.468577] cloud-init[432]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key 60s [ 24.469615] cloud-init[432]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub 60s [ 24.470629] cloud-init[432]: The key fingerprint is: 60s [ 24.471241] cloud-init[432]: SHA256:UwGLI++Jz15sAGC00zo+ekWt5d3lZwSqEaagw3niBFc root@autopkgtest 60s [ 24.472248] cloud-init[432]: The key's randomart image is: 60s [ 24.472907] cloud-init[432]: +--[ED25519 256]--+ 60s [ 24.473510] cloud-init[432]: | .+.E ... | 60s [ 24.474090] cloud-init[432]: |...+. .o. .. | 60s [ 24.474661] cloud-init[432]: | +oo+ooo.... . | 60s [ 24.475242] cloud-init[432]: | Boo++.... . . | 60s [ 24.475812] cloud-init[432]: | oo= +o.S+ o . | 60s [ 24.476393] cloud-init[432]: | ...oo.+o.. . o | 60s [ 24.476961] cloud-init[432]: | o.. o + o | 60s [ 24.477552] cloud-init[432]: | ... o o | 60s [ 24.478371] cloud-init[432]: |.. .+ | 60s [ 24.478949] cloud-init[432]: +----[SHA256]-----+ 60s [ 24.479645] sh[1011]: Completed socket interaction for boot stage final 60s [[0;32m OK [0m] Stopped [0;1;39mrun-p1925-i1926.service[0m - ���] /usr/bin/sh -c "sleep 3; reboot". 60s Stopping [0;1;39msession-5.scope[0m - Session 5 of User ubuntu... 60s [[0;32m OK [0m] Removed slice [0;1;39msystem-autopkgtest.slice[0m - Slice /system/autopkgtest. 60s [[0;32m OK [0m] Removed slice [0;1;39msystem-modprobe.slice[0m - Slice /system/modprobe. 60s [[0;32m OK [0m] Stopped target [0;1;39mboot-complete.target[0m - Boot Completion Check. 60s [[0;32m OK [0m] Stopped target [0;1;39mcloud-init.target[0m - Cloud-init target. 60s [[0;32m OK [0m] Stopped target [0;1;39mgraphical.target[0m - Graphical Interface. 60s [[0;32m OK [0m] Stopped target [0;1;39mnss-lookup.target[0m - Host and Network Name Lookups. 60s [[0;32m OK [0m] Stopped target [0;1;39mssh-access.target[0m - SSH Access Available. 60s [[0;32m OK [0m] Stopped target [0;1;39mtimers.target[0m - Timer Units. 60s [[0;32m OK [0m] Stopped [0;1;39mapt-daily-upgrade.timer[0m - ���y apt upgrade and clean activities. 60s [[0;32m OK [0m] Stopped [0;1;39mapt-daily.timer[0m - Daily apt download activities. 60s [[0;32m OK [0m] Stopped [0;1;39mdpkg-db-backup.timer[0m - Daily dpkg database backup timer. 60s [[0;32m OK [0m] Stopped [0;1;39me2scrub_all.timer[0m - Period���Metadata Check for All Filesystems. 60s [[0;32m OK [0m] Stopped [0;1;39mfstrim.timer[0m - Discard unused filesystem blocks once a week. 60s [[0;32m OK [0m] Stopped [0;1;39mfwupd-refresh.timer[0m - Refresh fwupd metadata regularly. 60s [[0;32m OK [0m] Stopped [0;1;39mlogrotate.timer[0m - Daily rotation of log files. 60s [[0;32m OK [0m] Stopped [0;1;39mman-db.timer[0m - Daily man-db regeneration. 60s [[0;32m OK [0m] Stopped [0;1;39mmotd-news.timer[0m - Message of the Day. 60s [[0;32m OK [0m] Stopped [0;1;39msysstat-collect.timer[0m - Ru���y accounting tool every 10 minutes. 60s [[0;32m OK [0m] Stopped [0;1;39msysstat-rotate.timer[0m - Rot���tem activity data file at midnight. 60s [[0;32m OK [0m] Stopped [0;1;39msysstat-summary.timer[0m - Ge��� of yesterday's process accounting. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-tmpfiles-clean.tim���[0my Cleanup of Temporary Directories. 60s [[0;32m OK [0m] Stopped target [0;1;39mtime-set.target[0m - System Time Set. 60s [[0;32m OK [0m] Closed [0;1;39mcloud-init-hotplugd.socket[0m - cloud-init hotplug hook socket. 60s [[0;32m OK [0m] Closed [0;1;39msystemd-rfkill.socket[0m - Loa���ll Switch Status /dev/rfkill Watch. 60s [[0;32m OK [0m] Stopped [0;1;39mcloud-final.service[0m - Cloud-init: Final Stage. 60s [[0;32m OK [0m] Stopped target [0;1;39mmulti-user.target[0m - Multi-User System. 60s [[0;32m OK [0m] Stopped target [0;1;39mgetty.target[0m - Login Prompts. 60s Stopping [0;1;39mapport.service[0m - automatic crash report generation... 60s [[0;32m OK [0m] Stopped [0;1;39mcloud-config.service[0m - Cloud-init: Config Stage. 60s [[0;32m OK [0m] Stopped target [0;1;39mcloud-config.target[0m - Cloud-config availability. 60s [[0;32m OK [0m] Stopped target [0;1;39mnetwork-online.target[0m - Network is Online. 60s Stopping [0;1;39mcron.service[0m - Regular ba���ground program processing daemon... 60s Stopping [0;1;39mgetty@tty1.service[0m - Getty on tty1... 60s [[0;32m OK [0m] Stopped [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen. 60s Stopping [0;1;39mrsyslog.service[0m - System Logging Service... 60s Stopping [0;1;39mserial-getty@ttyS0.service[0m - Serial Getty on ttyS0... 60s Stopping [0;1;39mssh.service[0m - OpenBSD Secure Shell server... 60s [[0;32m OK [0m] Stopped [0;1;39msysstat.service[0m - Resets System Activity Logs. 60s Stopping [0;1;39msystemd-networkd-persiste���[0mtent Storage in systemd-networkd... 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-networkd-wait-onli���[0m Wait for Network to be Configured. 60s Stopping [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed... 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-udev-load-credenti���[0m- Load udev Rules from Credentials. 60s Stopping [0;1;39mudisks2.service[0m - Disk Manager... 60s [[0;32m OK [0m] Stopped [0;1;39mcron.service[0m - Regular background program processing daemon. 60s [[0;32m OK [0m] Stopped [0;1;39mserial-getty@ttyS0.service[0m - Serial Getty on ttyS0. 60s [!p]104[?7h[6n[32766;32766H[6n[[0;32m OK [0m] Stopped [0;1;39mudisks2.service[0m - Disk Manager. 60s [[0;32m OK [0m] Stopped [0;1;39mgetty@tty1.service[0m - Getty on tty1. 60s [[0;32m OK [0m] Stopped [0;1;39mrsyslog.service[0m - System Logging Service. 60s [[0;32m OK [0m] Stopped [0;1;39mssh.service[0m - OpenBSD Secure Shell server. 60s [[0;32m OK [0m] Stopped [0;1;39mapport.service[0m - automatic crash report generation. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed. 60s [[0;32m OK [0m] Stopped [0;1;39msession-5.scope[0m - Session 5 of User ubuntu. 60s [[0;32m OK [0m] Removed slice [0;1;39msystem-getty.slice[0m - Slice /system/getty. 60s [[0;32m OK [0m] Removed slice [0;1;39msystem-serial\x2dget���slice[0m - Slice /system/serial-getty. 60s [[0;32m OK [0m] Stopped [0;1;39mplymouth-quit-wait.service[0m���old until boot process finishes up. 60s Stopping [0;1;39muser@1000.service[0m - User Manager for UID 1000... 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-networkd-persisten���[0mistent Storage in systemd-networkd. 60s [[0;32m OK [0m] Stopped [0;1;39muser@1000.service[0m - User Manager for UID 1000. 60s Stopping [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions... 60s Stopping [0;1;39muser-runtime-dir@1000.ser���[0mRuntime Directory /run/user/1000... 60s [[0;32m OK [0m] Unmounted [0;1;39mrun-user-1000.mount[0m - /run/user/1000. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions. 60s [[0;32m OK [0m] Stopped [0;1;39muser-runtime-dir@1000.serv���[0mr Runtime Directory /run/user/1000. 60s [[0;32m OK [0m] Removed slice [0;1;39muser-1000.slice[0m - User Slice of UID 1000. 60s [[0;32m OK [0m] Stopped target [0;1;39mnetwork.target[0m - Network. 60s [[0;32m OK [0m] Stopped target [0;1;39mremote-fs.target[0m - Remote File Systems. 60s Stopping [0;1;39msystemd-logind.service[0m - User Login Management... 60s Stopping [0;1;39msystemd-networkd.service[0m - Network Configuration... 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-logind.service[0m - User Login Management. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-networkd.service[0m - Network Configuration. 60s [[0;32m OK [0m] Stopped target [0;1;39mbasic.target[0m - Basic System. 60s [[0;32m OK [0m] Stopped target [0;1;39mnetwork-pre.target[0m - Preparation for Network. 60s [[0;32m OK [0m] Stopped target [0;1;39mpaths.target[0m - Path Units. 60s [[0;32m OK [0m] Stopped target [0;1;39mslices.target[0m - Slice Units. 60s [[0;32m OK [0m] Removed slice [0;1;39muser.slice[0m - User and Session Slice. 60s [[0;32m OK [0m] Stopped target [0;1;39msockets.target[0m - Socket Units. 60s [[0;32m OK [0m] Closed [0;1;39mlxd-installer.socket[0m - Helper to install lxd snap on demand. 60s [[0;32m OK [0m] Closed [0;1;39mssh.socket[0m - OpenBSD Secure Shell server socket. 60s [[0;32m OK [0m] Closed [0;1;39msshd-unix-local.socket[0m - Op���temd-ssh-generator, AF_UNIX Local). 60s [[0;32m OK [0m] Closed [0;1;39msshd-vsock.socket[0m - OpenSSH��� (systemd-ssh-generator, AF_VSOCK). 60s [[0;32m OK [0m] Closed [0;1;39msyslog.socket[0m - Syslog Socket. 60s [[0;32m OK [0m] Closed [0;1;39msystemd-hostnamed.socket[0m - Hostname Service Socket. 60s [[0;32m OK [0m] Closed [0;1;39msystemd-networkd.socket[0m - Network Service Netlink Socket. 60s [[0;32m OK [0m] Closed [0;1;39muuidd.socket[0m - UUID daemon activation socket. 60s [[0;32m OK [0m] Stopped target [0;1;39msysinit.target[0m - System Initialization. 60s [[0;32m OK [0m] Stopped target [0;1;39mcryptsetup.target[0m - Local Encrypted Volumes. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-ask-password-conso���[0mequests to Console Directory Watch. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-ask-password-wall.���[0md Requests to Wall Directory Watch. 60s [[0;32m OK [0m] Stopped target [0;1;39mintegritysetup.targ���[0m Local Integrity Protected Volumes. 60s [[0;32m OK [0m] Stopped target [0;1;39mswap.target[0m - Swaps. 60s [[0;32m OK [0m] Stopped target [0;1;39mveritysetup.target[0m - Local Verity Protected Volumes. 60s [[0;32m OK [0m] Stopped [0;1;39mcloud-init-network.service[0m - Cloud-init: Network Stage. 60s [[0;32m OK [0m] Stopped [0;1;39mcloud-init-local.service[0m -���ud-init: Local Stage (pre-network). 60s Stopping [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats... 60s Stopping [0;1;39msystemd-resolved.service[0m - Network Name Resolution... 60s Stopping [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization... 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-tmpfiles-setup.ser���[0mreate System Files and Directories. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-resolved.service[0m - Network Name Resolution. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats. 60s [[0;32m OK [0m] Unset automount [0;1;39mproc-sys-fs-binfmt���[0mormats File System Automount Point. 60s [[0;32m OK [0m] Stopped target [0;1;39mlocal-fs.target[0m - Local File Systems. 60s Unmounting [0;1;39mboot-efi.mount[0m - /boot/efi... 60s Unmounting [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock... 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules. 60s [[0;32m OK [0m] Unmounted [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock. 60s [[0;32m OK [0m] Unmounted [0;1;39mboot-efi.mount[0m - /boot/efi. 60s Unmounting [0;1;39mboot.mount[0m - /boot... 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-fsck@dev-disk-by\x���[0mm Check on /dev/disk/by-label/UEFI. 60s [[0;32m OK [0m] Unmounted [0;1;39mboot.mount[0m - /boot. 60s [[0;32m OK [0m] Reached target [0;1;39mumount.target[0m - Unmount All Filesystems. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-fsck@dev-disk-by\x���[0mm Check on /dev/disk/by-label/BOOT. 60s [[0;32m OK [0m] Removed slice [0;1;39msystem-systemd\x2dfs���slice[0m - Slice /system/systemd-fsck. 60s [[0;32m OK [0m] Stopped target [0;1;39mlocal-fs-pre.target[0m���Preparation for Local File Systems. 60s Stopping [0;1;39mmultipathd.service[0m - Devi���pper Multipath Device Controller... 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-tmpfiles-setup-dev���[0mCreate Static Device Nodes in /dev. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-tmpfiles-setup-dev���[0mic Device Nodes in /dev gracefully. 60s [[0;32m OK [0m] Stopped [0;1;39mmultipathd.service[0m - Devic���Mapper Multipath Device Controller. 60s [[0;32m OK [0m] Stopped [0;1;39msystemd-remount-fs.service[0m���mount Root and Kernel File Systems. 60s [[0;32m OK [0m] Reached target [0;1;39mshutdown.target[0m - System Shutdown. 60s [[0;32m OK [0m] Reached target [0;1;39mfinal.target[0m - Late Shutdown Services. 60s [[0;32m OK [0m] Finished [0;1;39msystemd-reboot.service[0m - System Reboot. 60s [[0;32m OK [0m] Reached target [0;1;39mreboot.target[0m - System Reboot. 60s [ 38.851059] reboot: Restarting system 60s 60s --------------------------------------------------- 60s ------- nova show 92d66376-e66e-4dd1-bfd4-aea6b31d32fd (adt-questing-amd64-dahdi-linux-20250619-233448-juju-7f2275-prod-proposed-migration-environment-2-42d09514-0402-40fc-9b40-a389222131ad) ------ 60s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 60s | Property | Value | 60s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 60s | OS-DCF:diskConfig | MANUAL | 60s | OS-EXT-AZ:availability_zone | AZ1 | 60s | OS-EXT-SRV-ATTR:host | ps7-ra2-n1.ps7.canonical.com | 60s | OS-EXT-SRV-ATTR:hostname | adt-questing-amd64-dahdi-linux-20250619-233448-juju-7f2275-prod | 60s | OS-EXT-SRV-ATTR:hypervisor_hostname | ps7-ra2-n1.ps7.canonical.com | 60s | OS-EXT-SRV-ATTR:instance_name | instance-0009de31 | 60s | OS-EXT-SRV-ATTR:kernel_id | | 60s | OS-EXT-SRV-ATTR:launch_index | 0 | 60s | OS-EXT-SRV-ATTR:ramdisk_id | | 60s | OS-EXT-SRV-ATTR:reservation_id | r-pcuj6j29 | 60s | OS-EXT-SRV-ATTR:root_device_name | /dev/vda | 60s | OS-EXT-STS:power_state | 1 | 60s | OS-EXT-STS:task_state | - | 60s | OS-EXT-STS:vm_state | active | 60s | OS-SRV-USG:launched_at | 2025-06-20T00:39:30.000000 | 60s | OS-SRV-USG:terminated_at | - | 60s | accessIPv4 | | 60s | accessIPv6 | | 60s | config_drive | | 60s | created | 2025-06-20T00:39:19Z | 60s | description | - | 60s | flavor:disk | 20 | 60s | flavor:ephemeral | 0 | 60s | flavor:extra_specs | {"aggregate_instance_extra_specs:commit": "amd64", "hw:cpu_policy": "shared", "hw:mem_page_size": "large", "hw:pci_numa_affinity_policy": "preferred"} | 60s | flavor:original_name | autopkgtest-cpu2-ram4-disk20-amd64 | 60s | flavor:ram | 4096 | 60s | flavor:swap | 0 | 60s | flavor:vcpus | 2 | 60s | hostId | 1b0dc5048077e09408c0c755210092eaa95d835d0cdbfe3ecf451437 | 60s | id | 92d66376-e66e-4dd1-bfd4-aea6b31d32fd | 60s | image | adt/ubuntu-questing-amd64-server-20250619.img (f2fe812e-b164-45c0-b2ab-1b0b09a5b610) | 60s | key_name | testbed-juju-7f2275-prod-proposed-migration-environment-2 | 60s | locked | False | 60s | locked_reason | - | 60s | metadata | {} | 60s | name | adt-questing-amd64-dahdi-linux-20250619-233448-juju-7f2275-prod-proposed-migration-environment-2-42d09514-0402-40fc-9b40-a389222131ad | 60s | net_prod-autopkgtest-workers-amd64 network | 10.151.36.196 | 60s | os-extended-volumes:volumes_attached | [] | 60s | progress | 0 | 60s | security_groups | autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-21.secgroup | 60s | server_groups | [] | 60s | status | ACTIVE | 60s | tags | [] | 60s | tenant_id | c20da633fc2e44cd97ff31be0acd959a | 60s | trusted_image_certificates | - | 60s | updated | 2025-06-20T00:39:30Z | 60s | user_id | d1c206dbd7b64e3eacefc738fd9acdca | 60s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 60s --------------------------------------------------- 60s 91s nova [W] Skipping flock for amd64 91s Creating nova instance adt-questing-amd64-dahdi-linux-20250619-233448-juju-7f2275-prod-proposed-migration-environment-2-42d09514-0402-40fc-9b40-a389222131ad from image adt/ubuntu-questing-amd64-server-20250619.img (UUID f2fe812e-b164-45c0-b2ab-1b0b09a5b610)... 91s nova [W] Timed out waiting for 92d66376-e66e-4dd1-bfd4-aea6b31d32fd to get deleted. 91s autopkgtest [00:40:45]: ERROR: testbed failure: sent `auxverb_debug_fail', got `copy-failed', expected `ok...'