0s autopkgtest [08:45:01]: starting date and time: 2025-10-30 08:45:01+0000 0s autopkgtest [08:45:01]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [08:45:01]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.t_s_yyz8/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:linux-meta-oem-6.17,src:linux-oem-6.17,src:linux-signed-oem-6.17 --apt-upgrade dkms --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=linux-meta-oem-6.17/6.17.0-1006.6 linux-oem-6.17/6.17.0-1006.6 linux-signed-oem-6.17/6.17.0-1006.6' --setup-commands 'apt-get install -y ^kernel-testing--linux\-oem\-6\.17--full--preferred$ || apt-get install -y ^linux-image\-oem\-24\.04$ ^linux-headers\-oem\-24\.04$ || apt-get install -y ^linux-image-generic\-oem\-24\.04$ ^linux-headers-generic\-oem\-24\.04$' --setup-commands 'apt-get install -y ^kernel-testing--linux\-oem\-6\.17--modules-extra--preferred$ || apt-get install -y ^linux-modules-extra\-oem\-24\.04$ || :' -- 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-8.secgroup --name adt-noble-amd64-dkms-20251030-082337-juju-7f2275-prod-proposed-migration-environment-2-8cee583f-6b75-42ab-b784-dfda3a07a7b8 --image adt/ubuntu-noble-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/ 4s Creating nova instance adt-noble-amd64-dkms-20251030-082337-juju-7f2275-prod-proposed-migration-environment-2-8cee583f-6b75-42ab-b784-dfda3a07a7b8 from image adt/ubuntu-noble-amd64-server-20251029.img (UUID b41dc4cf-b23a-49ac-8f53-9fa4b547e195)... 324s ------- nova console-log dd076af6-5d69-4a49-ae43-def5759658f7 (adt-noble-amd64-dkms-20251030-082337-juju-7f2275-prod-proposed-migration-environment-2-8cee583f-6b75-42ab-b784-dfda3a07a7b8) ------ 326s [ 0.000000] Linux version 6.8.0-86-generic (buildd@lcy02-amd64-031) (x86_64-linux-gnu-gcc-13 (Ubuntu 13.3.0-6ubuntu2~24.04) 13.3.0, GNU ld (GNU Binutils for Ubuntu) 2.42) #87-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 22 18:03:36 UTC 2025 (Ubuntu 6.8.0-86.87-generic 6.8.12) 326s [ 0.000000] Command line: BOOT_IMAGE=/vmlinuz-6.8.0-86-generic root=UUID=ffe7eb40-94f7-473b-b336-935460126345 ro console=tty0 console=hvc0 console=ttyS0 326s [ 0.000000] KERNEL supported cpus: 326s [ 0.000000] Intel GenuineIntel 326s [ 0.000000] AMD AuthenticAMD 326s [ 0.000000] Hygon HygonGenuine 326s [ 0.000000] Centaur CentaurHauls 326s [ 0.000000] zhaoxin Shanghai 326s [ 0.000000] BIOS-provided physical RAM map: 326s [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable 326s [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved 326s [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved 326s [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdcfff] usable 326s [ 0.000000] BIOS-e820: [mem 0x00000000bffdd000-0x00000000bfffffff] reserved 326s [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved 326s [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved 326s [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable 326s [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved 326s [ 0.000000] NX (Execute Disable) protection: active 326s [ 0.000000] APIC: Static calls initialized 326s [ 0.000000] SMBIOS 2.8 present. 326s [ 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 326s [ 0.000000] Hypervisor detected: KVM 326s [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 326s [ 0.000000] kvm-clock: using sched offset of 1937084019 cycles 326s [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns 326s [ 0.000004] tsc: Detected 2396.398 MHz processor 326s [ 0.000874] last_pfn = 0x140000 max_arch_pfn = 0x400000000 326s [ 0.000912] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs 326s [ 0.000915] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT 326s [ 0.000963] last_pfn = 0xbffdd max_arch_pfn = 0x400000000 326s [ 0.003192] found SMP MP-table at [mem 0x000f53c0-0x000f53cf] 326s [ 0.003206] Using GB pages for direct mapping 326s [ 0.003295] RAMDISK: [mem 0x2ffa3000-0x33fc8fff] 326s [ 0.003633] ACPI: Early table checksum verification disabled 326s [ 0.003636] ACPI: RSDP 0x00000000000F5140 000014 (v00 BOCHS ) 326s [ 0.003639] ACPI: RSDT 0x00000000BFFE2334 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) 326s [ 0.003644] ACPI: FACP 0x00000000BFFE2150 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) 326s [ 0.003648] ACPI: DSDT 0x00000000BFFE0040 002110 (v01 BOCHS BXPC 00000001 BXPC 00000001) 326s [ 0.003651] ACPI: FACS 0x00000000BFFE0000 000040 326s [ 0.003653] ACPI: APIC 0x00000000BFFE21C4 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) 326s [ 0.003655] ACPI: SRAT 0x00000000BFFE2244 0000C8 (v01 BOCHS BXPC 00000001 BXPC 00000001) 326s [ 0.003657] ACPI: WAET 0x00000000BFFE230C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) 326s [ 0.003659] ACPI: Reserving FACP table memory at [mem 0xbffe2150-0xbffe21c3] 326s [ 0.003660] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe214f] 326s [ 0.003661] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] 326s [ 0.003661] ACPI: Reserving APIC table memory at [mem 0xbffe21c4-0xbffe2243] 326s [ 0.003662] ACPI: Reserving SRAT table memory at [mem 0xbffe2244-0xbffe230b] 326s [ 0.003663] ACPI: Reserving WAET table memory at [mem 0xbffe230c-0xbffe2333] 326s [ 0.003730] SRAT: PXM 0 -> APIC 0x00 -> Node 0 326s [ 0.003731] SRAT: PXM 0 -> APIC 0x01 -> Node 0 326s [ 0.003732] ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x0009ffff] 326s [ 0.003734] ACPI: SRAT: Node 0 PXM 0 [mem 0x00100000-0xbfffffff] 326s [ 0.003735] ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x13fffffff] 326s [ 0.003737] NUMA: Node 0 [mem 0x00000000-0x0009ffff] + [mem 0x00100000-0xbfffffff] -> [mem 0x00000000-0xbfffffff] 326s [ 0.003739] NUMA: Node 0 [mem 0x00000000-0xbfffffff] + [mem 0x100000000-0x13fffffff] -> [mem 0x00000000-0x13fffffff] 326s [ 0.003747] NODE_DATA(0) allocated [mem 0x13ffd3000-0x13fffdfff] 326s [ 0.003892] Zone ranges: 326s [ 0.003893] DMA [mem 0x0000000000001000-0x0000000000ffffff] 326s [ 0.003894] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] 326s [ 0.003895] Normal [mem 0x0000000100000000-0x000000013fffffff] 326s [ 0.003897] Device empty 326s [ 0.003898] Movable zone start for each node 326s [ 0.003899] Early memory node ranges 326s [ 0.003899] node 0: [mem 0x0000000000001000-0x000000000009efff] 326s [ 0.003901] node 0: [mem 0x0000000000100000-0x00000000bffdcfff] 326s [ 0.003902] node 0: [mem 0x0000000100000000-0x000000013fffffff] 326s [ 0.003903] Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] 326s [ 0.003908] On node 0, zone DMA: 1 pages in unavailable ranges 326s [ 0.003920] On node 0, zone DMA: 97 pages in unavailable ranges 326s [ 0.006488] On node 0, zone Normal: 35 pages in unavailable ranges 326s [ 0.006893] ACPI: PM-Timer IO Port: 0x608 326s [ 0.006905] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) 326s [ 0.006932] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 326s [ 0.006934] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) 326s [ 0.006936] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) 326s [ 0.006937] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) 326s [ 0.006938] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) 326s [ 0.006939] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) 326s [ 0.006942] ACPI: Using ACPI (MADT) for SMP configuration information 326s [ 0.006943] smpboot: Allowing 2 CPUs, 0 hotplug CPUs 326s [ 0.006963] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() 326s [ 0.006978] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] 326s [ 0.006979] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x0009ffff] 326s [ 0.006980] PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000effff] 326s [ 0.006981] PM: hibernation: Registered nosave memory: [mem 0x000f0000-0x000fffff] 326s [ 0.006982] PM: hibernation: Registered nosave memory: [mem 0xbffdd000-0xbfffffff] 326s [ 0.006982] PM: hibernation: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] 326s [ 0.006983] PM: hibernation: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] 326s [ 0.006984] PM: hibernation: Registered nosave memory: [mem 0xff000000-0xfffbffff] 326s [ 0.006984] PM: hibernation: Registered nosave memory: [mem 0xfffc0000-0xffffffff] 326s [ 0.006986] [mem 0xc0000000-0xfeffbfff] available for PCI devices 326s [ 0.006987] Booting paravirtualized kernel on KVM 326s [ 0.006989] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns 326s [ 0.006996] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 326s [ 0.007090] percpu: Embedded 86 pages/cpu s229376 r8192 d114688 u1048576 326s [ 0.007118] kvm-guest: PV spinlocks disabled, no host support 326s [ 0.007119] Kernel command line: BOOT_IMAGE=/vmlinuz-6.8.0-86-generic root=UUID=ffe7eb40-94f7-473b-b336-935460126345 ro console=tty0 console=hvc0 console=ttyS0 326s [ 0.007176] Unknown kernel command line parameters "BOOT_IMAGE=/vmlinuz-6.8.0-86-generic", will be passed to user space. 326s [ 0.007189] random: crng init done 326s [ 0.007328] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) 326s [ 0.007402] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) 326s [ 0.007428] Fallback order for Node 0: 0 326s [ 0.007431] Built 1 zonelists, mobility grouping on. Total pages: 1031901 326s [ 0.007432] Policy zone: Normal 326s [ 0.007436] mem auto-init: stack:all(zero), heap alloc:on, heap free:off 326s [ 0.007440] software IO TLB: area num 2. 326s [ 0.016904] Memory: 3934960K/4193772K available (22528K kernel code, 4441K rwdata, 14384K rodata, 4912K init, 4796K bss, 258552K reserved, 0K cma-reserved) 326s [ 0.017800] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 326s [ 0.017823] ftrace: allocating 58191 entries in 228 pages 326s [ 0.029587] ftrace: allocated 228 pages with 4 groups 326s [ 0.030434] Dynamic Preempt: voluntary 326s [ 0.030474] rcu: Preemptible hierarchical RCU implementation. 326s [ 0.030475] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=2. 326s [ 0.030476] Trampoline variant of Tasks RCU enabled. 326s [ 0.030477] Rude variant of Tasks RCU enabled. 326s [ 0.030477] Tracing variant of Tasks RCU enabled. 326s [ 0.030478] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. 326s [ 0.030479] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 326s [ 0.030487] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. 326s [ 0.030488] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. 326s [ 0.030489] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. 326s [ 0.033019] NR_IRQS: 524544, nr_irqs: 440, preallocated irqs: 16 326s [ 0.033237] rcu: srcu_init: Setting srcu_struct sizes based on contention. 326s [ 0.042416] Console: colour VGA+ 80x25 326s [ 0.042420] printk: legacy console [tty0] enabled 326s [ 0.079374] printk: legacy console [ttyS0] enabled 326s [ 0.187751] ACPI: Core revision 20230628 326s [ 0.188576] APIC: Switch to symmetric I/O mode setup 326s [ 0.189684] x2apic enabled 326s [ 0.190521] APIC: Switched APIC routing to: physical x2apic 326s [ 0.192597] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 326s [ 0.193666] tsc: Marking TSC unstable due to TSCs unsynchronized 326s [ 0.195328] Calibrating delay loop (skipped) preset value.. 4792.79 BogoMIPS (lpj=2396398) 326s [ 0.197415] x86/cpu: User Mode Instruction Prevention (UMIP) activated 326s [ 0.198671] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 326s [ 0.199575] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 326s [ 0.200594] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization 326s [ 0.202326] Spectre V2 : Mitigation: Retpolines 326s [ 0.203132] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch 326s [ 0.204325] Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT 326s [ 0.205595] Spectre V2 : Enabling Speculation Barrier for firmware calls 326s [ 0.206595] RETBleed: Mitigation: untrained return thunk 326s [ 0.207568] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier 326s [ 0.209325] Speculative Store Bypass: Vulnerable 326s [ 0.210151] Speculative Return Stack Overflow: IBPB-extending microcode not applied! 326s [ 0.211325] Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. 326s [ 0.211326] Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode 326s [ 0.214689] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' 326s [ 0.216326] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' 326s [ 0.218327] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' 326s [ 0.220326] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 326s [ 0.222325] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. 326s [ 0.250846] Freeing SMP alternatives memory: 48K 326s [ 0.251577] pid_max: default: 32768 minimum: 301 326s [ 0.252630] LSM: initializing lsm=lockdown,capability,landlock,yama,apparmor,integrity 326s [ 0.253726] landlock: Up and running. 326s [ 0.254546] Yama: becoming mindful. 326s [ 0.256117] AppArmor: AppArmor initialized 326s [ 0.256606] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 326s [ 0.258328] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) 326s [ 0.362154] smpboot: CPU0: AMD EPYC-Rome Processor (family: 0x17, model: 0x31, stepping: 0x0) 326s [ 0.363012] Performance Events: Fam17h+ core perfctr, AMD PMU driver. 326s [ 0.364328] ... version: 0 326s [ 0.365101] ... bit width: 48 326s [ 0.365559] ... generic registers: 6 326s [ 0.366554] ... value mask: 0000ffffffffffff 326s [ 0.367586] ... max period: 00007fffffffffff 326s [ 0.368595] ... fixed-purpose events: 0 326s [ 0.369326] ... event mask: 000000000000003f 326s [ 0.370416] signal: max sigframe size: 1776 326s [ 0.371334] rcu: Hierarchical SRCU implementation. 326s [ 0.372227] rcu: Max phase no-delay instances is 400. 326s [ 0.376585] smp: Bringing up secondary CPUs ... 326s [ 0.377456] smpboot: x86: Booting SMP configuration: 326s [ 0.378328] .... node #0, CPUs: #1 326s [ 0.378474] smp: Brought up 1 node, 2 CPUs 326s [ 0.380560] smpboot: Max logical packages: 2 326s [ 0.381326] smpboot: Total of 2 processors activated (9585.59 BogoMIPS) 326s [ 0.382849] devtmpfs: initialized 326s [ 0.383598] x86/mm: Memory block size: 128MB 326s [ 0.385436] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns 326s [ 0.387336] futex hash table entries: 512 (order: 3, 32768 bytes, linear) 326s [ 0.388393] pinctrl core: initialized pinctrl subsystem 326s [ 0.389744] PM: RTC time: 08:45:16, date: 2025-10-30 326s [ 0.390987] NET: Registered PF_NETLINK/PF_ROUTE protocol family 326s [ 0.392338] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations 326s [ 0.393343] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations 326s [ 0.394730] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations 326s [ 0.396335] audit: initializing netlink subsys (disabled) 326s [ 0.397359] audit: type=2000 audit(1761813917.788:1): state=initialized audit_enabled=0 res=1 326s [ 0.397483] thermal_sys: Registered thermal governor 'fair_share' 326s [ 0.398729] thermal_sys: Registered thermal governor 'bang_bang' 326s [ 0.399606] thermal_sys: Registered thermal governor 'step_wise' 326s [ 0.401326] thermal_sys: Registered thermal governor 'user_space' 326s [ 0.402326] thermal_sys: Registered thermal governor 'power_allocator' 326s [ 0.403340] cpuidle: using governor ladder 326s [ 0.406117] cpuidle: using governor menu 326s [ 0.407430] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 326s [ 0.408766] PCI: Using configuration type 1 for base access 326s [ 0.409600] PCI: Using configuration type 1 for extended access 326s [ 0.410756] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. 326s [ 0.425472] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages 326s [ 0.426646] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page 326s [ 0.427628] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages 326s [ 0.429636] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page 326s [ 0.431325] ACPI: Added _OSI(Module Device) 326s [ 0.431561] ACPI: Added _OSI(Processor Device) 326s [ 0.432326] ACPI: Added _OSI(3.0 _SCP Extensions) 326s [ 0.433331] ACPI: Added _OSI(Processor Aggregator Device) 326s [ 0.436833] ACPI: 1 ACPI AML tables successfully acquired and loaded 326s [ 0.439491] ACPI: _OSC evaluation for CPUs failed, trying _PDC 326s [ 0.440803] ACPI: Interpreter enabled 326s [ 0.441560] ACPI: PM: (supports S0 S3 S4 S5) 326s [ 0.442327] ACPI: Using IOAPIC for interrupt routing 326s [ 0.443531] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug 326s [ 0.445745] PCI: Using E820 reservations for host bridge windows 326s [ 0.446434] ACPI: Enabled 2 GPEs in block 00 to 0F 326s [ 0.450891] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) 326s [ 0.452629] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI EDR HPX-Type3] 326s [ 0.454845] acpiphp: Slot [3] registered 326s [ 0.455571] acpiphp: Slot [4] registered 326s [ 0.455571] acpiphp: Slot [5] registered 326s [ 0.456570] acpiphp: Slot [6] registered 326s [ 0.457344] acpiphp: Slot [7] registered 326s [ 0.458117] acpiphp: Slot [8] registered 326s [ 0.458568] acpiphp: Slot [9] registered 326s [ 0.459565] acpiphp: Slot [10] registered 326s [ 0.460348] acpiphp: Slot [11] registered 326s [ 0.461169] acpiphp: Slot [12] registered 326s [ 0.462580] acpiphp: Slot [13] registered 326s [ 0.462580] acpiphp: Slot [14] registered 326s [ 0.463566] acpiphp: Slot [15] registered 326s [ 0.465581] acpiphp: Slot [16] registered 326s [ 0.465581] acpiphp: Slot [17] registered 326s [ 0.466344] acpiphp: Slot [18] registered 326s [ 0.467343] acpiphp: Slot [19] registered 326s [ 0.468174] acpiphp: Slot [20] registered 326s [ 0.469575] acpiphp: Slot [21] registered 326s [ 0.469575] acpiphp: Slot [22] registered 326s [ 0.470358] acpiphp: Slot [23] registered 326s [ 0.471346] acpiphp: Slot [24] registered 326s [ 0.472151] acpiphp: Slot [25] registered 326s [ 0.473576] acpiphp: Slot [26] registered 326s [ 0.473576] acpiphp: Slot [27] registered 326s [ 0.474566] acpiphp: Slot [28] registered 326s [ 0.475343] acpiphp: Slot [29] registered 326s [ 0.476131] acpiphp: Slot [30] registered 326s [ 0.477569] acpiphp: Slot [31] registered 326s [ 0.477569] PCI host bridge to bus 0000:00 326s [ 0.478328] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] 326s [ 0.479624] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] 326s [ 0.480646] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] 326s [ 0.482327] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] 326s [ 0.483697] pci_bus 0000:00: root bus resource [mem 0xc000000000-0xc07fffffff window] 326s [ 0.485718] pci_bus 0000:00: root bus resource [bus 00-ff] 326s [ 0.486334] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint 326s [ 0.488187] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint 326s [ 0.490346] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint 326s [ 0.492739] pci 0000:00:01.1: BAR 4 [io 0xc140-0xc14f] 326s [ 0.493615] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk 326s [ 0.495326] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk 326s [ 0.496327] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk 326s [ 0.497626] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk 326s [ 0.498794] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint 326s [ 0.500656] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI 326s [ 0.502705] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB 326s [ 0.503535] pci 0000:00:02.0: [1b36:0100] type 00 class 0x030000 conventional PCI endpoint 326s [ 0.509336] pci 0000:00:02.0: BAR 0 [mem 0xf4000000-0xf7ffffff] 326s [ 0.510622] pci 0000:00:02.0: BAR 1 [mem 0xf8000000-0xfbffffff] 326s [ 0.511610] pci 0000:00:02.0: BAR 2 [mem 0xfc090000-0xfc091fff] 326s [ 0.512334] pci 0000:00:02.0: BAR 3 [io 0xc100-0xc11f] 326s [ 0.513346] pci 0000:00:02.0: ROM [mem 0xfc080000-0xfc08ffff pref] 326s [ 0.514369] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] 326s [ 0.516975] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint 326s [ 0.519120] pci 0000:00:03.0: BAR 0 [io 0xc000-0xc03f] 326s [ 0.520594] pci 0000:00:03.0: BAR 1 [mem 0xfc092000-0xfc092fff] 326s [ 0.521352] pci 0000:00:03.0: BAR 4 [mem 0xc000000000-0xc000003fff 64bit pref] 326s [ 0.522701] pci 0000:00:03.0: ROM [mem 0xfc000000-0xfc07ffff pref] 326s [ 0.525878] pci 0000:00:04.0: [1af4:1004] type 00 class 0x010000 conventional PCI endpoint 326s [ 0.529335] pci 0000:00:04.0: BAR 0 [io 0xc040-0xc07f] 326s [ 0.530593] pci 0000:00:04.0: BAR 1 [mem 0xfc093000-0xfc093fff] 326s [ 0.531654] pci 0000:00:04.0: BAR 4 [mem 0xc000004000-0xc000007fff 64bit pref] 326s [ 0.534047] pci 0000:00:05.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint 326s [ 0.536335] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] 326s [ 0.537594] pci 0000:00:05.0: BAR 1 [mem 0xfc094000-0xfc094fff] 326s [ 0.538623] pci 0000:00:05.0: BAR 4 [mem 0xc000008000-0xc00000bfff 64bit pref] 326s [ 0.541727] pci 0000:00:06.0: [1af4:1002] type 00 class 0x00ff00 conventional PCI endpoint 326s [ 0.543929] pci 0000:00:06.0: BAR 0 [io 0xc0c0-0xc0ff] 326s [ 0.545594] pci 0000:00:06.0: BAR 1 [mem 0xfc095000-0xfc095fff] 326s [ 0.546357] pci 0000:00:06.0: BAR 4 [mem 0xc00000c000-0xc00000ffff 64bit pref] 326s [ 0.549266] pci 0000:00:07.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint 326s [ 0.551855] pci 0000:00:07.0: BAR 0 [io 0xc120-0xc13f] 326s [ 0.552592] pci 0000:00:07.0: BAR 1 [mem 0xfc096000-0xfc096fff] 326s [ 0.554624] pci 0000:00:07.0: BAR 4 [mem 0xc000010000-0xc000013fff 64bit pref] 326s [ 0.564372] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 326s [ 0.565480] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 326s [ 0.566737] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 326s [ 0.571484] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 326s [ 0.572413] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 326s [ 0.574345] iommu: Default domain type: Translated 326s [ 0.574577] iommu: DMA domain TLB invalidation policy: lazy mode 326s [ 0.576813] SCSI subsystem initialized 326s [ 0.577570] ACPI: bus type USB registered 326s [ 0.577570] usbcore: registered new interface driver usbfs 326s [ 0.578596] usbcore: registered new interface driver hub 326s [ 0.579599] usbcore: registered new device driver usb 326s [ 0.580605] pps_core: LinuxPPS API ver. 1 registered 326s [ 0.581600] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti 326s [ 0.583333] PTP clock support registered 326s [ 0.584373] EDAC MC: Ver: 3.0.0 326s [ 0.585584] NetLabel: Initializing 326s [ 0.586327] NetLabel: domain hash size = 128 326s [ 0.587327] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 326s [ 0.588351] NetLabel: unlabeled traffic allowed by default 326s [ 0.589389] mctp: management component transport protocol core 326s [ 0.590326] NET: Registered PF_MCTP protocol family 326s [ 0.591332] PCI: Using ACPI for IRQ routing 326s [ 0.592449] pci 0000:00:02.0: vgaarb: setting as boot VGA device 326s [ 0.593325] pci 0000:00:02.0: vgaarb: bridge control possible 326s [ 0.593325] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none 326s [ 0.596327] vgaarb: loaded 326s [ 0.597433] clocksource: Switched to clocksource kvm-clock 326s [ 0.598527] VFS: Disk quotas dquot_6.6.0 326s [ 0.599369] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 326s [ 0.600774] AppArmor: AppArmor Filesystem Enabled 326s [ 0.601690] pnp: PnP ACPI init 326s [ 0.602696] pnp: PnP ACPI: found 5 devices 326s [ 0.609524] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns 326s [ 0.611206] NET: Registered PF_INET protocol family 326s [ 0.612234] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) 326s [ 0.626777] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) 326s [ 0.628367] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 326s [ 0.629822] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) 326s [ 0.631321] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) 326s [ 0.632765] TCP: Hash tables configured (established 32768 bind 32768) 326s [ 0.633991] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear) 326s [ 0.635378] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) 326s [ 0.636594] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) 326s [ 0.637898] NET: Registered PF_UNIX/PF_LOCAL protocol family 326s [ 0.638947] NET: Registered PF_XDP protocol family 326s [ 0.639851] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] 326s [ 0.641008] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] 326s [ 0.642131] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] 326s [ 0.643378] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] 326s [ 0.645164] pci_bus 0000:00: resource 8 [mem 0xc000000000-0xc07fffffff window] 326s [ 0.646576] pci 0000:00:01.0: PIIX3: Enabling Passive Release 326s [ 0.647636] pci 0000:00:00.0: Limiting direct PCI/PCI transfers 326s [ 0.648787] PCI: CLS 0 bytes, default 64 326s [ 0.649645] Trying to unpack rootfs image as initramfs... 326s [ 0.652099] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) 326s [ 0.653292] software IO TLB: mapped [mem 0x00000000bbfdd000-0x00000000bffdd000] (64MB) 326s [ 0.655235] Initialise system trusted keyrings 326s [ 0.656107] Key type blacklist registered 326s [ 0.659127] workingset: timestamp_bits=36 max_order=20 bucket_order=0 326s [ 0.660305] zbud: loaded 326s [ 0.661099] squashfs: version 4.0 (2009/01/31) Phillip Lougher 326s [ 0.662264] fuse: init (API version 7.39) 326s [ 0.663236] integrity: Platform Keyring initialized 326s [ 0.664162] integrity: Machine keyring initialized 326s [ 0.675094] Key type asymmetric registered 326s [ 0.675898] Asymmetric key parser 'x509' registered 326s [ 0.676831] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) 326s [ 0.678257] io scheduler mq-deadline registered 326s [ 0.679292] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 326s [ 0.680642] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 326s [ 0.682111] ACPI: button: Power Button [PWRF] 326s [ 0.684560] ACPI: \_SB_.LNKC: Enabled at IRQ 11 326s [ 0.687782] ACPI: \_SB_.LNKD: Enabled at IRQ 10 326s [ 0.690923] ACPI: \_SB_.LNKA: Enabled at IRQ 10 326s [ 0.694001] ACPI: \_SB_.LNKB: Enabled at IRQ 11 326s [ 0.698843] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled 326s [ 0.723732] 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A 326s [ 0.726967] Freeing initrd memory: 65688K 326s [ 0.738292] Linux agpgart interface v0.103 326s [ 0.740602] loop: module loaded 326s [ 0.741764] virtio_scsi virtio1: 2/0/0 default/read/poll queues 326s [ 0.744146] scsi host0: Virtio SCSI HBA 326s [ 0.746785] scsi 0:0:0:0: Direct-Access QEMU QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 326s [ 0.748430] scsi host1: ata_piix 326s [ 0.749312] scsi host2: ata_piix 326s [ 0.750101] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc140 irq 14 lpm-pol 0 326s [ 0.751536] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc148 irq 15 lpm-pol 0 326s [ 0.753117] ACPI: bus type drm_connector registered 326s [ 0.755128] tun: Universal TUN/TAP device driver, 1.6 326s [ 0.759489] PPP generic driver version 2.4.2 326s [ 0.760501] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 326s [ 0.763009] serio: i8042 KBD port at 0x60,0x64 irq 1 326s [ 0.764123] serio: i8042 AUX port at 0x60,0x64 irq 12 326s [ 0.765373] mousedev: PS/2 mouse device common for all mice 326s [ 0.766949] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 326s [ 0.768899] rtc_cmos 00:04: RTC can wake from S4 326s [ 0.771186] rtc_cmos 00:04: registered as rtc0 326s [ 0.772111] rtc_cmos 00:04: setting system clock to 2025-10-30T08:45:17 UTC (1761813917) 326s [ 0.773822] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram 326s [ 0.775063] i2c_dev: i2c /dev entries driver 326s [ 0.776057] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 326s [ 0.776175] sd 0:0:0:0: Power-on or device reset occurred 326s [ 0.777768] device-mapper: uevent: version 1.0.3 326s [ 0.778504] sd 0:0:0:0: Attached scsi generic sg0 type 0 326s [ 0.779197] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com 326s [ 0.779922] sd 0:0:0:0: [sda] 41943040 512-byte logical blocks: (21.5 GB/20.0 GiB) 326s [ 0.781042] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled 326s [ 0.782114] sd 0:0:0:0: [sda] Write Protect is off 326s [ 0.786536] ledtrig-cpu: registered to indicate activity on CPUs 326s [ 0.786569] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA 326s [ 0.787483] drop_monitor: Initializing network drop monitor service 326s [ 0.790166] sda: sda1 sda14 sda15 sda16 326s [ 0.790292] NET: Registered PF_INET6 protocol family 326s [ 0.790870] sd 0:0:0:0: [sda] Attached SCSI disk 326s [ 0.797349] Segment Routing with IPv6 326s [ 0.798585] In-situ OAM (IOAM) with IPv6 326s [ 0.799386] NET: Registered PF_PACKET protocol family 326s [ 0.800390] Key type dns_resolver registered 326s [ 0.801521] IPI shorthand broadcast: enabled 326s [ 0.804536] sched_clock: Marking stable (646006810, 158081570)->(804314447, -226067) 326s [ 0.806185] registered taskstats version 1 326s [ 0.807143] Loading compiled-in X.509 certificates 326s [ 0.808704] Loaded X.509 cert 'Build time autogenerated kernel key: b54828a0f24178b39a7f6ff8db8f13420879d069' 326s [ 0.810945] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing 2025 Kmod: d541cef61dc7e793b7eb7e899970a2eef0b5dc8c' 326s [ 0.813226] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 326s [ 0.815456] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 326s [ 0.817259] blacklist: Loading compiled-in revocation X.509 certificates 326s [ 0.818494] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 326s [ 0.820338] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 326s [ 0.822237] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 326s [ 0.824176] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 326s [ 0.826129] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 326s [ 0.828693] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 326s [ 0.830755] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 326s [ 0.832805] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 326s [ 0.839579] Key type .fscrypt registered 326s [ 0.840375] Key type fscrypt-provisioning registered 326s [ 0.853847] Key type encrypted registered 326s [ 0.854875] AppArmor: AppArmor sha256 policy hashing enabled 326s [ 0.855967] ima: No TPM chip found, activating TPM-bypass! 326s [ 0.856990] Loading compiled-in module X.509 certificates 326s [ 0.858877] Loaded X.509 cert 'Build time autogenerated kernel key: b54828a0f24178b39a7f6ff8db8f13420879d069' 326s [ 0.860679] ima: Allocated hash algorithm: sha256 326s [ 0.864769] ima: No architecture policies found 326s [ 0.865709] evm: Initialising EVM extended attributes: 326s [ 0.866682] evm: security.selinux 326s [ 0.867463] evm: security.SMACK64 326s [ 0.868153] evm: security.SMACK64EXEC 326s [ 0.868879] evm: security.SMACK64TRANSMUTE 326s [ 0.869680] evm: security.SMACK64MMAP 326s [ 0.870402] evm: security.apparmor 326s [ 0.871078] evm: security.ima 326s [ 0.871700] evm: security.capability 326s [ 0.872439] evm: HMAC attrs: 0x1 326s [ 0.873389] PM: Magic number: 13:363:777 326s [ 0.874239] misc rfkill: hash matches 326s [ 0.881008] RAS: Correctable Errors collector initialized. 326s [ 0.882128] clk: Disabling unused clocks 326s [ 0.912898] Freeing unused decrypted memory: 2028K 326s [ 0.914193] Freeing unused kernel image (initmem) memory: 4912K 326s [ 0.915107] Write protecting the kernel read-only data: 38912k 326s [ 0.916497] Freeing unused kernel image (rodata/data gap) memory: 2000K 326s [ 0.965990] x86/mm: Checked W+X mappings: passed, no W+X pages found. 326s [ 0.967019] Run /init as init process 326s Loading, please wait... 326s Starting systemd-udevd version 255.4-1ubuntu8.11 326s [ 1.071850] virtio_net virtio0 ens3: renamed from eth0 326s [ 1.085998] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 326s [ 1.095578] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 326s [ 1.099907] FDC 0 is a S82078B 326s Begin: Loading essential drivers ... done. 326s Begin: Running /scripts/init-premount ... done. 326s Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. 326s Begin: Running /scripts/local-premount ... [ 2.252091] raid6: avx2x4 gen() 43806 MB/s 326s [ 2.269092] raid6: avx2x2 gen() 47141 MB/s 326s [ 2.286091] raid6: avx2x1 gen() 38778 MB/s 326s [ 2.286796] raid6: using algorithm avx2x2 gen() 47141 MB/s 326s [ 2.304103] raid6: .... xor() 34770 MB/s, rmw enabled 326s [ 2.304929] raid6: using avx2x2 recovery algorithm 326s [ 2.306740] xor: automatically using best checksumming function avx 326s [ 2.374981] Btrfs loaded, zoned=yes, fsverity=yes 326s Scanning for Btrfs filesystems 326s done. 326s Begin: Will now check root file system ... fsck from util-linux 2.39.3 326s [/usr/sbin/fsck.ext4 (1) -- /dev/sda1] fsck.ext4 -a -C0 /dev/sda1 326s cloudimg-rootfs: clean, 82181/2490368 files, 756461/4980475 blocks 326s done. 326s [ 2.424077] EXT4-fs (sda1): mounted filesystem ffe7eb40-94f7-473b-b336-935460126345 ro with ordered data mode. Quota mode: none. 326s done. 326s Begin: Running /scripts/local-bottom ... done. 326s Begin: Running /scripts/init-bottom ... done. 326s [ 2.555820] systemd[1]: Inserted module 'autofs4' 326s [ 2.576324] systemd[1]: systemd 255.4-1ubuntu8.11 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) 326s [ 2.580892] systemd[1]: Detected virtualization kvm. 326s [ 2.581691] systemd[1]: Detected architecture x86-64. 326s 326s Welcome to [1mUbuntu 24.04.3 LTS[0m! 326s 326s [ 2.585059] systemd[1]: Hostname set to . 326s [ 2.742957] systemd[1]: Queued start job for default target graphical.target. 326s [ 2.759039] systemd[1]: Created slice system-autopkgtest.slice - Slice /system/autopkgtest. 326s [[0;32m OK [0m] Created slice [0;1;39msystem-autopkgtest.slice[0m - Slice /system/autopkgtest. 326s [ 2.761873] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. 326s [[0;32m OK [0m] Created slice [0;1;39msystem-modprobe.slice[0m - Slice /system/modprobe. 326s [ 2.764635] systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. 326s [[0;32m OK [0m] Created slice [0;1;39msystem-serial\x2dget���slice[0m - Slice /system/serial-getty. 326s [ 2.767493] systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. 326s [[0;32m OK [0m] Created slice [0;1;39msystem-systemd\x2dfs���slice[0m - Slice /system/systemd-fsck. 326s [ 2.770266] systemd[1]: Created slice user.slice - User and Session Slice. 326s [[0;32m OK [0m] Created slice [0;1;39muser.slice[0m - User and Session Slice. 326s [ 2.772365] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. 326s [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-wall.���[0md Requests to Wall Directory Watch. 326s [ 2.775253] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. 326s [[0;32m OK [0m] Set up automount [0;1;39mproc-sys-fs-binfm���[0mormats File System Automount Point. 326s [ 2.778899] systemd[1]: Expecting device dev-disk-by\x2dlabel-BOOT.device - /dev/disk/by-label/BOOT... 326s Expecting device [0;1;39mdev-disk-by\x2dla���device[0m - /dev/disk/by-label/BOOT... 326s [ 2.781365] systemd[1]: Expecting device dev-disk-by\x2dlabel-UEFI.device - /dev/disk/by-label/UEFI... 326s Expecting device [0;1;39mdev-disk-by\x2dla���device[0m - /dev/disk/by-label/UEFI... 326s [ 2.783832] systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... 326s Expecting device [0;1;39mdev-ttyS0.device[0m - /dev/ttyS0... 326s [ 2.785698] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. 326s [[0;32m OK [0m] Reached target [0;1;39mintegritysetup.targ���[0m Local Integrity Protected Volumes. 326s [ 2.788213] systemd[1]: Reached target remote-fs.target - Remote File Systems. 326s [[0;32m OK [0m] Reached target [0;1;39mremote-fs.target[0m - Remote File Systems. 326s [ 2.790332] systemd[1]: Reached target slices.target - Slice Units. 326s [[0;32m OK [0m] Reached target [0;1;39mslices.target[0m - Slice Units. 326s [ 2.792168] systemd[1]: Reached target swap.target - Swaps. 326s [[0;32m OK [0m] Reached target [0;1;39mswap.target[0m - Swaps. 326s [ 2.793834] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. 326s [[0;32m OK [0m] Reached target [0;1;39mveritysetup.target[0m - Local Verity Protected Volumes. 326s [ 2.796383] systemd[1]: Listening on multipathd.socket - multipathd control socket. 326s [[0;32m OK [0m] Listening on [0;1;39mmultipathd.socket[0m - multipathd control socket. 326s [ 2.798786] systemd[1]: Listening on syslog.socket - Syslog Socket. 326s [[0;32m OK [0m] Listening on [0;1;39msyslog.socket[0m - Syslog Socket. 326s [ 2.800739] systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket. 326s [[0;32m OK [0m] Listening on [0;1;39msystemd-fsckd.socket[0m ���fsck to fsckd communication Socket. 326s [ 2.803301] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. 326s [[0;32m OK [0m] Listening on [0;1;39msystemd-initctl.socke���[0m- initctl Compatibility Named Pipe. 326s [ 2.805906] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). 326s [[0;32m OK [0m] Listening on [0;1;39msystemd-journald-dev-���socket[0m - Journal Socket (/dev/log). 326s [ 2.809430] systemd[1]: Listening on systemd-journald.socket - Journal Socket. 326s [[0;32m OK [0m] Listening on [0;1;39msystemd-journald.socket[0m - Journal Socket. 326s [ 2.811762] systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. 326s [[0;32m OK [0m] Listening on [0;1;39msystemd-networkd.socket[0m - Network Service Netlink Socket. 326s [ 2.814282] systemd[1]: systemd-pcrextend.socket - TPM2 PCR Extension (Varlink) was skipped because of an unmet condition check (ConditionSecurity=measured-uki). 326s [ 2.816871] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. 326s [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-control.socket[0m - udev Control Socket. 326s [ 2.819358] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. 326s [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-kernel.socket[0m - udev Kernel Socket. 326s [ 2.833157] systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... 326s Mounting [0;1;39mdev-hugepages.mount[0m - Huge Pages File System... 326s [ 2.835996] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... 326s Mounting [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System... 326s [ 2.840265] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... 326s Mounting [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System... 326s [ 2.843156] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... 326s Mounting [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System... 326s [ 2.847560] systemd[1]: Starting systemd-journald.service - Journal Service... 326s Starting [0;1;39msystemd-journald.service[0m - Journal Service... 326s [ 2.854178] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout... 326s Starting [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout... 326s [ 2.860234] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... 326s Starting [0;1;39mkmod-static-nodes.service[0m���eate List of Static Device Nodes... 326s [ 2.864748] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... 326s Starting [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs... 326s [ 2.869767] systemd-journald[263]: Collecting audit messages is disabled. 326s [ 2.873198] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... 326s Starting [0;1;39mmodprobe@dm_mod.service[0m - Load Kernel Module dm_mod... 326s [ 2.892180] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... 326s Starting [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm... 326s [ 2.895188] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... 326s Starting [0;1;39mmodprobe@efi_pstore.servi���[0m - Load Kernel Module efi_pstore... 326s [ 2.908193] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... 326s Starting [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse... 326s [ 2.914192] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... 326s Starting [0;1;39mmodprobe@loop.service[0m - Load Kernel Module loop... 326s [ 2.916388] systemd[1]: netplan-ovs-cleanup.service - OpenVSwitch configuration for cleanup was skipped because of an unmet condition check (ConditionFileIsExecutable=/usr/bin/ovs-vsctl). 326s [ 2.919153] 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). 326s [ 2.925036] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... 326s Starting [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules... 326s [ 2.927313] systemd[1]: systemd-pcrmachine.service - TPM2 PCR Machine ID Measurement was skipped because of an unmet condition check (ConditionSecurity=measured-uki). 326s [ 2.932224] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... 326s Starting [0;1;39msystemd-remount-fs.servic���[0munt Root and Kernel File Systems... 326s [ 2.935215] systemd[1]: systemd-tpm2-setup-early.service - TPM2 SRK Setup (Early) was skipped because of an unmet condition check (ConditionSecurity=measured-uki). 326s [ 2.938192] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... 326s Starting [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices... 326s [ 2.941971] systemd[1]: Started systemd-journald.service - Journal Service. 326s [[0;32m OK [0m] Started [0;1;39msystemd-journald.service[0m - Journal Service. 326s [[0;32m OK [0m] Mounted [0;1;39mdev-hugepages.mount[0m - Huge Pages File System. 326s [[0;32m OK [0m] Mounted [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System. 326s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System. 326s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System. 326s [ 2.951494] EXT4-fs (sda1): re-mounted ffe7eb40-94f7-473b-b336-935460126345 r/w. Quota mode: none. 326s [[0;32m OK [0m] Finished [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout. 326s [[0;32m OK [0m] Finished [0;1;39mkmod-static-nodes.service[0m���Create List of Static Device Nodes. 326s [[0;32m OK [0m] Finished [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs. 326s [[0;32m OK [0m] Finished [0;1;39mmodprobe@dm_mod.service[0m - Load Kernel Module dm_mod. 326s [[0;32m OK [0m] Finished [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm. 326s [[0;32m OK [0m] Finished [0;1;39mmodprobe@efi_pstore.service[0m - Load Kernel Module efi_pstore. 326s [[0;32m OK [0m] Finished [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse. 326s [[0;32m OK [0m] Finished [0;1;39mmodprobe@loop.service[0m - Load Kernel Module loop. 326s [[0;32m OK [0m] Finished [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules. 326s [[0;32m OK [0m] Finished [0;1;39msystemd-remount-fs.servic���[0mmount Root and Kernel File Systems. 326s Mounting [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System... 326s Mounting [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System... 326s Starting [0;1;39mcloud-init-local.service[0m ���-init: Local Stage (pre-network)... 326s Starting [0;1;39mmultipathd.service[0m - Devi���pper Multipath Device Controller... 326s Starting [0;1;39msystemd-journal-flush.ser���[0msh Journal to Persistent Storage... 326s Starting [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed... 326s [ 3.009446] systemd-journald[263]: Received client request to flush runtime journal. 326s Starting [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables... 326s Starting [0;1;39msystemd-tmpfiles-setup-de���[0m Device Nodes in /dev gracefully... 326s [[0;32m OK [0m] Mounted [0;[ 3.023760] systemd-journald[263]: /var/log/journal/ea8e8369d1ee47fe9da4853a2842cf27/system.journal: Journal file uses a different sequence number ID, rotating. 326s 1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System. 326s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System.[ 3.029588] systemd-journald[263]: Rotating system journal. 326s 326s [[0;32m OK [0m] Finished [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables. 326s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mic Device Nodes in /dev gracefully. 326s Starting [0;1;39msystemd-tmpfiles-setup-de���[0meate Static Device Nodes in /dev... 326s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mCreate Static Device Nodes in /dev. 326s [[0;32m OK [0m] Finished [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices. 326s Starting [0;1;39msystemd-udevd.service[0m - R���ager for Device Events and Files... 326s [[0;32m OK [0m] Started [0;1;39mmultipathd.service[0m - Devic���Mapper Multipath Device Controller. 326s [[0;32m OK [0m] Finished [0;1;39msystemd-journal-flush.ser���[0mlush Journal to Persistent Storage. 326s [[0;32m OK [0m] Finished [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed. 326s [[0;32m OK [0m] Reached target [0;1;39mlocal-fs-pre.target[0m���Preparation for Local File Systems. 326s [[0;32m OK [0m] Started [0;1;39msystemd-udevd.service[0m - Ru���anager for Device Events and Files. 326s [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-conso���[0mequests to Console Directory Watch. 326s [[0;32m OK [0m] Reached target [0;1;39mcryptsetup.target[0m - Local Encrypted Volumes. 326s [[0;32m OK [0m] Found device [0;1;39mdev-ttyS0.device[0m - /dev/ttyS0. 326s [[0;32m OK [0m] Listening on [0;1;39msystemd-rfkill.socket[0m���ll Switch Status /dev/rfkill Watch. 326s [[0;32m OK [0m] Found device [0;1;39mdev-disk-by\x2dlabel-BOOT.device[0m - QEMU_HARDDISK BOOT. 326s [[0;32m OK [0m] Found device [0;1;39mdev-disk-by\x2dlabel-UEFI.device[0m - QEMU_HARDDISK UEFI. 326s Starting [0;1;39msystemd-fsck@dev-disk-by\���[0mCheck on /dev/disk/by-label/BOOT... 326s Starting [0;1;39msystemd-fsck@dev-disk-by\���[0mCheck on /dev/disk/by-label/UEFI... 326s [[0;32m OK [0m] Started [0;1;39msystemd-fsckd.service[0m - Fi���stem Check Daemon to report status. 326s [[0;32m OK [0m] Finished [0;1;39msystemd-fsck@dev-disk-by\���[0mm Check on /dev/disk/by-label/BOOT. 326s Mounting [0;1;39mboot.mount[0m - /boot... 326s [[0;32m OK [0m] Mounted [0;1;39mboot.mount[0m - /boot. 326s [ 3.448721] cloud-init[431]: Cloud-init v. 25.2-0ubuntu1~24.04.1 running 'init-local' at Thu, 30 Oct 2025 08:45:20 +0000. Up 3.42 seconds. 326s [[0;32m OK [0m] Finished [0;1;39msystemd-fsck@dev-disk-by\���[0mm Check on /dev/disk/by-label/UEFI. 326s Mounting [0;1;39mboot-efi.mount[0m - /boot/efi... 326s [[0;32m OK [0m] Mounted [0;1;39mboot-efi.mount[0m - /boot/efi. 326s [[0;32m OK [0m] Reached target [0;1;39mlocal-fs.target[0m - Local File Systems. 326s [[0;32m OK [0m] Listening on [0;1;39msystemd-sysext.socket[0m���tension Image Management (Varlink). 326s Starting [0;1;39mapparmor.service[0m - Load AppArmor profiles... 326s Starting [0;1;39mconsole-setup.service[0m - Set console font and keymap... 326s Starting [0;1;39mplymouth-read-write.servi���[0mymouth To Write Out Runtime Data... 326s Starting [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats... 326s Starting [0;1;39msystemd-tmpfiles-setup.se���[0me Volatile Files and Directories... 326s Starting [0;1;39mufw.service[0m - Uncomplicated firewall... 326s [[0;32m OK [0m] Finished [0;1;39mconsole-setup.service[0m - Set console font and keymap. 326s [[0;32m OK [0m] Finished [0;1;39mplymouth-read-write.servi���[0mPlymouth To Write Out Runtime Data. 326s [[0;32m OK [0m] Finished [0;1;39mufw.service[0m - Uncomplicated firewall. 326s Mounting [0;1;39mproc-sys-fs-binfmt_misc.m���[0mcutable File Formats File System... 326s [[0;32m OK [0m] Mounted [0;1;39mproc-sys-fs-binfmt_misc.mo���[0mxecutable File Formats File System. 326s [[0;32m OK [0m] Finished [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats. 326s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup.se���[0mate Volatile Files and Directories. 326s Starting [0;1;39msystemd-resolved.service[0m - Network Name Resolution... 326s Starting [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization... 326s Starting [0;1;39msystemd-update-utmp.servi���[0mord System Boot/Shutdown in UTMP... 326s [[0;32m OK [0m] Finished [0;1;39msystemd-update-utmp.servi���[0mecord System Boot/Shutdown in UTMP. 326s [[0;32m OK [0m] Started [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization. 326s [[0;32m OK [0m] Reached target [0;1;39mtime-set.target[0m - System Time Set. 326s [[0;32m OK [0m] Started [0;1;39msystemd-resolved.service[0m - Network Name Resolution. 326s [[0;32m OK [0m] Reached target [0;1;39mnss-lookup.target[0m - Host and Network Name Lookups. 326s [[0;32m OK [0m] Finished [0;1;39mapparmor.service[0m - Load AppArmor profiles. 326s [[0;32m OK [0m] Finished [0;1;39mcloud-init-local.service[0m ���ud-init: Local Stage (pre-network). 326s [[0;32m OK [0m] Reached target [0;1;39mnetwork-pre.target[0m - Preparation for Network. 326s Starting [0;1;39msystemd-networkd.service[0m - Network Configuration... 326s [[0;32m OK [0m] Started [0;1;39msystemd-networkd.service[0m - Network Configuration. 326s [[0;32m OK [0m] Reached target [0;1;39mnetwork.target[0m - Network. 326s Starting [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured... 326s [[0;32m OK [0m] Finished [0;1;39msystemd-networkd-wait-onl���[0m Wait for Network to be Configured. 326s Starting [0;1;39mcloud-init.service[0m - Cloud-init: Network Stage... 326s [ 7.583189] cloud-init[662]: Cloud-init v. 25.2-0ubuntu1~24.04.1 running 'init' at Thu, 30 Oct 2025 08:45:24 +0000. Up 7.57 seconds. 326s [ 7.589828] cloud-init[662]: ci-info: +++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++ 326s [ 7.591320] cloud-init[662]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 326s [ 7.592777] cloud-init[662]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 326s [ 7.594285] cloud-init[662]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 326s [ 7.595733] cloud-init[662]: ci-info: | ens3 | True | 10.151.36.223 | 255.255.255.0 | global | fa:16:3e:7f:dd:e1 | 326s [ 7.597191] cloud-init[662]: ci-info: | ens3 | True | fe80::f816:3eff:fe7f:dde1/64 | . | link | fa:16:3e:7f:dd:e1 | 326s [ 7.598645] cloud-init[662]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 326s [ 7.600116] cloud-init[662]: ci-info: | lo | True | ::1/128 | . | host | . | 326s [ 7.601741] cloud-init[662]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 326s [ 7.603260] cloud-init[662]: ci-info: ++++++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++++++ 326s [ 7.604576] cloud-init[662]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 326s [ 7.605884] cloud-init[662]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | 326s [ 7.607188] cloud-init[662]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 326s [ 7.608502] cloud-init[662]: ci-info: | 0 | 0.0.0.0 | 10.151.36.1 | 0.0.0.0 | ens3 | UG | 326s [ 7.609834] cloud-init[662]: ci-info: | 1 | 10.151.11.5 | 10.151.36.1 | 255.255.255.255 | ens3 | UGH | 326s [ 7.611147] cloud-init[662]: ci-info: | 2 | 10.151.11.6 | 10.151.36.1 | 255.255.255.255 | ens3 | UGH | 326s [ 7.612455] cloud-init[662]: ci-info: | 3 | 10.151.11.7 | 10.151.36.1 | 255.255.255.255 | ens3 | UGH | 326s [ 7.613869] cloud-init[662]: ci-info: | 4 | 10.151.36.0 | 0.0.0.0 | 255.255.255.0 | ens3 | U | 326s [ 7.615175] cloud-init[662]: ci-info: | 5 | 10.151.36.1 | 0.0.0.0 | 255.255.255.255 | ens3 | UH | 326s [ 7.616488] cloud-init[662]: ci-info: | 6 | 10.151.36.2 | 0.0.0.0 | 255.255.255.255 | ens3 | UH | 326s [ 7.617797] cloud-init[662]: ci-info: | 7 | 169.254.169.254 | 10.151.36.2 | 255.255.255.255 | ens3 | UGH | 326s [ 7.619251] cloud-init[662]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 326s [ 7.620619] cloud-init[662]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 326s [ 7.621695] cloud-init[662]: ci-info: +-------+-------------+---------+-----------+-------+ 326s [ 7.622759] cloud-init[662]: ci-info: | Route | Destination | Gateway | Interface | Flags | 326s [ 7.623827] cloud-init[662]: ci-info: +-------+-------------+---------+-----------+-------+ 326s [ 7.624973] cloud-init[662]: ci-info: | 0 | fe80::/64 | :: | ens3 | U | 326s [ 7.626237] cloud-init[662]: ci-info: | 2 | local | :: | ens3 | U | 326s [ 7.627312] cloud-init[662]: ci-info: | 3 | multicast | :: | ens3 | U | 326s [ 7.628391] cloud-init[662]: ci-info: +-------+-------------+---------+-----------+-------+ 326s [ 7.629970] cloud-init[662]: 2025-10-30 08:45:24,515 - 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. 326s [ 7.632857] cloud-init[662]: 2025-10-30 08:45:24,515 - schema.py[WARNING]: cloud-config failed schema validation! You may run 'sudo cloud-init schema --system' to check the details. 326s [ 8.570076] cloud-init[662]: Generating public/private rsa key pair. 326s [ 8.571293] cloud-init[662]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key 326s [ 8.572610] cloud-init[662]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub 326s [ 8.573704] cloud-init[662]: The key fingerprint is: 326s [ 8.574396] cloud-init[662]: SHA256:947qvRrVB/uLhkhAMRWzWiq0X4axNOZmZ4QN3xPtXHk root@autopkgtest 326s [ 8.575510] cloud-init[662]: The key's randomart image is: 326s [ 8.576256] cloud-init[662]: +---[RSA 3072]----+ 326s [ 8.576893] cloud-init[662]: | +o+... . | 326s [ 8.577544] cloud-init[662]: | .* + .. o E| 326s [ 8.578184] cloud-init[662]: | ..* * oo.. . | 326s [ 8.578821] cloud-init[662]: | . =.X ooo | 326s [ 8.579475] cloud-init[662]: | o O.S o o . | 326s [ 8.580115] cloud-init[662]: | = =.o . o | 326s [ 8.580753] cloud-init[662]: | .... .. . | 326s [ 8.581400] cloud-init[662]: | .o.o.. . | 326s [ 8.582040] cloud-init[662]: | .+o+oo . | 326s [ 8.582677] cloud-init[662]: +----[SHA256]-----+ 326s [ 8.583527] cloud-init[662]: Generating public/private ecdsa key pair. 326s [ 8.584438] cloud-init[662]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key 326s [ 8.585613] cloud-init[662]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub 326s [ 8.586718] cloud-init[662]: The key fingerprint is: 326s [ 8.587406] cloud-init[662]: SHA256:p5UQvKX+vechtnXTIR2PQJhvNguU/ZVTtNNjKTZhGyU root@autopkgtest 326s [ 8.588522] cloud-init[662]: The key's randomart image is: 326s [ 8.589249] cloud-init[662]: +---[ECDSA 256]---+ 326s [ 8.589906] cloud-init[662]: | .. =.E.o=| 326s [ 8.590562] cloud-init[662]: | ..*.o =o=| 326s [ 8.591209] cloud-init[662]: | .= ..* Oo| 326s [ 8.591847] cloud-init[662]: | o...*.*.=| 326s [ 8.592494] cloud-init[662]: | .S ++ +.o.| 326s [ 8.593135] cloud-init[662]: | .+ . . o| 326s [ 8.593768] cloud-init[662]: | .. .o o.o| 326s [ 8.594410] cloud-init[662]: | ...+.o.| 326s [ 8.595051] cloud-init[662]: | o+. | 326s [ 8.595687] cloud-init[662]: +----[SHA256]-----+ 326s [ 8.596328] cloud-init[662]: Generating public/private ed25519 key pair. 326s [ 8.597201] cloud-init[662]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key 326s [ 8.598332] cloud-init[662]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub 326s [ 8.599457] cloud-init[662]: The key fingerprint is: 326s [ 8.600129] cloud-init[662]: SHA256:/0ZttBVemHwGkz4KiOpvo9lwGF5MI34EEoSR+Tr2pUU root@autopkgtest 326s [ 8.601247] cloud-init[662]: The key's randomart image is: 326s [ 8.601990] cloud-init[662]: +--[ED25519 256]--+ 326s [ 8.602642] cloud-init[662]: |.*+.. .o= | 326s [ 8.603289] cloud-init[662]: |+ . . =o+| 326s [ 8.603925] cloud-init[662]: | . . +. . ..oo| 326s [ 8.604572] cloud-init[662]: | .. E... . +..| 326s [ 8.605213] cloud-init[662]: | . +.+ S . + + | 326s [[0;32m OK [0m] Finished [0;1;39mcloud-init.service[0m - Cloud-init: Network Stage. 326s [[0;32m OK [0m] Reached target [0;1;39mcloud-config.target[0m - Cloud-config availability. 326s [ 8.607958] cloud-init[662]: |o. ..B . o + | 326s [[0;32m OK [0m] Reached target [0;1;39mnetwork-online.target[0m - Network is Online. 326s [ 8.609582] cloud-init[662]: |....B . .. . | 326s [[0;32m OK [0m] Reached target [0;1;39msysinit.target[0m - System Initialization. 326s [ 8.611171] cloud-init[662]: | o.=o .. | 326s [[0;32m OK [0m] Started [0;1;39mapt-daily.timer[0m - Daily apt download activities. 326s [ 8.612964] cloud-init[662]: | o+o. .. | 326s [[0;32m OK [0m] Started [0;1;39mapt-daily-upgrade.timer[0m - ���y apt upgrade and clean activities. 326s [ 8.614734] cloud-init[662]: +----[SHA256]-----+ 326s [[0;32m OK [0m] Started [0;1;39mdpkg-db-backup.timer[0m - Daily dpkg database backup timer. 326s [[0;32m OK [0m] Started [0;1;39me2scrub_all.timer[0m - Period���Metadata Check for All Filesystems. 326s [[0;32m OK [0m] Started [0;1;39mfstrim.timer[0m - Discard unused filesystem blocks once a week. 326s [[0;32m OK [0m] Started [0;1;39mfwupd-refresh.timer[0m - Refresh fwupd metadata regularly. 326s [[0;32m OK [0m] Started [0;1;39mlogrotate.timer[0m - Daily rotation of log files. 326s [[0;32m OK [0m] Started [0;1;39mman-db.timer[0m - Daily man-db regeneration. 326s [[0;32m OK [0m] Started [0;1;39mmotd-news.timer[0m - Message of the Day. 326s [[0;32m OK [0m] Started [0;1;39msysstat-collect.timer[0m - Ru���y accounting tool every 10 minutes. 326s [[0;32m OK [0m] Started [0;1;39msysstat-summary.timer[0m - Ge��� of yesterday's process accounting. 326s [[0;32m OK [0m] Started [0;1;39msystemd-tmpfiles-clean.tim���[0my Cleanup of Temporary Directories. 326s [[0;32m OK [0m] Reached target [0;1;39mpaths.target[0m - Path Units. 326s [[0;32m OK [0m] Reached target [0;1;39mtimers.target[0m - Timer Units. 326s [[0;32m OK [0m] Listening on [0;1;39mcloud-init-hotplugd.s���t[0m - cloud-init hotplug hook socket. 326s [[0;32m OK [0m] Listening on [0;1;39mdbus.socket[0m - D-Bus System Message Bus Socket. 326s Starting [0;1;39mlxd-installer.socket[0m - He���er to install lxd snap on demand... 326s [[0;32m OK [0m] Listening on [0;1;39mssh.socket[0m - OpenBSD Secure Shell server socket. 326s [[0;32m OK [0m] Listening on [0;1;39muuidd.socket[0m - UUID daemon activation socket. 326s [[0;32m OK [0m] Listening on [0;1;39mlxd-installer.socket[0m ���lper to install lxd snap on demand. 326s [[0;32m OK [0m] Reached target [0;1;39msockets.target[0m - Socket Units. 326s [[0;32m OK [0m] Reached target [0;1;39mbasic.target[0m - Basic System. 326s Starting [0;1;39mapport.service[0m - automatic crash report generation... 326s [[0;32m OK [0m] Started [0;1;39mautopkgtest@ttyS1.service[0m - autopkgtest root shell on ttyS1. 326s Starting [0;1;39mcloud-config.service[0m - Cloud-init: Config Stage... 326s [[0;32m OK [0m] Started [0;1;39mcron.service[0m - Regular background program processing daemon. 326s Starting [0;1;39mdbus.service[0m - D-Bus System Message Bus... 326s [[0;32m OK [0m] Started [0;1;39mdmesg.service[0m - Save initial kernel messages after boot. 326s Starting [0;1;39mdpkg-db-backup.service[0m - ���ily dpkg database backup service... 326s Starting [0;1;39me2scrub_reap.service[0m - Re���ne ext4 Metadata Check Snapshots... 326s Starting [0;1;39mgrub-common.service[0m - Record successful boot for GRUB... 326s Starting [0;1;39mpollinate.service[0m - Polli���e pseudo random number generator... 326s Starting [0;1;39mrng-tools-debian.service[0m - LSB: rng-tools (Debian variant)... 326s Starting [0;1;39mrsyslog.service[0m - System Logging Service... 326s Starting [0;1;39msysstat.service[0m - Resets System Activity Logs... 326s Starting [0;1;39msystemd-logind.service[0m - User Login Management... 326s Starting [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions... 326s Starting [0;1;39mudisks2.service[0m - Disk Manager... 326s Starting [0;1;39mlogrotate.service[0m - Rotate log files... 326s [[0;32m OK [0m] Started [0;1;39mdbus.service[0m - D-Bus System Message Bus. 326s [[0;32m OK [0m] Finished [0;1;39me2scrub_reap.service[0m - Re���line ext4 Metadata Check Snapshots. 326s [[0;32m OK [0m] Finished [0;1;39msysstat.service[0m - Resets System Activity Logs. 326s [[0;32m OK [0m] Finished [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions. 326s Starting [0;1;39mplymouth-quit-wait.servic���[0md until boot process finishes up... 326s Starting [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen... 326s [[0;32m OK [0m] Finished [0;1;39mplymouth-quit-wait.servic���[0mold until boot process finishes up. 326s [[0;32m OK [0m] Finished [0;1;39mdpkg-db-backup.service[0m - Daily dpkg database backup service. 326s [[0;32m OK [0m] Finished [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen. 326s [[0;32m OK [0m] Started [0;1;39msystemd-logind.service[0m - User Login Management. 326s [[0;32m OK [0m] Started [0;1;39mrng-tools-debian.service[0m - LSB: rng-tools (Debian variant). 326s [[0;32m OK [0m] Finished [0;1;39mlogrotate.service[0m - Rotate log files. 326s [[0;32m OK [0m] Finished [0;1;39mgrub-common.service[0m - Record successful boot for GRUB. 326s [[0;32m OK [0m] Started [0;1;39mudisks2.service[0m - Disk Manager. 326s Starting [0;1;39mgrub-initrd-fallback.service[0m - GRUB failed boot detection... 326s [[0;32m OK [0m] Started [0;1;39mserial-getty@ttyS0.service[0m - Serial Getty on ttyS0. 326s Starting [0;1;39msetvtrgb.service[0m - Set console scheme... 326s [[0;32m OK [0m] Finished [0;1;39mapport.service[0m - automatic crash report generation. 326s [[0;32m OK [0m] Finished [0;1;39msetvtrgb.service[0m - Set console scheme. 326s [[0;32m OK [0m] Created slice [0;1;39msystem-getty.slice[0m - Slice /system/getty. 326s [[0;32m OK [0m] Started [0;1;39mgetty@tty1.service[0m - Getty on tty1. 326s [[0;32m OK [0m] Reached target [0;1;39mgetty.target[0m - Login Prompts. 326s [[0;32m OK [0m] Finished [0;1;39mgrub-initrd-fallback.service[0m - GRUB failed boot detection. 326s [[0;32m OK [0m] Started [0;1;39mrsyslog.service[0m - System Logging Service. 326s [ 9.121022] cloud-init[881]: Cloud-init v. 25.2-0ubuntu1~24.04.1 running 'modules:config' at Thu, 30 Oct 2025 08:45:25 +0000. Up 9.09 seconds. 326s [ 9.244776] cloud-init[881]: 2025-10-30 08:45:26,130 - 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. 326s [ 9.247394] cloud-init[881]: 2025-10-30 08:45:26,130 - 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. 326s [[0;32m OK [0m] Finished [0;1;39mcloud-config.service[0m - Cloud-init: Config Stage. 326s 326s Ubuntu 24.04.3 LTS autopkgtest ttyS0 326s 326s autopkgtest login: [ 19.278709] cloud-init[933]: Cloud-init v. 25.2-0ubuntu1~24.04.1 running 'modules:final' at Thu, 30 Oct 2025 08:45:36 +0000. Up 19.25 seconds. 326s [ 19.418453] cloud-init[933]: Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 326s [ 19.447376] cloud-init[933]: Get:2 http://ftpmaster.internal/ubuntu noble-updates InRelease [126 kB] 326s [ 19.482344] cloud-init[933]: Get:3 http://ftpmaster.internal/ubuntu noble-security InRelease [126 kB] 326s [ 19.558974] cloud-init[933]: Get:4 http://ftpmaster.internal/ubuntu noble-updates/main Sources [475 kB] 326s [ 19.604743] cloud-init[933]: Get:5 http://ftpmaster.internal/ubuntu noble-updates/restricted Sources [55.4 kB] 326s [ 19.637244] cloud-init[933]: Get:6 http://ftpmaster.internal/ubuntu noble-updates/universe Sources [482 kB] 326s [ 19.671989] cloud-init[933]: Get:7 http://ftpmaster.internal/ubuntu noble-updates/main i386 Packages [545 kB] 326s [ 19.908963] cloud-init[933]: Get:8 http://ftpmaster.internal/ubuntu noble-updates/main amd64 Packages [1570 kB] 326s [ 20.010023] cloud-init[933]: Get:9 http://ftpmaster.internal/ubuntu noble-updates/restricted amd64 Packages [2217 kB] 326s [ 20.085142] cloud-init[933]: Get:10 http://ftpmaster.internal/ubuntu noble-updates/universe amd64 Packages [1498 kB] 326s [ 20.133633] cloud-init[933]: Get:11 http://ftpmaster.internal/ubuntu noble-updates/universe i386 Packages [988 kB] 326s [ 20.177536] cloud-init[933]: Get:12 http://ftpmaster.internal/ubuntu noble-security/universe Sources [325 kB] 326s [ 20.210828] cloud-init[933]: Get:13 http://ftpmaster.internal/ubuntu noble-security/main Sources [208 kB] 326s [ 20.244272] cloud-init[933]: Get:14 http://ftpmaster.internal/ubuntu noble-security/main amd64 Packages [1270 kB] 326s [ 20.296256] cloud-init[933]: Get:15 http://ftpmaster.internal/ubuntu noble-security/main i386 Packages [344 kB] 326s [ 20.329933] cloud-init[933]: Get:16 http://ftpmaster.internal/ubuntu noble-security/universe i386 Packages [562 kB] 326s [ 20.372216] cloud-init[933]: Get:17 http://ftpmaster.internal/ubuntu noble-security/universe amd64 Packages [906 kB] 326s [ 20.786731] cloud-init[933]: Fetched 11.7 MB in 1s (8278 kB/s) 326s [ 21.731019] cloud-init[933]: Reading package lists... 326s ci-info: ++++++++++++++++++++++++++++++++++++++++++++++++++++++Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu+++++++++++++++++++++++++++++++++++++++++++++++++++++++ 326s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 326s ci-info: | Keytype | Fingerprint (sha256) | Options | Comment | 326s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 326s 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 | 326s 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 | 326s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 326s <14>Oct 30 08:45:38 cloud-init: ############################################################# 326s <14>Oct 30 08:45:38 cloud-init: -----BEGIN SSH HOST KEY FINGERPRINTS----- 326s <14>Oct 30 08:45:38 cloud-init: 256 SHA256:p5UQvKX+vechtnXTIR2PQJhvNguU/ZVTtNNjKTZhGyU root@autopkgtest (ECDSA) 326s <14>Oct 30 08:45:38 cloud-init: 256 SHA256:/0ZttBVemHwGkz4KiOpvo9lwGF5MI34EEoSR+Tr2pUU root@autopkgtest (ED25519) 326s <14>Oct 30 08:45:38 cloud-init: 3072 SHA256:947qvRrVB/uLhkhAMRWzWiq0X4axNOZmZ4QN3xPtXHk root@autopkgtest (RSA) 326s <14>Oct 30 08:45:38 cloud-init: -----END SSH HOST KEY FINGERPRINTS----- 326s <14>Oct 30 08:45:38 cloud-init: ############################################################# 326s -----BEGIN SSH HOST KEY KEYS----- 326s ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBHa6/0bAlX4rP3IcQO5eORpdn8PV438JDPVSrrq3uCSB4193H5SfEcoB1jR9dqlClHScjtnA2c5JZf70N8DH9w4= root@autopkgtest 326s ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEzkNGK+B1y9VCLGrc3uKkFhtnHe5XsUAKtGvHGf9u9b root@autopkgtest 326s ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDXmV0f0glWWkz1FD18wlediTEXiZLcVa0V2ZR1VwvnvrsPYirSB6h+hGGpLwaFawQXj9zuUqPXctqirEFmhPaGG/rTeA0WXHrRluawKDA1kwVW1FeZWB3C0bHXjQAGkizWEcWjSgQUXDlIvHKDHbA4r8kwjmuvg57b6LvsN6JDX2VOFlH3/fKunisuCywhiy+JO2F6C5B8Uk3Gh6ELF1A4AqfyU3uEWDVFa1hMQQqEMB5AsPC3RkREms8rHNqqhvm6qJNc99Sei0cVfw1Pb+1SCTYVH242P95jBMnRezyhUyls5yf3SNjvSXoKaBvahLO3yyiLGDNl1kBmcHGD/8KQRHl6pEykDLubUxMs1i8hZ/1+WwJKDxQGV/VNQax5/bWJ6FJif9TwUm5aivXaj0ewcs3Of1MWKbQ9WJjUEXMOSXO6h4MlR3YtnY/cnQy3TMYWhCiqPz9rG5jpIDhTFiJl77ymM5WTyNdpC2WAnb6OgB48TMtW7SzUgE9dcYfpWoE= root@autopkgtest 326s -----END SSH HOST KEY KEYS----- 326s [ 21.801863] cloud-init[933]: Cloud-init v. 25.2-0ubuntu1~24.04.1 finished at Thu, 30 Oct 2025 08:45:38 +0000. Datasource DataSourceOpenStackLocal [net,ver=2]. Up 21.78 seconds 326s 326s --------------------------------------------------- 326s ------- nova show dd076af6-5d69-4a49-ae43-def5759658f7 (adt-noble-amd64-dkms-20251030-082337-juju-7f2275-prod-proposed-migration-environment-2-8cee583f-6b75-42ab-b784-dfda3a07a7b8) ------ 328s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 328s | Property | Value | 328s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 328s | OS-DCF:diskConfig | MANUAL | 328s | OS-EXT-AZ:availability_zone | AZ1 | 328s | OS-EXT-SRV-ATTR:host | ps7-ra1-n3.ps7.canonical.com | 328s | OS-EXT-SRV-ATTR:hostname | adt-noble-amd64-dkms-20251030-082337-juju-7f2275-prod-proposed | 328s | OS-EXT-SRV-ATTR:hypervisor_hostname | ps7-ra1-n3.ps7.canonical.com | 328s | OS-EXT-SRV-ATTR:instance_name | instance-0020b9b7 | 328s | OS-EXT-SRV-ATTR:kernel_id | | 328s | OS-EXT-SRV-ATTR:launch_index | 0 | 328s | OS-EXT-SRV-ATTR:ramdisk_id | | 328s | OS-EXT-SRV-ATTR:reservation_id | r-32jjv73j | 328s | OS-EXT-SRV-ATTR:root_device_name | /dev/sda | 328s | OS-EXT-STS:power_state | 1 | 328s | OS-EXT-STS:task_state | - | 328s | OS-EXT-STS:vm_state | active | 328s | OS-SRV-USG:launched_at | 2025-10-30T08:45:15.000000 | 328s | OS-SRV-USG:terminated_at | - | 328s | accessIPv4 | | 328s | accessIPv6 | | 328s | config_drive | | 328s | created | 2025-10-30T08:45:09Z | 328s | description | - | 328s | flavor:disk | 20 | 328s | flavor:ephemeral | 0 | 328s | flavor:extra_specs | {"aggregate_instance_extra_specs:commit": "amd64", "hw:cpu_policy": "shared", "hw:mem_page_size": "large", "hw:pci_numa_affinity_policy": "preferred"} | 328s | flavor:original_name | autopkgtest-cpu2-ram4-disk20-amd64 | 328s | flavor:ram | 4096 | 328s | flavor:swap | 0 | 328s | flavor:vcpus | 2 | 328s | hostId | c46b0988867c3abc86a78fb3e5eb7ee2049601a2b4e78162d6d8bae2 | 328s | id | dd076af6-5d69-4a49-ae43-def5759658f7 | 328s | image | adt/ubuntu-noble-amd64-server-20251029.img (b41dc4cf-b23a-49ac-8f53-9fa4b547e195) | 328s | key_name | testbed-juju-7f2275-prod-proposed-migration-environment-2 | 328s | locked | False | 328s | locked_reason | - | 328s | metadata | {} | 328s | name | adt-noble-amd64-dkms-20251030-082337-juju-7f2275-prod-proposed-migration-environment-2-8cee583f-6b75-42ab-b784-dfda3a07a7b8 | 328s | net_prod-autopkgtest-workers-amd64 network | 10.151.36.223 | 328s | os-extended-volumes:volumes_attached | [] | 328s | progress | 0 | 328s | security_groups | autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-8.secgroup | 328s | server_groups | [] | 328s | status | ACTIVE | 328s | tags | [] | 328s | tenant_id | c20da633fc2e44cd97ff31be0acd959a | 328s | trusted_image_certificates | - | 328s | updated | 2025-10-30T08:45:16Z | 328s | user_id | d1c206dbd7b64e3eacefc738fd9acdca | 328s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 328s --------------------------------------------------- 344s : failure: Timed out on waiting for ssh connection 344s autopkgtest [08:50:45]: ERROR: testbed failure: eof from the virtualisation server