0s autopkgtest [02:14:36]: starting date and time: 2025-06-13 02:14:36+0000 0s autopkgtest [02:14:36]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [02:14:36]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.s3v9uizd/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed --apt-upgrade linux-ibm --timeout-short=300 --timeout-copy=20000 --timeout-test=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=systemd/255.4-1ubuntu8.9 dpdk/23.11.4-0ubuntu0.24.04.1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu4-ram16-disk100-amd64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@sto01-23.secgroup --name adt-noble-amd64-linux-ibm-20250612-235055-juju-7f2275-prod-proposed-migration-environment-20-f895ae9f-2e37-4005-85ff-ada3a0ce0d1d --image adt/ubuntu-noble-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 424s nova [W] Skipping flock for amd64 424s Creating nova instance adt-noble-amd64-linux-ibm-20250612-235055-juju-7f2275-prod-proposed-migration-environment-20-f895ae9f-2e37-4005-85ff-ada3a0ce0d1d from image adt/ubuntu-noble-amd64-server-20250613.img (UUID bf64d55c-279f-422d-aa12-2f04c07e168f)... 424s nova [E] Timed out waiting for ssh. Aborting! Console log: 424s ------- nova console-log 298e096d-78a6-43c4-99eb-e7a636e82370 (adt-noble-amd64-linux-ibm-20250612-235055-juju-7f2275-prod-proposed-migration-environment-20-f895ae9f-2e37-4005-85ff-ada3a0ce0d1d) ------ 424s [ 0.000000] Linux version 6.8.0-60-generic (buildd@lcy02-amd64-054) (x86_64-linux-gnu-gcc-13 (Ubuntu 13.3.0-6ubuntu2~24.04) 13.3.0, GNU ld (GNU Binutils for Ubuntu) 2.42) #63-Ubuntu SMP PREEMPT_DYNAMIC Tue Apr 15 19:04:15 UTC 2025 (Ubuntu 6.8.0-60.63-generic 6.8.12) 424s [ 0.000000] Command line: BOOT_IMAGE=/vmlinuz-6.8.0-60-generic root=UUID=21f08275-91e8-4a2a-85f9-9a52f3ea034b ro console=tty0 console=hvc0 console=ttyS0 424s [ 0.000000] KERNEL supported cpus: 424s [ 0.000000] Intel GenuineIntel 424s [ 0.000000] AMD AuthenticAMD 424s [ 0.000000] Hygon HygonGenuine 424s [ 0.000000] Centaur CentaurHauls 424s [ 0.000000] zhaoxin Shanghai 424s [ 0.000000] BIOS-provided physical RAM map: 424s [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable 424s [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved 424s [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved 424s [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdcfff] usable 424s [ 0.000000] BIOS-e820: [mem 0x00000000bffdd000-0x00000000bfffffff] reserved 424s [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved 424s [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved 424s [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000043fffffff] usable 424s [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved 424s [ 0.000000] NX (Execute Disable) protection: active 424s [ 0.000000] APIC: Static calls initialized 424s [ 0.000000] SMBIOS 3.0.0 present. 424s [ 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 424s [ 0.000000] Hypervisor detected: KVM 424s [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 424s [ 0.000000] kvm-clock: using sched offset of 1887677193 cycles 424s [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns 424s [ 0.000004] tsc: Detected 2396.400 MHz processor 424s [ 0.000869] last_pfn = 0x440000 max_arch_pfn = 0x400000000 424s [ 0.000908] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs 424s [ 0.000911] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT 424s [ 0.000963] last_pfn = 0xbffdd max_arch_pfn = 0x400000000 424s [ 0.003192] found SMP MP-table at [mem 0x000f5390-0x000f539f] 424s [ 0.003206] Using GB pages for direct mapping 424s [ 0.003386] RAMDISK: [mem 0x303cd000-0x341ddfff] 424s [ 0.003770] ACPI: Early table checksum verification disabled 424s [ 0.003773] ACPI: RSDP 0x00000000000F5350 000014 (v00 BOCHS ) 424s [ 0.003776] ACPI: RSDT 0x00000000BFFE1A27 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) 424s [ 0.003781] ACPI: FACP 0x00000000BFFE1813 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) 424s [ 0.003785] ACPI: DSDT 0x00000000BFFDFD40 001AD3 (v01 BOCHS BXPC 00000001 BXPC 00000001) 424s [ 0.003788] ACPI: FACS 0x00000000BFFDFD00 000040 424s [ 0.003790] ACPI: APIC 0x00000000BFFE1887 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) 424s [ 0.003792] ACPI: SRAT 0x00000000BFFE1917 0000E8 (v01 BOCHS BXPC 00000001 BXPC 00000001) 424s [ 0.003794] ACPI: WAET 0x00000000BFFE19FF 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) 424s [ 0.003796] ACPI: Reserving FACP table memory at [mem 0xbffe1813-0xbffe1886] 424s [ 0.003797] ACPI: Reserving DSDT table memory at [mem 0xbffdfd40-0xbffe1812] 424s [ 0.003798] ACPI: Reserving FACS table memory at [mem 0xbffdfd00-0xbffdfd3f] 424s [ 0.003799] ACPI: Reserving APIC table memory at [mem 0xbffe1887-0xbffe1916] 424s [ 0.003799] ACPI: Reserving SRAT table memory at [mem 0xbffe1917-0xbffe19fe] 424s [ 0.003800] ACPI: Reserving WAET table memory at [mem 0xbffe19ff-0xbffe1a26] 424s [ 0.003862] SRAT: PXM 0 -> APIC 0x00 -> Node 0 424s [ 0.003863] SRAT: PXM 0 -> APIC 0x01 -> Node 0 424s [ 0.003864] SRAT: PXM 0 -> APIC 0x02 -> Node 0 424s [ 0.003864] SRAT: PXM 0 -> APIC 0x03 -> Node 0 424s [ 0.003866] ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x0009ffff] 424s [ 0.003867] ACPI: SRAT: Node 0 PXM 0 [mem 0x00100000-0xbfffffff] 424s [ 0.003868] ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x43fffffff] 424s [ 0.003871] NUMA: Node 0 [mem 0x00000000-0x0009ffff] + [mem 0x00100000-0xbfffffff] -> [mem 0x00000000-0xbfffffff] 424s [ 0.003873] NUMA: Node 0 [mem 0x00000000-0xbfffffff] + [mem 0x100000000-0x43fffffff] -> [mem 0x00000000-0x43fffffff] 424s [ 0.003880] NODE_DATA(0) allocated [mem 0x43ffd5000-0x43fffffff] 424s [ 0.004045] Zone ranges: 424s [ 0.004046] DMA [mem 0x0000000000001000-0x0000000000ffffff] 424s [ 0.004047] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] 424s [ 0.004049] Normal [mem 0x0000000100000000-0x000000043fffffff] 424s [ 0.004050] Device empty 424s [ 0.004051] Movable zone start for each node 424s [ 0.004054] Early memory node ranges 424s [ 0.004054] node 0: [mem 0x0000000000001000-0x000000000009efff] 424s [ 0.004056] node 0: [mem 0x0000000000100000-0x00000000bffdcfff] 424s [ 0.004057] node 0: [mem 0x0000000100000000-0x000000043fffffff] 424s [ 0.004059] Initmem setup node 0 [mem 0x0000000000001000-0x000000043fffffff] 424s [ 0.004063] On node 0, zone DMA: 1 pages in unavailable ranges 424s [ 0.004081] On node 0, zone DMA: 97 pages in unavailable ranges 424s [ 0.020657] On node 0, zone Normal: 35 pages in unavailable ranges 424s [ 0.021084] ACPI: PM-Timer IO Port: 0x608 424s [ 0.021097] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) 424s [ 0.021131] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 424s [ 0.021133] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) 424s [ 0.021135] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) 424s [ 0.021136] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) 424s [ 0.021137] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) 424s [ 0.021138] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) 424s [ 0.021141] ACPI: Using ACPI (MADT) for SMP configuration information 424s [ 0.021142] smpboot: Allowing 4 CPUs, 0 hotplug CPUs 424s [ 0.021163] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() 424s [ 0.021178] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] 424s [ 0.021180] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x0009ffff] 424s [ 0.021181] PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000effff] 424s [ 0.021181] PM: hibernation: Registered nosave memory: [mem 0x000f0000-0x000fffff] 424s [ 0.021182] PM: hibernation: Registered nosave memory: [mem 0xbffdd000-0xbfffffff] 424s [ 0.021183] PM: hibernation: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] 424s [ 0.021184] PM: hibernation: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] 424s [ 0.021184] PM: hibernation: Registered nosave memory: [mem 0xff000000-0xfffbffff] 424s [ 0.021185] PM: hibernation: Registered nosave memory: [mem 0xfffc0000-0xffffffff] 424s [ 0.021186] [mem 0xc0000000-0xfeffbfff] available for PCI devices 424s [ 0.021188] Booting paravirtualized kernel on KVM 424s [ 0.021190] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns 424s [ 0.021204] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 424s [ 0.021324] percpu: Embedded 86 pages/cpu s229376 r8192 d114688 u524288 424s [ 0.021355] kvm-guest: PV spinlocks disabled, no host support 424s [ 0.021356] Kernel command line: BOOT_IMAGE=/vmlinuz-6.8.0-60-generic root=UUID=21f08275-91e8-4a2a-85f9-9a52f3ea034b ro console=tty0 console=hvc0 console=ttyS0 424s [ 0.021409] Unknown kernel command line parameters "BOOT_IMAGE=/vmlinuz-6.8.0-60-generic", will be passed to user space. 424s [ 0.021422] random: crng init done 424s [ 0.022031] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear) 424s [ 0.022338] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) 424s [ 0.022372] Fallback order for Node 0: 0 424s [ 0.022375] Built 1 zonelists, mobility grouping on. Total pages: 4128477 424s [ 0.022376] Policy zone: Normal 424s [ 0.022381] mem auto-init: stack:all(zero), heap alloc:on, heap free:off 424s [ 0.022385] software IO TLB: area num 4. 424s [ 0.047243] Memory: 16304260K/16776684K available (22528K kernel code, 4439K rwdata, 14376K rodata, 4992K init, 4720K bss, 472164K reserved, 0K cma-reserved) 424s [ 0.048281] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 424s [ 0.048306] ftrace: allocating 58162 entries in 228 pages 424s [ 0.059873] ftrace: allocated 228 pages with 4 groups 424s [ 0.060788] Dynamic Preempt: voluntary 424s [ 0.060832] rcu: Preemptible hierarchical RCU implementation. 424s [ 0.060833] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. 424s [ 0.060834] Trampoline variant of Tasks RCU enabled. 424s [ 0.060835] Rude variant of Tasks RCU enabled. 424s [ 0.060835] Tracing variant of Tasks RCU enabled. 424s [ 0.060836] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. 424s [ 0.060836] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 424s [ 0.063362] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 424s [ 0.063593] rcu: srcu_init: Setting srcu_struct sizes based on contention. 424s [ 0.073877] Console: colour VGA+ 80x25 424s [ 0.073882] printk: legacy console [tty0] enabled 424s [ 0.115265] printk: legacy console [ttyS0] enabled 424s [ 0.221515] ACPI: Core revision 20230628 424s [ 0.222375] APIC: Switch to symmetric I/O mode setup 424s [ 0.223506] x2apic enabled 424s [ 0.224391] APIC: Switched APIC routing to: physical x2apic 424s [ 0.226542] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 424s [ 0.227629] tsc: Marking TSC unstable due to TSCs unsynchronized 424s [ 0.228712] Calibrating delay loop (skipped) preset value.. 4792.80 BogoMIPS (lpj=2396400) 424s [ 0.230233] x86/cpu: User Mode Instruction Prevention (UMIP) activated 424s [ 0.231784] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 424s [ 0.232709] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 424s [ 0.234022] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization 424s [ 0.235148] Spectre V2 : Mitigation: Retpolines 424s [ 0.235969] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch 424s [ 0.237709] Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT 424s [ 0.239021] Spectre V2 : Enabling Speculation Barrier for firmware calls 424s [ 0.240030] RETBleed: Mitigation: untrained return thunk 424s [ 0.240989] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier 424s [ 0.242709] Speculative Store Bypass: Vulnerable 424s [ 0.243662] Speculative Return Stack Overflow: IBPB-extending microcode not applied! 424s [ 0.244709] Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. 424s [ 0.244711] Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode 424s [ 0.248723] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' 424s [ 0.250709] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' 424s [ 0.251709] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' 424s [ 0.253016] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 424s [ 0.254011] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. 424s [ 0.286143] Freeing SMP alternatives memory: 48K 424s [ 0.286986] pid_max: default: 32768 minimum: 301 424s [ 0.287775] LSM: initializing lsm=lockdown,capability,landlock,yama,apparmor,integrity 424s [ 0.289155] landlock: Up and running. 424s [ 0.289948] Yama: becoming mindful. 424s [ 0.290744] AppArmor: AppArmor initialized 424s [ 0.291725] Mount-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) 424s [ 0.292719] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) 424s [ 0.396971] smpboot: CPU0: AMD EPYC-Rome Processor (family: 0x17, model: 0x31, stepping: 0x0) 424s [ 0.398400] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. 424s [ 0.399731] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. 424s [ 0.401726] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. 424s [ 0.403183] Performance Events: Fam17h+ core perfctr, AMD PMU driver. 424s [ 0.404029] ... version: 0 424s [ 0.404958] ... bit width: 48 424s [ 0.405958] ... generic registers: 6 424s [ 0.406958] ... value mask: 0000ffffffffffff 424s [ 0.407710] ... max period: 00007fffffffffff 424s [ 0.408711] ... fixed-purpose events: 0 424s [ 0.409710] ... event mask: 000000000000003f 424s [ 0.410806] signal: max sigframe size: 1776 424s [ 0.411646] rcu: Hierarchical SRCU implementation. 424s [ 0.411981] rcu: Max phase no-delay instances is 400. 424s [ 0.417315] smp: Bringing up secondary CPUs ... 424s [ 0.418120] smpboot: x86: Booting SMP configuration: 424s [ 0.418988] .... node #0, CPUs: #1 #2 #3 424s [ 0.420748] smp: Brought up 1 node, 4 CPUs 424s [ 0.422495] smpboot: Max logical packages: 4 424s [ 0.422961] smpboot: Total of 4 processors activated (19171.20 BogoMIPS) 424s [ 0.425046] devtmpfs: initialized 424s [ 0.426769] x86/mm: Memory block size: 128MB 424s [ 0.429900] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns 424s [ 0.431718] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) 424s [ 0.432780] pinctrl core: initialized pinctrl subsystem 424s [ 0.434113] PM: RTC time: 02:15:26, date: 2025-06-13 424s [ 0.435452] NET: Registered PF_NETLINK/PF_ROUTE protocol family 424s [ 0.436916] DMA: preallocated 2048 KiB GFP_KERNEL pool for atomic allocations 424s [ 0.438113] DMA: preallocated 2048 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations 424s [ 0.439748] DMA: preallocated 2048 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations 424s [ 0.441156] audit: initializing netlink subsys (disabled) 424s [ 0.442026] audit: type=2000 audit(1749780926.214:1): state=initialized audit_enabled=0 res=1 424s [ 0.442026] thermal_sys: Registered thermal governor 'fair_share' 424s [ 0.443710] thermal_sys: Registered thermal governor 'bang_bang' 424s [ 0.444710] thermal_sys: Registered thermal governor 'step_wise' 424s [ 0.446010] thermal_sys: Registered thermal governor 'user_space' 424s [ 0.447010] thermal_sys: Registered thermal governor 'power_allocator' 424s [ 0.448030] EISA bus registered 424s [ 0.449944] cpuidle: using governor ladder 424s [ 0.450714] cpuidle: using governor menu 424s [ 0.452028] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 424s [ 0.453177] PCI: Using configuration type 1 for base access 424s [ 0.454005] PCI: Using configuration type 1 for extended access 424s [ 0.455744] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. 424s [ 0.467935] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages 424s [ 0.469042] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page 424s [ 0.470030] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages 424s [ 0.471037] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page 424s [ 0.475305] ACPI: Added _OSI(Module Device) 424s [ 0.476009] ACPI: Added _OSI(Processor Device) 424s [ 0.476971] ACPI: Added _OSI(3.0 _SCP Extensions) 424s [ 0.477710] ACPI: Added _OSI(Processor Aggregator Device) 424s [ 0.480690] ACPI: 1 ACPI AML tables successfully acquired and loaded 424s [ 0.484063] ACPI: _OSC evaluation for CPUs failed, trying _PDC 424s [ 0.484934] ACPI: Interpreter enabled 424s [ 0.486735] ACPI: PM: (supports S0 S3 S4 S5) 424s [ 0.486962] ACPI: Using IOAPIC for interrupt routing 424s [ 0.488268] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug 424s [ 0.489710] PCI: Using E820 reservations for host bridge windows 424s [ 0.491156] ACPI: Enabled 2 GPEs in block 00 to 0F 424s [ 0.496216] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) 424s [ 0.497029] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI EDR HPX-Type3] 424s [ 0.499240] acpiphp: Slot [3] registered 424s [ 0.499974] acpiphp: Slot [4] registered 424s [ 0.500972] acpiphp: Slot [5] registered 424s [ 0.501732] acpiphp: Slot [6] registered 424s [ 0.502502] acpiphp: Slot [7] registered 424s [ 0.502969] acpiphp: Slot [8] registered 424s [ 0.503974] acpiphp: Slot [9] registered 424s [ 0.504973] acpiphp: Slot [10] registered 424s [ 0.505728] acpiphp: Slot [11] registered 424s [ 0.506506] acpiphp: Slot [12] registered 424s [ 0.506976] acpiphp: Slot [13] registered 424s [ 0.507977] acpiphp: Slot [14] registered 424s [ 0.508728] acpiphp: Slot [15] registered 424s [ 0.509717] acpiphp: Slot [16] registered 424s [ 0.510500] acpiphp: Slot [17] registered 424s [ 0.510977] acpiphp: Slot [18] registered 424s [ 0.511973] acpiphp: Slot [19] registered 424s [ 0.512730] acpiphp: Slot [20] registered 424s [ 0.513512] acpiphp: Slot [21] registered 424s [ 0.513973] acpiphp: Slot [22] registered 424s [ 0.514972] acpiphp: Slot [23] registered 424s [ 0.515978] acpiphp: Slot [24] registered 424s [ 0.516976] acpiphp: Slot [25] registered 424s [ 0.517973] acpiphp: Slot [26] registered 424s [ 0.518729] acpiphp: Slot [27] registered 424s [ 0.519722] acpiphp: Slot [28] registered 424s [ 0.520502] acpiphp: Slot [29] registered 424s [ 0.520971] acpiphp: Slot [30] registered 424s [ 0.522056] acpiphp: Slot [31] registered 424s [ 0.522728] PCI host bridge to bus 0000:00 424s [ 0.523714] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] 424s [ 0.524711] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] 424s [ 0.526033] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] 424s [ 0.527125] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] 424s [ 0.528711] pci_bus 0000:00: root bus resource [mem 0xc000000000-0xc07fffffff window] 424s [ 0.530140] pci_bus 0000:00: root bus resource [bus 00-ff] 424s [ 0.531156] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint 424s [ 0.533250] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint 424s [ 0.535637] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint 424s [ 0.537742] pci 0000:00:01.1: BAR 4 [io 0xc180-0xc18f] 424s [ 0.538742] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk 424s [ 0.539711] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk 424s [ 0.541020] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk 424s [ 0.542031] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk 424s [ 0.543717] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint 424s [ 0.545466] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI 424s [ 0.547129] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB 424s [ 0.548927] pci 0000:00:02.0: [1b36:0100] type 00 class 0x030000 conventional PCI endpoint 424s [ 0.553720] pci 0000:00:02.0: BAR 0 [mem 0xf4000000-0xf7ffffff] 424s [ 0.555022] pci 0000:00:02.0: BAR 1 [mem 0xf8000000-0xfbffffff] 424s [ 0.556014] pci 0000:00:02.0: BAR 2 [mem 0xfc090000-0xfc091fff] 424s [ 0.557021] pci 0000:00:02.0: BAR 3 [io 0xc140-0xc15f] 424s [ 0.558012] pci 0000:00:02.0: ROM [mem 0xfc080000-0xfc08ffff pref] 424s [ 0.559069] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] 424s [ 0.561412] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint 424s [ 0.564157] pci 0000:00:03.0: BAR 0 [io 0xc080-0xc0bf] 424s [ 0.564999] pci 0000:00:03.0: BAR 1 [mem 0xfc092000-0xfc092fff] 424s [ 0.566033] pci 0000:00:03.0: BAR 4 [mem 0xc000000000-0xc000003fff 64bit pref] 424s [ 0.567717] pci 0000:00:03.0: ROM [mem 0xfc000000-0xfc07ffff pref] 424s [ 0.570429] pci 0000:00:04.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint 424s [ 0.572718] pci 0000:00:04.0: BAR 0 [io 0xc0c0-0xc0ff] 424s [ 0.573717] pci 0000:00:04.0: BAR 1 [mem 0xfc093000-0xfc093fff] 424s [ 0.575038] pci 0000:00:04.0: BAR 4 [mem 0xc000004000-0xc000007fff 64bit pref] 424s [ 0.578512] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint 424s [ 0.581500] pci 0000:00:05.0: BAR 0 [io 0xc000-0xc07f] 424s [ 0.581996] pci 0000:00:05.0: BAR 1 [mem 0xfc094000-0xfc094fff] 424s [ 0.583032] pci 0000:00:05.0: BAR 4 [mem 0xc000008000-0xc00000bfff 64bit pref] 424s [ 0.586441] pci 0000:00:06.0: [1af4:1002] type 00 class 0x00ff00 conventional PCI endpoint 424s [ 0.588413] pci 0000:00:06.0: BAR 0 [io 0xc100-0xc13f] 424s [ 0.590020] pci 0000:00:06.0: BAR 4 [mem 0xc00000c000-0xc00000ffff 64bit pref] 424s [ 0.592495] pci 0000:00:07.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint 424s [ 0.595104] pci 0000:00:07.0: BAR 0 [io 0xc160-0xc17f] 424s [ 0.596004] pci 0000:00:07.0: BAR 1 [mem 0xfc095000-0xfc095fff] 424s [ 0.597036] pci 0000:00:07.0: BAR 4 [mem 0xc000010000-0xc000013fff 64bit pref] 424s [ 0.607261] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 424s [ 0.611852] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 424s [ 0.612848] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 424s [ 0.614149] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 424s [ 0.615084] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 424s [ 0.617017] iommu: Default domain type: Translated 424s [ 0.617712] iommu: DMA domain TLB invalidation policy: lazy mode 424s [ 0.618930] SCSI subsystem initialized 424s [ 0.619980] ACPI: bus type USB registered 424s [ 0.620726] usbcore: registered new interface driver usbfs 424s [ 0.621716] usbcore: registered new interface driver hub 424s [ 0.622718] usbcore: registered new device driver usb 424s [ 0.623734] pps_core: LinuxPPS API ver. 1 registered 424s [ 0.624636] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti 424s [ 0.626169] PTP clock support registered 424s [ 0.626989] EDAC MC: Ver: 3.0.0 424s [ 0.627984] NetLabel: Initializing 424s [ 0.628943] NetLabel: domain hash size = 128 424s [ 0.629710] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 424s [ 0.630740] NetLabel: unlabeled traffic allowed by default 424s [ 0.631752] mctp: management component transport protocol core 424s [ 0.633006] NET: Registered PF_MCTP protocol family 424s [ 0.633715] PCI: Using ACPI for IRQ routing 424s [ 0.634869] pci 0000:00:02.0: vgaarb: setting as boot VGA device 424s [ 0.635708] pci 0000:00:02.0: vgaarb: bridge control possible 424s [ 0.635708] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none 424s [ 0.638712] vgaarb: loaded 424s [ 0.639828] clocksource: Switched to clocksource kvm-clock 424s [ 0.641894] VFS: Disk quotas dquot_6.6.0 424s [ 0.642677] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 424s [ 0.644057] AppArmor: AppArmor Filesystem Enabled 424s [ 0.644955] pnp: PnP ACPI init 424s [ 0.646151] pnp: PnP ACPI: found 5 devices 424s [ 0.654200] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns 424s [ 0.655855] NET: Registered PF_INET protocol family 424s [ 0.656849] IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) 424s [ 0.674840] tcp_listen_portaddr_hash hash table entries: 8192 (order: 5, 131072 bytes, linear) 424s [ 0.676478] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) 424s [ 0.677929] TCP established hash table entries: 131072 (order: 8, 1048576 bytes, linear) 424s [ 0.679786] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) 424s [ 0.681747] TCP: Hash tables configured (established 131072 bind 65536) 424s [ 0.682990] MPTCP token hash table entries: 16384 (order: 6, 393216 bytes, linear) 424s [ 0.684428] UDP hash table entries: 8192 (order: 6, 262144 bytes, linear) 424s [ 0.685745] UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes, linear) 424s [ 0.687239] NET: Registered PF_UNIX/PF_LOCAL protocol family 424s [ 0.688273] NET: Registered PF_XDP protocol family 424s [ 0.689166] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] 424s [ 0.690270] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] 424s [ 0.691368] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] 424s [ 0.692627] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] 424s [ 0.693835] pci_bus 0000:00: resource 8 [mem 0xc000000000-0xc07fffffff window] 424s [ 0.695232] pci 0000:00:01.0: PIIX3: Enabling Passive Release 424s [ 0.696890] pci 0000:00:00.0: Limiting direct PCI/PCI transfers 424s [ 0.698029] PCI: CLS 0 bytes, default 64 424s [ 0.698885] Trying to unpack rootfs image as initramfs... 424s [ 0.699672] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) 424s [ 0.701100] software IO TLB: mapped [mem 0x00000000bbfdd000-0x00000000bffdd000] (64MB) 424s [ 0.703191] Initialise system trusted keyrings 424s [ 0.704062] Key type blacklist registered 424s [ 0.704971] workingset: timestamp_bits=36 max_order=22 bucket_order=0 424s [ 0.706171] zbud: loaded 424s [ 0.707105] squashfs: version 4.0 (2009/01/31) Phillip Lougher 424s [ 0.708306] fuse: init (API version 7.39) 424s [ 0.709279] integrity: Platform Keyring initialized 424s [ 0.710198] integrity: Machine keyring initialized 424s [ 0.723930] Key type asymmetric registered 424s [ 0.724729] Asymmetric key parser 'x509' registered 424s [ 0.726511] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) 424s [ 0.727952] io scheduler mq-deadline registered 424s [ 0.729296] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 424s [ 0.730633] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 424s [ 0.732215] ACPI: button: Power Button [PWRF] 424s [ 0.770766] Freeing initrd memory: 63556K 424s [ 0.774846] ACPI: \_SB_.LNKC: Enabled at IRQ 11 424s [ 0.818155] ACPI: \_SB_.LNKD: Enabled at IRQ 10 424s [ 0.861435] ACPI: \_SB_.LNKA: Enabled at IRQ 10 424s [ 0.905036] ACPI: \_SB_.LNKB: Enabled at IRQ 11 424s [ 0.949656] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled 424s [ 0.974051] 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A 424s [ 0.990168] Linux agpgart interface v0.103 424s [ 0.993008] loop: module loaded 424s [ 0.993807] virtio_blk virtio2: 4/0/0 default/read/poll queues 424s [ 0.996496] virtio_blk virtio2: [vda] 209715200 512-byte logical blocks (107 GB/100 GiB) 424s [ 1.000130] GPT:Primary header thinks Alt. header is not at the end of the disk. 424s [ 1.001528] GPT:41943039 != 209715199 424s [ 1.002259] GPT:Alternate GPT header not at the end of the disk. 424s [ 1.003357] GPT:41943039 != 209715199 424s [ 1.004085] GPT: Use GNU Parted to correct GPT errors. 424s [ 1.005038] vda: vda1 vda14 vda15 vda16 424s [ 1.007156] scsi host0: ata_piix 424s [ 1.008008] scsi host1: ata_piix 424s [ 1.008714] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc180 irq 14 lpm-pol 0 424s [ 1.010139] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc188 irq 15 lpm-pol 0 424s [ 1.011594] ACPI: bus type drm_connector registered 424s [ 1.012810] tun: Universal TUN/TAP device driver, 1.6 424s [ 1.018170] PPP generic driver version 2.4.2 424s [ 1.019164] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 424s [ 1.021296] serio: i8042 KBD port at 0x60,0x64 irq 1 424s [ 1.022232] serio: i8042 AUX port at 0x60,0x64 irq 12 424s [ 1.023316] mousedev: PS/2 mouse device common for all mice 424s [ 1.024550] rtc_cmos 00:04: RTC can wake from S4 424s [ 1.026365] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 424s [ 1.027807] rtc_cmos 00:04: registered as rtc0 424s [ 1.028963] rtc_cmos 00:04: setting system clock to 2025-06-13T02:15:26 UTC (1749780926) 424s [ 1.030527] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram 424s [ 1.031721] i2c_dev: i2c /dev entries driver 424s [ 1.032576] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 424s [ 1.034708] device-mapper: uevent: version 1.0.3 424s [ 1.035676] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com 424s [ 1.037252] platform eisa.0: Probing EISA bus 0 424s [ 1.038105] platform eisa.0: EISA: Cannot allocate resource for mainboard 424s [ 1.039312] platform eisa.0: Cannot allocate resource for EISA slot 1 424s [ 1.040469] platform eisa.0: Cannot allocate resource for EISA slot 2 424s [ 1.041624] platform eisa.0: Cannot allocate resource for EISA slot 3 424s [ 1.042773] platform eisa.0: Cannot allocate resource for EISA slot 4 424s [ 1.043938] platform eisa.0: Cannot allocate resource for EISA slot 5 424s [ 1.045094] platform eisa.0: Cannot allocate resource for EISA slot 6 424s [ 1.046252] platform eisa.0: Cannot allocate resource for EISA slot 7 424s [ 1.047405] platform eisa.0: Cannot allocate resource for EISA slot 8 424s [ 1.048564] platform eisa.0: EISA: Detected 0 cards 424s [ 1.049475] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled 424s [ 1.050994] ledtrig-cpu: registered to indicate activity on CPUs 424s [ 1.052202] drop_monitor: Initializing network drop monitor service 424s [ 1.053436] NET: Registered PF_INET6 protocol family 424s [ 1.060720] Segment Routing with IPv6 424s [ 1.061480] In-situ OAM (IOAM) with IPv6 424s [ 1.062276] NET: Registered PF_PACKET protocol family 424s [ 1.063289] Key type dns_resolver registered 424s [ 1.064586] IPI shorthand broadcast: enabled 424s [ 1.067820] sched_clock: Marking stable (907005033, 160110317)->(1067522769, -407419) 424s [ 1.069469] registered taskstats version 1 424s [ 1.070543] Loading compiled-in X.509 certificates 424s [ 1.072075] Loaded X.509 cert 'Build time autogenerated kernel key: 027a94c2856b4187ba6dc668090aa0eefdaa3927' 424s [ 1.074441] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 424s [ 1.076855] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 424s [ 1.078640] blacklist: Loading compiled-in revocation X.509 certificates 424s [ 1.079860] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 424s [ 1.081624] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 424s [ 1.083491] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 424s [ 1.085411] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 424s [ 1.087880] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 424s [ 1.089785] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 424s [ 1.091686] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 424s [ 1.093624] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 424s [ 1.104249] Key type .fscrypt registered 424s [ 1.105027] Key type fscrypt-provisioning registered 424s [ 1.119907] Key type encrypted registered 424s [ 1.120718] AppArmor: AppArmor sha256 policy hashing enabled 424s [ 1.121763] ima: No TPM chip found, activating TPM-bypass! 424s [ 1.122776] Loading compiled-in module X.509 certificates 424s [ 1.124321] Loaded X.509 cert 'Build time autogenerated kernel key: 027a94c2856b4187ba6dc668090aa0eefdaa3927' 424s [ 1.126087] ima: Allocated hash algorithm: sha256 424s [ 1.126987] ima: No architecture policies found 424s [ 1.127872] evm: Initialising EVM extended attributes: 424s [ 1.128820] evm: security.selinux 424s [ 1.129487] evm: security.SMACK64 424s [ 1.130159] evm: security.SMACK64EXEC 424s [ 1.130869] evm: security.SMACK64TRANSMUTE 424s [ 1.131749] evm: security.SMACK64MMAP 424s [ 1.132479] evm: security.apparmor 424s [ 1.133166] evm: security.ima 424s [ 1.133772] evm: security.capability 424s [ 1.134485] evm: HMAC attrs: 0x1 424s [ 1.135469] PM: Magic number: 13:903:257 424s [ 1.143011] RAS: Correctable Errors collector initialized. 424s [ 1.144139] clk: Disabling unused clocks 424s [ 1.169148] Freeing unused decrypted memory: 2028K 424s [ 1.170471] Freeing unused kernel image (initmem) memory: 4992K 424s [ 1.171362] Write protecting the kernel read-only data: 38912k 424s [ 1.172770] Freeing unused kernel image (rodata/data gap) memory: 2008K 424s [ 1.229558] x86/mm: Checked W+X mappings: passed, no W+X pages found. 424s [ 1.230563] Run /init as init process 424s Loading, please wait... 424s Starting systemd-udevd version 255.4-1ubuntu8.8 424s [ 1.343318] virtio_net virtio0 ens3: renamed from eth0 424s [ 1.348609] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 424s [ 1.350929] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 424s [ 1.358064] FDC 0 is a S82078B 424s Begin: Loading essential drivers ... done. 424s Begin: Running /scripts/init-premount ... done. 424s Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. 424s Begin: Running /scripts/local-premount ... [ 2.504119] raid6: avx2x4 gen() 49549 MB/s 424s [ 2.521119] raid6: avx2x2 gen() 50078 MB/s 424s [ 2.538121] raid6: avx2x1 gen() 40694 MB/s 424s [ 2.538829] raid6: using algorithm avx2x2 gen() 50078 MB/s 424s [ 2.556122] raid6: .... xor() 34704 MB/s, rmw enabled 424s [ 2.556970] raid6: using avx2x2 recovery algorithm 424s [ 2.558757] xor: automatically using best checksumming function avx 424s [ 2.635221] Btrfs loaded, zoned=yes, fsverity=yes 424s Scanning for Btrfs filesystems 424s done. 424s Begin: Will now check root file system ... fsck from util-linux 2.39.3 424s [/usr/sbin/fsck.ext4 (1) -- /dev/vda1] fsck.ext4 -a -C0 /dev/vda1 424s cloudimg-rootfs: clean, 82365/2490368 files, 717167/4980475 blocks 424s done. 424s [ 2.681737] EXT4-fs (vda1): mounted filesystem 21f08275-91e8-4a2a-85f9-9a52f3ea034b ro with ordered data mode. Quota mode: none. 424s done. 424s Begin: Running /scripts/local-bottom ... done. 424s Begin: Running /scripts/init-bottom ... done. 424s [ 2.814542] systemd[1]: Inserted module 'autofs4' 424s [ 2.836429] systemd[1]: systemd 255.4-1ubuntu8.8 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) 424s [ 2.840930] systemd[1]: Detected virtualization kvm. 424s [ 2.841729] systemd[1]: Detected architecture x86-64. 424s 424s Welcome to [1mUbuntu 24.04.2 LTS[0m! 424s 424s [ 2.844684] systemd[1]: Hostname set to . 424s [ 3.021267] systemd[1]: Queued start job for default target graphical.target. 424s [ 3.036382] systemd[1]: Created slice system-autopkgtest.slice - Slice /system/autopkgtest. 424s [[0;32m OK [0m] Created slice [0;1;39msystem-autopkgtest.slice[0m - Slice /system/autopkgtest. 424s [ 3.039378] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. 424s [[0;32m OK [0m] Created slice [0;1;39msystem-modprobe.slice[0m - Slice /system/modprobe. 424s [ 3.041916] systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. 424s [[0;32m OK [0m] Created slice [0;1;39msystem-serial\x2dget���slice[0m - Slice /system/serial-getty. 424s [ 3.044672] systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. 424s [[0;32m OK [0m] Created slice [0;1;39msystem-systemd\x2dfs���slice[0m - Slice /system/systemd-fsck. 424s [ 3.047360] systemd[1]: Created slice user.slice - User and Session Slice. 424s [[0;32m OK [0m] Created slice [0;1;39muser.slice[0m - User and Session Slice. 424s [ 3.049336] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. 424s [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-wall.���[0md Requests to Wall Directory Watch. 424s [ 3.052146] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. 424s [[0;32m OK [0m] Set up automount [0;1;39mproc-sys-fs-binfm���[0mormats File System Automount Point. 424s [ 3.055033] systemd[1]: Expecting device dev-disk-by\x2dlabel-BOOT.device - /dev/disk/by-label/BOOT... 424s Expecting device [0;1;39mdev-disk-by\x2dla���device[0m - /dev/disk/by-label/BOOT... 424s [ 3.057423] systemd[1]: Expecting device dev-disk-by\x2dlabel-UEFI.device - /dev/disk/by-label/UEFI... 424s Expecting device [0;1;39mdev-disk-by\x2dla���device[0m - /dev/disk/by-label/UEFI... 424s [ 3.059805] systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... 424s Expecting device [0;1;39mdev-ttyS0.device[0m - /dev/ttyS0... 424s [ 3.061633] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. 424s [[0;32m OK [0m] Reached target [0;1;39mintegritysetup.targ���[0m Local Integrity Protected Volumes. 424s [ 3.064068] systemd[1]: Reached target remote-fs.target - Remote File Systems. 424s [[0;32m OK [0m] Reached target [0;1;39mremote-fs.target[0m - Remote File Systems. 424s [ 3.066773] systemd[1]: Reached target slices.target - Slice Units. 424s [[0;32m OK [0m] Reached target [0;1;39mslices.target[0m - Slice Units. 424s [ 3.068579] systemd[1]: Reached target swap.target - Swaps. 424s [[0;32m OK [0m] Reached target [0;1;39mswap.target[0m - Swaps. 424s [ 3.070192] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. 424s [[0;32m OK [0m] Reached target [0;1;39mveritysetup.target[0m - Local Verity Protected Volumes. 424s [ 3.072661] systemd[1]: Listening on multipathd.socket - multipathd control socket. 424s [[0;32m OK [0m] Listening on [0;1;39mmultipathd.socket[0m - multipathd control socket. 424s [ 3.074950] systemd[1]: Listening on syslog.socket - Syslog Socket. 424s [[0;32m OK [0m] Listening on [0;1;39msyslog.socket[0m - Syslog Socket. 424s [ 3.076828] systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket. 424s [[0;32m OK [0m] Listening on [0;1;39msystemd-fsckd.socket[0m ���fsck to fsckd communication Socket. 424s [ 3.079490] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. 424s [[0;32m OK [0m] Listening on [0;1;39msystemd-initctl.socke���[0m- initctl Compatibility Named Pipe. 424s [ 3.082024] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). 424s [[0;32m OK [0m] Listening on [0;1;39msystemd-journald-dev-���socket[0m - Journal Socket (/dev/log). 424s [ 3.084658] systemd[1]: Listening on systemd-journald.socket - Journal Socket. 424s [[0;32m OK [0m] Listening on [0;1;39msystemd-journald.socket[0m - Journal Socket. 424s [ 3.087072] systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. 424s [[0;32m OK [0m] Listening on [0;1;39msystemd-networkd.socket[0m - Network Service Netlink Socket. 424s [ 3.089490] systemd[1]: systemd-pcrextend.socket - TPM2 PCR Extension (Varlink) was skipped because of an unmet condition check (ConditionSecurity=measured-uki). 424s [ 3.091736] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. 424s [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-control.socket[0m - udev Control Socket. 424s [ 3.094102] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. 424s [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-kernel.socket[0m - udev Kernel Socket. 424s [ 3.106205] systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... 424s Mounting [0;1;39mdev-hugepages.mount[0m - Huge Pages File System... 424s [ 3.109074] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... 424s Mounting [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System... 424s [ 3.111846] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... 424s Mounting [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System... 424s [ 3.114157] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... 424s Mounting [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System... 424s [ 3.118063] systemd[1]: Starting systemd-journald.service - Journal Service... 424s Starting [0;1;39msystemd-journald.service[0m - Journal Service... 424s [ 3.119988] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout... 424s Starting [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout... 424s [ 3.123354] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... 424s Starting [0;1;39mkmod-static-nodes.service[0m���eate List of Static D[ 3.125562] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... 424s evice Nodes... 424s Starting [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs... 424s [ 3.130733] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... 424s Starting [0;1;39mmodprobe@dm_mod.service[0m - Load Kernel Module dm_mod... 424s [ 3.134507] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... 424s Starting [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm...[ 3.137015] systemd-journald[284]: Collecting audit messages is disabled. 424s 424s [ 3.139000] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... 424s Starting [0;1;39mmodprobe@efi_pstore.servi���[0m - Load Kernel Module efi_pstore... 424s [ 3.146238] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... 424s Starting [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse... 424s [ 3.150256] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... 424s Starting [0;1;39mmodprobe@loop.service[0m - Load Kernel Module loop... 424s [ 3.152718] systemd[1]: netplan-ovs-cleanup.service - OpenVSwitch configuration for cleanup was skipped because of an unmet condition check (ConditionFileIsExecutable=/usr/bin/ovs-vsctl). 424s [ 3.155691] 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). 424s [ 3.161822] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... 424s Starting [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules... 424s [ 3.164212] systemd[1]: systemd-pcrmachine.service - TPM2 PCR Machine ID Measurement was skipped because of an unmet condition check (ConditionSecurity=measured-uki). 424s [ 3.167593] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... 424s Starting [0;1;39msystemd-remount-fs.servic���[0munt Root and Kernel File Systems... 424s [ 3.170443] systemd[1]: systemd-tpm2-setup-early.service - TPM2 SRK Setup (Early) was skipped because of an unmet condition check (ConditionSecurity=measured-uki). 424s [ 3.174312] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... 424s Starting [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices... 424s [ 3.177851] systemd[1]: Started systemd-journald.service - Journal Service. 424s [[0;32m OK [0m] Started [0;1;39msystemd-journald.service[0m - Journal Service. 424s [[0;32m OK [0m] Mounted [0;1;39mdev-hugepages.mount[0m - Huge Pages File S[ 3.181677] EXT4-fs (vda1): re-mounted 21f08275-91e8-4a2a-85f9-9a52f3ea034b r/w. Quota mode: none. 424s ystem. 424s [[0;32m OK [0m] Mounted [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System. 424s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System. 424s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System. 424s [[0;32m OK [0m] Finished [0;1;39mkeyboard-setup.service[0m - Set the console keyboard layout. 424s [[0;32m OK [0m] Finished [0;1;39mkmod-static-nodes.service[0m���Create List of Static Device Nodes. 424s [[0;32m OK [0m] Finished [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs. 424s [[0;32m OK [0m] Finished [0;1;39mmodprobe@dm_mod.service[0m - Load Kernel Module dm_mod. 424s [[0;32m OK [0m] Finished [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm. 424s [[0;32m OK [0m] Finished [0;1;39mmodprobe@efi_pstore.service[0m - Load Kernel Module efi_pstore. 424s [[0;32m OK [0m] Finished [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse. 424s [[0;32m OK [0m] Finished [0;1;39mmodprobe@loop.service[0m - Load Kernel Module loop. 424s [[0;32m OK [0m] Finished [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules. 424s [[0;32m OK [0m] Finished [0;1;39msystemd-remount-fs.servic���[0mmount Root and Kernel File Systems. 424s Mounting [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System... 424s Mounting [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System... 424s Starting [0;1;39mcloud-init-local.service[0m ���-init: Local Stage (pre-network)... 424s Starting [0;1;39mmultipathd.service[0m - Devi���pper Multipath Device Controller... 424s Starting [0;1;39msystemd-journal-flush.ser���[0msh Journal to Persistent Storage... 424s Starting [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed... 424s [ 3.242265] systemd-journald[284]: Received client request to flush runtime journal. 424s Startin[ 3.256454] systemd-journald[284]: /var/log/journal/dd935e54c01e41e68c1c9902a3ccca9c/system.journal: Journal file uses a different sequence number ID, rotating. 424s g [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables... 424s [ 3.258967] systemd-journald[284]: Rotating system journal. 424s Starting [0;1;39msystemd-tmpfiles-setup-de���[0m Device Nodes in /dev gracefully... 424s [[0;32m OK [0m] Mounted [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System. 424s [[0;32m OK [0m] Mounted [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System. 424s [[0;32m OK [0m] Finished [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables. 424s [[0;32m OK [0m] Finished [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices. 424s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mic Device Nodes in /dev gracefully. 424s Starting [0;1;39msystemd-tmpfiles-setup-de���[0meate Static Device Nodes in /dev... 424s [[0;32m OK [0m] Finished [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed. 424s [[0;32m OK [0m] Finished [0;1;39msystemd-journal-flush.ser���[0mlush Journal to Persistent Storage. 424s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de���[0mCreate Static Device Nodes in /dev. 424s Starting [0;1;39msystemd-udevd.service[0m - R���ager for Device Events and Files... 424s [[0;32m OK [0m] Started [0;1;39mmultipathd.service[0m - Devic���Mapper Multipath Device Controller. 424s [[0;32m OK [0m] Reached target [0;1;39mlocal-fs-pre.target[0m���Preparation for Local File Systems. 424s [[0;32m OK [0m] Started [0;1;39msystemd-udevd.service[0m - Ru���anager for Device Events and Files. 424s [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-conso���[0mequests to Console Directory Watch. 424s [[0;32m OK [0m] Reached target [0;1;39mcryptsetup.target[0m - Local Encrypted Volumes. 424s [[0;32m OK [0m] Found device [0;1;39mdev-ttyS0.device[0m - /dev/ttyS0. 424s [[0;32m OK [0m] Found device [0;1;39mdev-disk-by\x2dlabel-���T.device[0m - /dev/disk/by-label/BOOT. 424s [[0;32m OK [0m] Found device [0;1;39mdev-disk-by\x2dlabel-���I.device[0m - /dev/disk/by-label/UEFI. 424s Starting [0;1;39msystemd-fsck@dev-disk-by\���[0mCheck on /dev/disk/by-label/BOOT... 424s Starting [0;1;39msystemd-fsck@dev-disk-by\���[0mCheck on /dev/disk/by-label/UEFI... 424s [[0;32m OK [0m] Started [0;1;39msystemd-fsckd.service[0m - Fi���stem Check Daemon to report status. 424s Checking in progress on 1 disk (0.0% complete)[[0;32m OK [0m] Finished [0;1;39msystemd-fsck@dev-disk-by\���[0mm Check on /dev/disk/by-label/BOOT. 424s Mounting [0;1;39mboot.mount[0m - /boot... 424s Checking in progress on 0 disks (100.0% complete)[[0;32m OK [0m] Finished [0;1;39msystemd-fsck@dev-disk-by\���[0mm Check on /dev/disk/by-label/UEFI. 424s [[0;32m OK [0m] Mounted [0;1;39mboot.mount[0m - /boot. 424s Mounting [0;1;39mboot-efi.mount[0m - /boot/efi... 424s [[0;32m OK [0m] Mounted [0;1;39mboot-efi.mount[0m - /boot/efi. 424s [[0;32m OK [0m] Reached target [0;1;39mlocal-fs.target[0m - Local File Systems. 424s [[0;32m OK [0m] Listening on [0;1;39msystemd-sysext.socket[0m���tension Image Management (Varlink). 424s Starting [0;1;39mapparmor.service[0m - Load AppArmor profiles... 424s Starting [0;1;39mconsole-setup.service[0m - Set console font and keymap... 424s Starting [0;1;39mplymouth-read-write.servi���[0mymouth To Write Out Runtime Data... 424s Starting [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats... 424s Starting [0;1;39msystemd-tmpfiles-setup.se���[0me Volatile Files and Directories... 424s Starting [0;1;39mufw.service[0m - Uncomplicated firewall... 424s [[0;32m OK [0m] Finished [0;1;39mconsole-setup.service[0m - Set console font and keymap. 424s [[0;32m OK [0m] Finished [0;1;39mplymouth-read-write.servi���[0mPlymouth To Write Out Runtime Data. 424s [[0;32m OK [0m] Finished [0;1;39mufw.service[0m - Uncomplicated firewall. 424s [[0;32m OK [0m] Finished [0;1;39mapparmor.service[0m - Load AppArmor profiles. 424s [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup.se���[0mate Volatile Files and Directories. 424s [[0;32m OK [0m] Listening on [0;1;39msystemd-rfkill.socket[0m���ll Switch Status /dev/rfkill Watch. 424s Mounting [0;1;39mproc-sys-fs-binfmt_misc.m���[0mcutable File Formats File System... 424s Starting [0;1;39msystemd-resolved.service[0m - Network Name Resolution... 424s Starting [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization... 424s Starting [0;1;39msystemd-update-utmp.servi���[0mord System Boot/Shutdown in UTMP... 424s [[0;32m OK [0m] Mounted [0;1;39mproc-sys-fs-binfmt_misc.mo���[0mxecutable File Formats File System. 424s [[0;32m OK [0m] Finished [0;1;39msystemd-binfmt.service[0m - Set Up Additional Binary Formats. 424s [[0;32m OK [0m] Finished [0;1;39msystemd-update-utmp.servi���[0mecord System Boot/Shutdown in UTMP. 424s [[0;32m OK [0m] Started [0;1;39msystemd-timesyncd.service[0m - Network Time Synchronization. 424s [[0;32m OK [0m] Reached target [0;1;39mtime-set.target[0m - System Time Set. 424s [ 3.684839] cloud-init[597]: Cloud-init v. 25.1.2-0ubuntu0~24.04.1 running 'init-local' at Fri, 13 Jun 2025 02:15:29 +0000. Up 3.66 seconds. 424s [[0;32m OK [0m] Started [0;1;39msystemd-resolved.service[0m - Network Name Resolution. 424s [[0;32m OK [0m] Reached target [0;1;39mnss-lookup.target[0m - Host and Network Name Lookups. 424s [ 19.216904] cloud-init[597]: 2025-06-13 02:15:44,847 - log_util.py[WARNING]: No active metadata service found 424s [[0;32m OK [0m] Finished [0;1;39mcloud-init-local.service[0m ���ud-init: Local Stage (pre-network). 424s [[0;32m OK [0m] Reached target [0;1;39mnetwork-pre.target[0m - Preparation for Network. 424s Starting [0;1;39msystemd-networkd.service[0m - Network Configuration... 424s [[0;32m OK [0m] Started [0;1;39msystemd-networkd.service[0m - Network Configuration. 424s [[0;32m OK [0m] Reached target [0;1;39mnetwork.target[0m - Network. 424s Starting [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured... 424s [ [0;31m*[0;1;31m*[0m] Job systemd-networkd-wait-online.se���ice/start running (14s / no limit) 424s M[K[ [0;31m*[0m] Job systemd-networkd-wait-online.se���ice/start running (14s / no limit) 424s M[K[[0;32m OK [0m] Finished [0;1;39msystemd-networkd-wait-onl���[0m Wait for Network to be Configured. 424s [K Starting [0;1;39mcloud-init.service[0m - Cloud-init: Network Stage... 424s [ 34.387342] cloud-init[685]: Cloud-init v. 25.1.2-0ubuntu0~24.04.1 running 'init' at Fri, 13 Jun 2025 02:16:00 +0000. Up 34.37 seconds. 424s [ 34.394098] cloud-init[685]: ci-info: +++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++ 424s [ 34.395473] cloud-init[685]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 424s [ 34.396830] cloud-init[685]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 424s [ 34.398170] cloud-init[685]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 424s [ 34.399499] cloud-init[685]: ci-info: | ens3 | True | 10.151.36.222 | 255.255.255.0 | global | fa:16:3e:34:c0:a7 | 424s [ 34.400839] cloud-init[685]: ci-info: | ens3 | True | fe80::f816:3eff:fe34:c0a7/64 | . | link | fa:16:3e:34:c0:a7 | 424s [ 34.402179] cloud-init[685]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 424s [ 34.403519] cloud-init[685]: ci-info: | lo | True | ::1/128 | . | host | . | 424s [ 34.404870] cloud-init[685]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 424s [ 34.406194] cloud-init[685]: ci-info: ++++++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++++++ 424s [ 34.407412] cloud-init[685]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 424s [ 34.408634] cloud-init[685]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | 424s [ 34.409842] cloud-init[685]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 424s [ 34.411049] cloud-init[685]: ci-info: | 0 | 0.0.0.0 | 10.151.36.1 | 0.0.0.0 | ens3 | UG | 424s [ 34.412264] cloud-init[685]: ci-info: | 1 | 10.151.11.5 | 10.151.36.1 | 255.255.255.255 | ens3 | UGH | 424s [ 34.413468] cloud-init[685]: ci-info: | 2 | 10.151.11.6 | 10.151.36.1 | 255.255.255.255 | ens3 | UGH | 424s [ 34.414669] cloud-init[685]: ci-info: | 3 | 10.151.11.7 | 10.151.36.1 | 255.255.255.255 | ens3 | UGH | 424s [ 34.415940] cloud-init[685]: ci-info: | 4 | 10.151.36.0 | 0.0.0.0 | 255.255.255.0 | ens3 | U | 424s [ 34.417139] cloud-init[685]: ci-info: | 5 | 10.151.36.1 | 0.0.0.0 | 255.255.255.255 | ens3 | UH | 424s [ 34.418359] cloud-init[685]: ci-info: | 6 | 10.151.36.2 | 0.0.0.0 | 255.255.255.255 | ens3 | UH | 424s [ 34.419573] cloud-init[685]: ci-info: | 7 | 169.254.169.254 | 10.151.36.2 | 255.255.255.255 | ens3 | UGH | 424s [ 34.420788] cloud-init[685]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 424s [ 34.421992] cloud-init[685]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 424s [ 34.423135] cloud-init[685]: ci-info: +-------+-------------+---------+-----------+-------+ 424s [ 34.424201] cloud-init[685]: ci-info: | Route | Destination | Gateway | Interface | Flags | 424s [ 34.425227] cloud-init[685]: ci-info: +-------+-------------+---------+-----------+-------+ 424s [ 34.426238] cloud-init[685]: ci-info: | 0 | fe80::/64 | :: | ens3 | U | 424s [ 34.427249] cloud-init[685]: ci-info: | 2 | local | :: | ens3 | U | 424s [ 34.428266] cloud-init[685]: ci-info: | 3 | multicast | :: | ens3 | U | 424s [ 34.429278] cloud-init[685]: ci-info: +-------+-------------+---------+-----------+-------+ 424s [ 34.587744] cloud-init[685]: 2025-06-13 02:16:00,218 - log_util.py[WARNING]: No active metadata service found 424s [[0;32m OK [0m] Stopped [0;1;39msystemd-networkd-wait-onli���[0m Wait for Network to be Configured. 424s Stopping [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured... 424s Stopping [0;1;39msystemd-networkd.service[0m - Network Configuration... 424s [[0;32m OK [0m] Stopped [0;1;39msystemd-networkd.service[0m - Network Configuration. 424s Starting [0;1;39msystemd-networkd.service[0m - Network Configuration... 424s [[0;32m OK [0m] Started [0;1;39msystemd-networkd.service[0m - Network Configuration. 424s Starting [0;1;39msystemd-networkd-wait-onl���[0mait for Network to be Configured... 424s [ 37.184782] cloud-init[685]: Generating public/private rsa key pair. 424s [ 37.185672] cloud-init[685]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key 424s [ 37.186665] cloud-init[685]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub 424s [ 37.187660] cloud-init[685]: The key fingerprint is: 424s [ 37.188305] cloud-init[685]: SHA256:iU5VtvbGw8aJ2rQubcBs+ONxp6XUg0nQRZtk5P2lA24 root@auto-syncubuntu-noble-24-04-amd64-server-20250610-disk1-img-ad 424s [ 37.189800] cloud-init[685]: The key's randomart image is: 424s [ 37.190455] cloud-init[685]: +---[RSA 3072]----+ 424s [ 37.191045] cloud-init[685]: | oo* | 424s [ 37.191614] cloud-init[685]: | + * + | 424s [ 37.192223] cloud-init[685]: | o + = . .| 424s [ 37.192811] cloud-init[685]: | o + B o o.| 424s [ 37.193379] cloud-init[685]: | o+S + E o .| 424s [ 37.193944] cloud-init[685]: | o. == O . . | 424s [ 37.194512] cloud-init[685]: | .oooB = | 424s [ 37.195079] cloud-init[685]: | +=o= . | 424s [ 37.195645] cloud-init[685]: | ..++ | 424s [ 37.196224] cloud-init[685]: +----[SHA256]-----+ 424s [ 37.196787] cloud-init[685]: Generating public/private ecdsa key pair. 424s [ 37.197550] cloud-init[685]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key 424s [ 37.198554] cloud-init[685]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub 424s [ 37.199551] cloud-init[685]: The key fingerprint is: 424s [ 37.200151] cloud-init[685]: SHA256:N8EwQsd5Y98uPW0EDotrsBavdUOqxWFpAvddTfVom58 root@auto-syncubuntu-noble-24-04-amd64-server-20250610-disk1-img-ad 424s [ 37.201673] cloud-init[685]: The key's randomart image is: 424s [ 37.202336] cloud-init[685]: +---[ECDSA 256]---+ 424s [ 37.202906] cloud-init[685]: | .o.+. o+| 424s [ 37.203470] cloud-init[685]: | .o+++ . o.o| 424s [ 37.204056] cloud-init[685]: | o +o* *o..| 424s [ 37.204625] cloud-init[685]: | + B.=.oo.| 424s [ 37.205191] cloud-init[685]: | SXo= ooo | 424s [ 37.205752] cloud-init[685]: | o.O.+ +.+| 424s [ 37.206312] cloud-init[685]: | . * . o E.| 424s [ 37.206924] cloud-init[685]: | o | 424s [ 37.207490] cloud-init[685]: | | 424s [ 37.208215] cloud-init[685]: +----[SHA256]-----+ 424s [ 37.208780] cloud-init[685]: Generating public/private ed25519 key pair. 424s [ 37.209566] cloud-init[685]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key 424s [ 37.210589] cloud-init[685]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub 424s [ 37.211602] cloud-init[685]: The key fingerprint is: 424s [ 37.212206] cloud-init[685]: SHA256:wFaZIwosJLn+ZlTAcFVA7AtizYLPes6uxT95JtAvf+4 root@auto-syncubuntu-noble-24-04-amd64-server-20250610-disk1-img-ad 424s [ 37.213680] cloud-init[685]: The key's randomart image is: 424s [ 37.214320] cloud-init[685]: +--[ED25519 256]--+ 424s [ 37.214885] cloud-init[685]: |o=o.++o..o | 424s [ 37.215444] cloud-init[685]: |+ +o o..+ | 424s [ 37.216035] cloud-init[685]: |.oo.o.+. . | 424s [ 37.216596] cloud-init[685]: |o+ +.+ . | 424s [ 37.217155] cloud-init[685]: |ooo.o . S | 424s [ 37.217711] cloud-init[685]: | o+... | 424s [ 37.218278] cloud-init[685]: | .=. o | 424s [ 37.218841] cloud-init[685]: |.o.== + . | 424s [ 37.219401] cloud-init[685]: |.=* .B.+E | 424s [ 37.220056] cloud-init[685]: +----[SHA256]-----+ 424s [[0;32m OK [0m] Finished [0;1;39msystemd-networkd-wait-onl���[0m Wait for Network to be Configured. 424s [[0;32m OK [0m] Finished [0;1;39mcloud-init.service[0m - Cloud-init: Network Stage. 424s [[0;32m OK [0m] Reached target [0;1;39mcloud-config.target[0m - Cloud-config availability. 424s [[0;32m OK [0m] Reached target [0;1;39mnetwork-online.target[0m - Network is Online. 424s [[0;32m OK [0m] Reached target [0;1;39msysinit.target[0m - System Initialization. 424s [[0;32m OK [0m] Started [0;1;39mapt-daily.timer[0m - Daily apt download activities. 424s [[0;32m OK [0m] Started [0;1;39mapt-daily-upgrade.timer[0m - ���y apt upgrade and clean activities. 424s [[0;32m OK [0m] Started [0;1;39mdpkg-db-backup.timer[0m - Daily dpkg database backup timer. 424s [[0;32m OK [0m] Started [0;1;39me2scrub_all.timer[0m - Period���Metadata Check for All Filesystems. 424s [[0;32m OK [0m] Started [0;1;39mfstrim.timer[0m - Discard unused filesystem blocks once a week. 424s [[0;32m OK [0m] Started [0;1;39mfwupd-refresh.timer[0m - Refresh fwupd metadata regularly. 424s [[0;32m OK [0m] Started [0;1;39mlogrotate.timer[0m - Daily rotation of log files. 424s [[0;32m OK [0m] Started [0;1;39mman-db.timer[0m - Daily man-db regeneration. 424s [[0;32m OK [0m] Started [0;1;39mmotd-news.timer[0m - Message of the Day. 424s [[0;32m OK [0m] Started [0;1;39msysstat-collect.timer[0m - Ru���y accounting tool every 10 minutes. 424s [[0;32m OK [0m] Started [0;1;39msysstat-summary.timer[0m - Ge��� of yesterday's process accounting. 424s [[0;32m OK [0m] Started [0;1;39msystemd-tmpfiles-clean.tim���[0my Cleanup of Temporary Directories. 424s [[0;32m OK [0m] Reached target [0;1;39mpaths.target[0m - Path Units. 424s [[0;32m OK [0m] Reached target [0;1;39mtimers.target[0m - Timer Units. 424s [[0;32m OK [0m] Listening on [0;1;39mcloud-init-hotplugd.s���t[0m - cloud-init hotplug hook socket. 424s [[0;32m OK [0m] Listening on [0;1;39mdbus.socket[0m - D-Bus System Message Bus Socket. 424s Starting [0;1;39mlxd-installer.socket[0m - He���er to install lxd snap on demand... 424s [[0;32m OK [0m] Listening on [0;1;39mssh.socket[0m - OpenBSD Secure Shell server socket. 424s [[0;32m OK [0m] Listening on [0;1;39muuidd.socket[0m - UUID daemon activation socket. 424s [[0;32m OK [0m] Listening on [0;1;39mlxd-installer.socket[0m ���lper to install lxd snap on demand. 424s [[0;32m OK [0m] Reached target [0;1;39msockets.target[0m - Socket Units. 424s [[0;32m OK [0m] Reached target [0;1;39mbasic.target[0m - Basic System. 424s Starting [0;1;39mapport.service[0m - automatic crash report generation... 424s [[0;32m OK [0m] Started [0;1;39mautopkgtest@ttyS1.service[0m - autopkgtest root shell on ttyS1. 424s Starting [0;1;39mcloud-config.service[0m - Cloud-init: Config Stage... 424s [[0;32m OK [0m] Started [0;1;39mcron.service[0m - Regular background program processing daemon. 424s Starting [0;1;39mdbus.service[0m - D-Bus System Message Bus... 424s [[0;32m OK [0m] Started [0;1;39mdmesg.service[0m - Save initial kernel messages after boot. 424s Starting [0;1;39me2scrub_reap.service[0m - Re���ne ext4 Metadata Check Snapshots... 424s Starting [0;1;39mgrub-common.service[0m - Record successful boot for GRUB... 424s Starting [0;1;39mpollinate.service[0m - Polli���e pseudo random number generator... 424s Starting [0;1;39mrng-tools-debian.service[0m - LSB: rng-tools (Debian variant)... 424s Starting [0;1;39mrsyslog.service[0m - System Logging Service... 424s Starting [0;1;39msysstat.service[0m - Resets System Activity Logs... 424s Starting [0;1;39msystemd-logind.service[0m - User Login Management... 424s Starting [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions... 424s Starting [0;1;39mudisks2.service[0m - Disk Manager... 424s [[0;32m OK [0m] Started [0;1;39mdbus.service[0m - D-Bus System Message Bus. 424s [[0;32m OK [0m] Finished [0;1;39me2scrub_reap.service[0m - Re���line ext4 Metadata Check Snapshots. 424s [[0;32m OK [0m] Finished [0;1;39msysstat.service[0m - Resets System Activity Logs. 424s [[0;32m OK [0m] Finished [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions. 424s Starting [0;1;39mplymouth-quit-wait.servic���[0md until boot process finishes up... 424s Starting [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen... 424s [[0;32m OK [0m] Finished [0;1;39mplymouth-quit-wait.servic���[0mold until boot process finishes up. 424s [[0;32m OK [0m] Started [0;1;39mserial-getty@ttyS0.service[0m - Serial Getty on ttyS0. 424s Starting [0;1;39msetvtrgb.service[0m - Set console scheme... 424s [[0;32m OK [0m] Started [0;1;39mrng-tools-debian.service[0m - LSB: rng-tools (Debian variant). 424s [[0;32m OK [0m] Finished [0;1;39mgrub-common.service[0m - Record successful boot for GRUB. 424s Starting [0;1;39mgrub-initrd-fallback.service[0m - GRUB failed boot detection... 424s [[0;32m OK [0m] Finished [0;1;39mplymouth-quit.service[0m - Terminate Plymouth Boot Screen. 424s [[0;32m OK [0m] Started [0;1;39msystemd-logind.service[0m - User Login Management. 424s [[0;32m OK [0m] Finished [0;1;39msetvtrgb.service[0m - Set console scheme. 424s [[0;32m OK [0m] Created slice [0;1;39msystem-getty.slice[0m - Slice /system/getty. 424s [[0;32m OK [0m] Started [0;1;39mgetty@tty1.service[0m - Getty on tty1. 424s [[0;32m OK [0m] Reached target [0;1;39mgetty.target[0m - Login Prompts. 424s [[0;32m OK [0m] Finished [0;1;39mgrub-initrd-fallback.service[0m - GRUB failed boot detection. 424s [[0;32m OK [0m] Started [0;1;39mudisks2.service[0m - Disk Manager. 424s [[0;32m OK [0m] Finished [0;1;39mapport.service[0m - automatic crash report generation. 424s [[0;32m OK [0m] Started [0;1;39mrsyslog.service[0m - System Logging Service. 424s [ 44.834838] cloud-init[954]: Cloud-init v. 25.1.2-0ubuntu0~24.04.1 running 'modules:config' at Fri, 13 Jun 2025 02:16:10 +0000. Up 44.80 seconds. 424s [ 44.968493] cloud-init[954]: 2025-06-13 02:16:10,599 - lifecycle.py[DEPRECATED]: The following config key(s): ['apt_preserve_sources_list'] is deprecated in 22.1 and scheduled to be removed in 27.1. 424s [ 44.970574] cloud-init[954]: 2025-06-13 02:16:10,599 - 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. 424s [[0;32m OK [0m] Finished [0;1;39mcloud-config.service[0m - Cloud-init: Config Stage. 424s 424s Ubuntu 24.04.2 LTS auto-syncubuntu-noble-24-04-amd64-server-20250610-disk1-img-ad ttyS0 424s 424s auto-syncubuntu-noble-24-04-amd64-server-20250610-disk1-img-ad login: [ 54.981248] cloud-init[1013]: Cloud-init v. 25.1.2-0ubuntu0~24.04.1 running 'modules:final' at Fri, 13 Jun 2025 02:16:20 +0000. Up 54.95 seconds. 424s ci-info: ++++++++++++++++++++++++++++++++++++++++++++++++++++++Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu+++++++++++++++++++++++++++++++++++++++++++++++++++++++ 424s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 424s ci-info: | Keytype | Fingerprint (sha256) | Options | Comment | 424s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 424s 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 | 424s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 424s <14>Jun 13 02:16:20 cloud-init: ############################################################# 424s <14>Jun 13 02:16:20 cloud-init: -----BEGIN SSH HOST KEY FINGERPRINTS----- 424s <14>Jun 13 02:16:20 cloud-init: 256 SHA256:N8EwQsd5Y98uPW0EDotrsBavdUOqxWFpAvddTfVom58 root@auto-syncubuntu-noble-24-04-amd64-server-20250610-disk1-img-ad (ECDSA) 424s <14>Jun 13 02:16:20 cloud-init: 256 SHA256:wFaZIwosJLn+ZlTAcFVA7AtizYLPes6uxT95JtAvf+4 root@auto-syncubuntu-noble-24-04-amd64-server-20250610-disk1-img-ad (ED25519) 424s <14>Jun 13 02:16:20 cloud-init: 3072 SHA256:iU5VtvbGw8aJ2rQubcBs+ONxp6XUg0nQRZtk5P2lA24 root@auto-syncubuntu-noble-24-04-amd64-server-20250610-disk1-img-ad (RSA) 424s <14>Jun 13 02:16:20 cloud-init: -----END SSH HOST KEY FINGERPRINTS----- 424s <14>Jun 13 02:16:20 cloud-init: ############################################################# 424s -----BEGIN SSH HOST KEY KEYS----- 424s ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBG3KXmZAw1pla8buUVKCX9vG1CbG2n1kg8gp1LgVmWp+F4GsYGtEUQyVnFN9ivxn6iddEuaitPIgCabc5lUQwRw= root@auto-syncubuntu-noble-24-04-amd64-server-20250610-disk1-img-ad 424s ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIJGzEdz72CENrT5rTB27qb6RGdl0bXtm/5y02yqmKDF5 root@auto-syncubuntu-noble-24-04-amd64-server-20250610-disk1-img-ad 424s ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDY/I/m0c9JjY0sewSigYPdB762oSpMAJPklTsetExh32IVKE/wplYCWkDb+3qaSeT2C1JtBvY06A7tS0SqzTph+81Q3dxjSO9CdyfoMzCi/Yg4HZ7aS4kvBWyqyKn+u30tMDFXzu8MjSHWJFGgSKI/axyQVlRomyTkOoOYc1+3354QW4l5RRHSvZ5HF+5SdNf4Kz8lSU3bTfbf2ONKVYSVpIamkWCl4QKApK5sMhB8DTiT05Be9l7ghKAqbbm5JY3itGNEVPdQvfStzmSRrBPDrexl15LrOvWTSoLv8K9i3KiPaGyxvV6mLVh3uHzmMW7sLNdHAhMcbIurJYtCeJq/c4daGEU7ljA7vVcU2g53Xi1JAmPwmNDk3rNsF61ciq3rUe5E/3OYcx+IXmyEU3kCiS0TLcrpwxhFVh+auF5ImDFIKnioz3kNWEoym1dpoqG3fKZEoz4y/iR4FjRTUHrA1Y4o5aQKJY02A/eIMWcrfom8aW8IXmASEN42FprX9m8= root@auto-syncubuntu-noble-24-04-amd64-server-20250610-disk1-img-ad 424s -----END SSH HOST KEY KEYS----- 424s [ 55.054338] cloud-init[1013]: Cloud-init v. 25.1.2-0ubuntu0~24.04.1 finished at Fri, 13 Jun 2025 02:16:20 +0000. Datasource DataSourceNone. Up 55.03 seconds 424s [ 55.054433] cloud-init[1013]: 2025-06-13 02:16:20,673 - cc_final_message.py[WARNING]: Used fallback datasource 424s 424s --------------------------------------------------- 424s ------- nova show 298e096d-78a6-43c4-99eb-e7a636e82370 (adt-noble-amd64-linux-ibm-20250612-235055-juju-7f2275-prod-proposed-migration-environment-20-f895ae9f-2e37-4005-85ff-ada3a0ce0d1d) ------ 424s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 424s | Property | Value | 424s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 424s | OS-DCF:diskConfig | MANUAL | 424s | OS-EXT-AZ:availability_zone | AZ3 | 424s | OS-EXT-SRV-ATTR:host | ps7-ra6-n1.ps7.canonical.com | 424s | OS-EXT-SRV-ATTR:hostname | adt-noble-amd64-linux-ibm-20250612-235055-juju-7f2275-prod-prop | 424s | OS-EXT-SRV-ATTR:hypervisor_hostname | ps7-ra6-n1.ps7.canonical.com | 424s | OS-EXT-SRV-ATTR:instance_name | instance-0007c996 | 424s | OS-EXT-SRV-ATTR:kernel_id | | 424s | OS-EXT-SRV-ATTR:launch_index | 0 | 424s | OS-EXT-SRV-ATTR:ramdisk_id | | 424s | OS-EXT-SRV-ATTR:reservation_id | r-yxv0skad | 424s | OS-EXT-SRV-ATTR:root_device_name | /dev/vda | 424s | OS-EXT-STS:power_state | 1 | 424s | OS-EXT-STS:task_state | - | 424s | OS-EXT-STS:vm_state | active | 424s | OS-SRV-USG:launched_at | 2025-06-13T02:15:24.000000 | 424s | OS-SRV-USG:terminated_at | - | 424s | accessIPv4 | | 424s | accessIPv6 | | 424s | config_drive | | 424s | created | 2025-06-13T02:14:41Z | 424s | description | - | 424s | flavor:disk | 100 | 424s | flavor:ephemeral | 0 | 424s | flavor:extra_specs | {"aggregate_instance_extra_specs:commit": "amd64", "hw:cpu_policy": "shared", "hw:mem_page_size": "large", "hw:pci_numa_affinity_policy": "preferred"} | 424s | flavor:original_name | autopkgtest-cpu4-ram16-disk100-amd64 | 424s | flavor:ram | 16384 | 424s | flavor:swap | 0 | 424s | flavor:vcpus | 4 | 424s | hostId | 4d537748b21485c2e2e92cd6380edeb21de4a1ce18c910fa2f71beb9 | 424s | id | 298e096d-78a6-43c4-99eb-e7a636e82370 | 424s | image | adt/ubuntu-noble-amd64-server-20250613.img (bf64d55c-279f-422d-aa12-2f04c07e168f) | 424s | key_name | testbed-juju-7f2275-prod-proposed-migration-environment-20 | 424s | locked | False | 424s | locked_reason | - | 424s | metadata | {} | 424s | name | adt-noble-amd64-linux-ibm-20250612-235055-juju-7f2275-prod-proposed-migration-environment-20-f895ae9f-2e37-4005-85ff-ada3a0ce0d1d | 424s | net_prod-autopkgtest-workers-amd64 network | 10.151.36.222 | 424s | os-extended-volumes:volumes_attached | [] | 424s | progress | 0 | 424s | security_groups | autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@sto01-23.secgroup | 424s | server_groups | [] | 424s | status | ACTIVE | 424s | tags | [] | 424s | tenant_id | c20da633fc2e44cd97ff31be0acd959a | 424s | trusted_image_certificates | - | 424s | updated | 2025-06-13T02:15:25Z | 424s | user_id | d1c206dbd7b64e3eacefc738fd9acdca | 424s +--------------------------------------------+--------------------------------------------------------------------------------------------------------------------------------------------------------+ 424s --------------------------------------------------- 424s nova [W] Timed out waiting for 298e096d-78a6-43c4-99eb-e7a636e82370 to get deleted. 424s nova [E] No UUID given. Instance won't be deleted! 424s : failure: setup script failed with code 1: /home/ubuntu/autopkgtest/ssh-setup/nova open --flavor autopkgtest-cpu4-ram16-disk100-amd64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@sto01-23.secgroup --name adt-noble-amd64-linux-ibm-20250612-235055-juju-7f2275-prod-proposed-migration-environment-20-f895ae9f-2e37-4005-85ff-ada3a0ce0d1d --image adt/ubuntu-noble-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 424s autopkgtest [02:21:40]: ERROR: testbed failure: unexpected eof from the testbed