Jul 2 08:55:06.893157 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jul 2 08:55:06.893178 kernel: Linux version 6.6.36-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.2.1_p20240210 p14) 13.2.1 20240210, GNU ld (Gentoo 2.41 p5) 2.41.0) #1 SMP PREEMPT Mon Jul 1 22:48:46 -00 2024 Jul 2 08:55:06.893188 kernel: KASLR enabled Jul 2 08:55:06.893193 kernel: efi: EFI v2.7 by EDK II Jul 2 08:55:06.893199 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb900018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 Jul 2 08:55:06.893205 kernel: random: crng init done Jul 2 08:55:06.893212 kernel: ACPI: Early table checksum verification disabled Jul 2 08:55:06.893217 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Jul 2 08:55:06.893224 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Jul 2 08:55:06.893231 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jul 2 08:55:06.893237 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 2 08:55:06.893243 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jul 2 08:55:06.893249 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 2 08:55:06.893256 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 2 08:55:06.893263 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 2 08:55:06.893271 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 2 08:55:06.893277 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jul 2 08:55:06.893284 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 2 08:55:06.893290 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jul 2 08:55:06.893297 kernel: NUMA: Failed to initialise from firmware Jul 2 08:55:06.893330 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jul 2 08:55:06.893338 kernel: NUMA: NODE_DATA [mem 0xdc957800-0xdc95cfff] Jul 2 08:55:06.893344 kernel: Zone ranges: Jul 2 08:55:06.893350 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jul 2 08:55:06.893357 kernel: DMA32 empty Jul 2 08:55:06.893366 kernel: Normal empty Jul 2 08:55:06.893372 kernel: Movable zone start for each node Jul 2 08:55:06.893378 kernel: Early memory node ranges Jul 2 08:55:06.893385 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Jul 2 08:55:06.893391 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Jul 2 08:55:06.893397 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Jul 2 08:55:06.893404 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Jul 2 08:55:06.893410 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Jul 2 08:55:06.893416 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Jul 2 08:55:06.893422 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Jul 2 08:55:06.893429 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jul 2 08:55:06.893435 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jul 2 08:55:06.893443 kernel: psci: probing for conduit method from ACPI. Jul 2 08:55:06.893449 kernel: psci: PSCIv1.1 detected in firmware. Jul 2 08:55:06.893456 kernel: psci: Using standard PSCI v0.2 function IDs Jul 2 08:55:06.893465 kernel: psci: Trusted OS migration not required Jul 2 08:55:06.893472 kernel: psci: SMC Calling Convention v1.1 Jul 2 08:55:06.893479 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jul 2 08:55:06.893487 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Jul 2 08:55:06.893494 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Jul 2 08:55:06.893501 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jul 2 08:55:06.893508 kernel: Detected PIPT I-cache on CPU0 Jul 2 08:55:06.893515 kernel: CPU features: detected: GIC system register CPU interface Jul 2 08:55:06.893521 kernel: CPU features: detected: Hardware dirty bit management Jul 2 08:55:06.893528 kernel: CPU features: detected: Spectre-v4 Jul 2 08:55:06.893549 kernel: CPU features: detected: Spectre-BHB Jul 2 08:55:06.893556 kernel: CPU features: kernel page table isolation forced ON by KASLR Jul 2 08:55:06.893563 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jul 2 08:55:06.893579 kernel: CPU features: detected: ARM erratum 1418040 Jul 2 08:55:06.893586 kernel: alternatives: applying boot alternatives Jul 2 08:55:06.893593 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=339cf548fbb7b0074109371a653774e9fabae27ff3a90e4c67dbbb2f78376930 Jul 2 08:55:06.893600 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 2 08:55:06.893607 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 2 08:55:06.893614 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 2 08:55:06.893622 kernel: Fallback order for Node 0: 0 Jul 2 08:55:06.893629 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Jul 2 08:55:06.893636 kernel: Policy zone: DMA Jul 2 08:55:06.893642 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 2 08:55:06.893649 kernel: software IO TLB: area num 4. Jul 2 08:55:06.893658 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Jul 2 08:55:06.893665 kernel: Memory: 2386848K/2572288K available (10240K kernel code, 2182K rwdata, 8072K rodata, 39040K init, 897K bss, 185440K reserved, 0K cma-reserved) Jul 2 08:55:06.893672 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 2 08:55:06.893679 kernel: trace event string verifier disabled Jul 2 08:55:06.893686 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 2 08:55:06.893693 kernel: rcu: RCU event tracing is enabled. Jul 2 08:55:06.893700 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 2 08:55:06.893707 kernel: Trampoline variant of Tasks RCU enabled. Jul 2 08:55:06.893714 kernel: Tracing variant of Tasks RCU enabled. Jul 2 08:55:06.893721 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 2 08:55:06.893728 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 2 08:55:06.893735 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jul 2 08:55:06.893743 kernel: GICv3: 256 SPIs implemented Jul 2 08:55:06.893750 kernel: GICv3: 0 Extended SPIs implemented Jul 2 08:55:06.893757 kernel: Root IRQ handler: gic_handle_irq Jul 2 08:55:06.893764 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Jul 2 08:55:06.893771 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jul 2 08:55:06.893778 kernel: ITS [mem 0x08080000-0x0809ffff] Jul 2 08:55:06.893784 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Jul 2 08:55:06.893791 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Jul 2 08:55:06.893798 kernel: GICv3: using LPI property table @0x00000000400f0000 Jul 2 08:55:06.893805 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Jul 2 08:55:06.893812 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 2 08:55:06.893820 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 2 08:55:06.893827 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jul 2 08:55:06.893834 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jul 2 08:55:06.893841 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jul 2 08:55:06.893847 kernel: arm-pv: using stolen time PV Jul 2 08:55:06.893854 kernel: Console: colour dummy device 80x25 Jul 2 08:55:06.893861 kernel: ACPI: Core revision 20230628 Jul 2 08:55:06.893868 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jul 2 08:55:06.893875 kernel: pid_max: default: 32768 minimum: 301 Jul 2 08:55:06.893882 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Jul 2 08:55:06.893891 kernel: SELinux: Initializing. Jul 2 08:55:06.893898 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 2 08:55:06.893905 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 2 08:55:06.893912 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Jul 2 08:55:06.893919 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Jul 2 08:55:06.893925 kernel: rcu: Hierarchical SRCU implementation. Jul 2 08:55:06.893933 kernel: rcu: Max phase no-delay instances is 400. Jul 2 08:55:06.893939 kernel: Platform MSI: ITS@0x8080000 domain created Jul 2 08:55:06.893946 kernel: PCI/MSI: ITS@0x8080000 domain created Jul 2 08:55:06.893954 kernel: Remapping and enabling EFI services. Jul 2 08:55:06.893962 kernel: smp: Bringing up secondary CPUs ... Jul 2 08:55:06.893969 kernel: Detected PIPT I-cache on CPU1 Jul 2 08:55:06.893976 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jul 2 08:55:06.893983 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Jul 2 08:55:06.893989 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 2 08:55:06.893996 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jul 2 08:55:06.894003 kernel: Detected PIPT I-cache on CPU2 Jul 2 08:55:06.894010 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jul 2 08:55:06.894017 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Jul 2 08:55:06.894025 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 2 08:55:06.894032 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jul 2 08:55:06.894044 kernel: Detected PIPT I-cache on CPU3 Jul 2 08:55:06.894053 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jul 2 08:55:06.894061 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Jul 2 08:55:06.894068 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 2 08:55:06.894076 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jul 2 08:55:06.894083 kernel: smp: Brought up 1 node, 4 CPUs Jul 2 08:55:06.894090 kernel: SMP: Total of 4 processors activated. Jul 2 08:55:06.894099 kernel: CPU features: detected: 32-bit EL0 Support Jul 2 08:55:06.894106 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jul 2 08:55:06.894114 kernel: CPU features: detected: Common not Private translations Jul 2 08:55:06.894121 kernel: CPU features: detected: CRC32 instructions Jul 2 08:55:06.894128 kernel: CPU features: detected: Enhanced Virtualization Traps Jul 2 08:55:06.894136 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jul 2 08:55:06.894143 kernel: CPU features: detected: LSE atomic instructions Jul 2 08:55:06.894151 kernel: CPU features: detected: Privileged Access Never Jul 2 08:55:06.894160 kernel: CPU features: detected: RAS Extension Support Jul 2 08:55:06.894167 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jul 2 08:55:06.894174 kernel: CPU: All CPU(s) started at EL1 Jul 2 08:55:06.894182 kernel: alternatives: applying system-wide alternatives Jul 2 08:55:06.894189 kernel: devtmpfs: initialized Jul 2 08:55:06.894196 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 2 08:55:06.894204 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 2 08:55:06.894211 kernel: pinctrl core: initialized pinctrl subsystem Jul 2 08:55:06.894219 kernel: SMBIOS 3.0.0 present. Jul 2 08:55:06.894228 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Jul 2 08:55:06.894236 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 2 08:55:06.894243 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jul 2 08:55:06.894250 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jul 2 08:55:06.894258 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jul 2 08:55:06.894265 kernel: audit: initializing netlink subsys (disabled) Jul 2 08:55:06.894272 kernel: audit: type=2000 audit(0.023:1): state=initialized audit_enabled=0 res=1 Jul 2 08:55:06.894280 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 2 08:55:06.894287 kernel: cpuidle: using governor menu Jul 2 08:55:06.894296 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jul 2 08:55:06.894312 kernel: ASID allocator initialised with 32768 entries Jul 2 08:55:06.894321 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 2 08:55:06.894328 kernel: Serial: AMBA PL011 UART driver Jul 2 08:55:06.894335 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jul 2 08:55:06.894342 kernel: Modules: 0 pages in range for non-PLT usage Jul 2 08:55:06.894350 kernel: Modules: 509120 pages in range for PLT usage Jul 2 08:55:06.894357 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 2 08:55:06.894364 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jul 2 08:55:06.894373 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jul 2 08:55:06.894381 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jul 2 08:55:06.894388 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 2 08:55:06.894395 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jul 2 08:55:06.894403 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jul 2 08:55:06.894410 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jul 2 08:55:06.894422 kernel: ACPI: Added _OSI(Module Device) Jul 2 08:55:06.894430 kernel: ACPI: Added _OSI(Processor Device) Jul 2 08:55:06.894438 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jul 2 08:55:06.894447 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 2 08:55:06.894454 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 2 08:55:06.894461 kernel: ACPI: Interpreter enabled Jul 2 08:55:06.894468 kernel: ACPI: Using GIC for interrupt routing Jul 2 08:55:06.894476 kernel: ACPI: MCFG table detected, 1 entries Jul 2 08:55:06.894483 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jul 2 08:55:06.894491 kernel: printk: console [ttyAMA0] enabled Jul 2 08:55:06.894498 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 2 08:55:06.894650 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 2 08:55:06.894734 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jul 2 08:55:06.894805 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jul 2 08:55:06.894872 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jul 2 08:55:06.894937 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jul 2 08:55:06.894947 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jul 2 08:55:06.894954 kernel: PCI host bridge to bus 0000:00 Jul 2 08:55:06.895026 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jul 2 08:55:06.895089 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jul 2 08:55:06.895152 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jul 2 08:55:06.895214 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 2 08:55:06.895314 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Jul 2 08:55:06.895395 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Jul 2 08:55:06.895465 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Jul 2 08:55:06.895538 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Jul 2 08:55:06.895616 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Jul 2 08:55:06.895686 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Jul 2 08:55:06.895753 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Jul 2 08:55:06.895821 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Jul 2 08:55:06.895883 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jul 2 08:55:06.895943 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jul 2 08:55:06.896007 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jul 2 08:55:06.896017 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jul 2 08:55:06.896024 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jul 2 08:55:06.896032 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jul 2 08:55:06.896039 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jul 2 08:55:06.896046 kernel: iommu: Default domain type: Translated Jul 2 08:55:06.896053 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jul 2 08:55:06.896061 kernel: efivars: Registered efivars operations Jul 2 08:55:06.896068 kernel: vgaarb: loaded Jul 2 08:55:06.896077 kernel: clocksource: Switched to clocksource arch_sys_counter Jul 2 08:55:06.896084 kernel: VFS: Disk quotas dquot_6.6.0 Jul 2 08:55:06.896092 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 2 08:55:06.896099 kernel: pnp: PnP ACPI init Jul 2 08:55:06.896171 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jul 2 08:55:06.896182 kernel: pnp: PnP ACPI: found 1 devices Jul 2 08:55:06.896189 kernel: NET: Registered PF_INET protocol family Jul 2 08:55:06.896197 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 2 08:55:06.896207 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 2 08:55:06.896214 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 2 08:55:06.896222 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 2 08:55:06.896229 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 2 08:55:06.896236 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 2 08:55:06.896244 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 2 08:55:06.896251 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 2 08:55:06.896259 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 2 08:55:06.896266 kernel: PCI: CLS 0 bytes, default 64 Jul 2 08:55:06.896276 kernel: kvm [1]: HYP mode not available Jul 2 08:55:06.896284 kernel: Initialise system trusted keyrings Jul 2 08:55:06.896292 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 2 08:55:06.896299 kernel: Key type asymmetric registered Jul 2 08:55:06.896317 kernel: Asymmetric key parser 'x509' registered Jul 2 08:55:06.896325 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jul 2 08:55:06.896333 kernel: io scheduler mq-deadline registered Jul 2 08:55:06.896354 kernel: io scheduler kyber registered Jul 2 08:55:06.896361 kernel: io scheduler bfq registered Jul 2 08:55:06.896371 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jul 2 08:55:06.896379 kernel: ACPI: button: Power Button [PWRB] Jul 2 08:55:06.896387 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jul 2 08:55:06.896463 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jul 2 08:55:06.896473 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 2 08:55:06.896481 kernel: thunder_xcv, ver 1.0 Jul 2 08:55:06.896488 kernel: thunder_bgx, ver 1.0 Jul 2 08:55:06.896496 kernel: nicpf, ver 1.0 Jul 2 08:55:06.896503 kernel: nicvf, ver 1.0 Jul 2 08:55:06.896593 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jul 2 08:55:06.896662 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-07-02T08:55:06 UTC (1719910506) Jul 2 08:55:06.896672 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 2 08:55:06.896679 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Jul 2 08:55:06.896687 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jul 2 08:55:06.896695 kernel: watchdog: Hard watchdog permanently disabled Jul 2 08:55:06.896702 kernel: NET: Registered PF_INET6 protocol family Jul 2 08:55:06.896710 kernel: Segment Routing with IPv6 Jul 2 08:55:06.896720 kernel: In-situ OAM (IOAM) with IPv6 Jul 2 08:55:06.896742 kernel: NET: Registered PF_PACKET protocol family Jul 2 08:55:06.896749 kernel: Key type dns_resolver registered Jul 2 08:55:06.896756 kernel: registered taskstats version 1 Jul 2 08:55:06.896764 kernel: Loading compiled-in X.509 certificates Jul 2 08:55:06.896771 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.36-flatcar: 60660d9c77cbf90f55b5b3c47931cf5941193eaf' Jul 2 08:55:06.896778 kernel: Key type .fscrypt registered Jul 2 08:55:06.896786 kernel: Key type fscrypt-provisioning registered Jul 2 08:55:06.896793 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 2 08:55:06.896803 kernel: ima: Allocated hash algorithm: sha1 Jul 2 08:55:06.896810 kernel: ima: No architecture policies found Jul 2 08:55:06.896818 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jul 2 08:55:06.896825 kernel: clk: Disabling unused clocks Jul 2 08:55:06.896832 kernel: Freeing unused kernel memory: 39040K Jul 2 08:55:06.896840 kernel: Run /init as init process Jul 2 08:55:06.896848 kernel: with arguments: Jul 2 08:55:06.896855 kernel: /init Jul 2 08:55:06.896862 kernel: with environment: Jul 2 08:55:06.896871 kernel: HOME=/ Jul 2 08:55:06.896878 kernel: TERM=linux Jul 2 08:55:06.896886 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 2 08:55:06.896895 systemd[1]: systemd 255 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) Jul 2 08:55:06.896905 systemd[1]: Detected virtualization kvm. Jul 2 08:55:06.896913 systemd[1]: Detected architecture arm64. Jul 2 08:55:06.896921 systemd[1]: Running in initrd. Jul 2 08:55:06.896929 systemd[1]: No hostname configured, using default hostname. Jul 2 08:55:06.896938 systemd[1]: Hostname set to . Jul 2 08:55:06.896946 systemd[1]: Initializing machine ID from VM UUID. Jul 2 08:55:06.896954 systemd[1]: Queued start job for default target initrd.target. Jul 2 08:55:06.896962 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 2 08:55:06.896969 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 2 08:55:06.896978 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 2 08:55:06.896986 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 2 08:55:06.896994 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 2 08:55:06.897004 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 2 08:55:06.897014 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 2 08:55:06.897022 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 2 08:55:06.897030 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 2 08:55:06.897037 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 2 08:55:06.897045 systemd[1]: Reached target paths.target - Path Units. Jul 2 08:55:06.897055 systemd[1]: Reached target slices.target - Slice Units. Jul 2 08:55:06.897062 systemd[1]: Reached target swap.target - Swaps. Jul 2 08:55:06.897070 systemd[1]: Reached target timers.target - Timer Units. Jul 2 08:55:06.897078 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 2 08:55:06.897086 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 2 08:55:06.897094 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 2 08:55:06.897102 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jul 2 08:55:06.897109 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 2 08:55:06.897117 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 2 08:55:06.897127 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 2 08:55:06.897135 systemd[1]: Reached target sockets.target - Socket Units. Jul 2 08:55:06.897142 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 2 08:55:06.897150 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 2 08:55:06.897158 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 2 08:55:06.897165 systemd[1]: Starting systemd-fsck-usr.service... Jul 2 08:55:06.897173 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 2 08:55:06.897181 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 2 08:55:06.897189 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 2 08:55:06.897198 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 2 08:55:06.897206 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 2 08:55:06.897214 systemd[1]: Finished systemd-fsck-usr.service. Jul 2 08:55:06.897222 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 2 08:55:06.897247 systemd-journald[236]: Collecting audit messages is disabled. Jul 2 08:55:06.897266 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 2 08:55:06.897275 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 2 08:55:06.897283 systemd-journald[236]: Journal started Jul 2 08:55:06.897379 systemd-journald[236]: Runtime Journal (/run/log/journal/b645bd6b0dc54d38aef13006b19112ea) is 5.9M, max 47.3M, 41.4M free. Jul 2 08:55:06.888622 systemd-modules-load[237]: Inserted module 'overlay' Jul 2 08:55:06.899356 systemd[1]: Started systemd-journald.service - Journal Service. Jul 2 08:55:06.900604 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 2 08:55:06.904002 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 2 08:55:06.908163 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 2 08:55:06.908191 kernel: Bridge firewalling registered Jul 2 08:55:06.905624 systemd-modules-load[237]: Inserted module 'br_netfilter' Jul 2 08:55:06.906390 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Jul 2 08:55:06.907478 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 2 08:55:06.910797 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 2 08:55:06.917169 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 2 08:55:06.921611 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 2 08:55:06.922718 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Jul 2 08:55:06.926536 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 2 08:55:06.936456 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 2 08:55:06.939127 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 2 08:55:06.948763 dracut-cmdline[277]: dracut-dracut-053 Jul 2 08:55:06.951134 dracut-cmdline[277]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=339cf548fbb7b0074109371a653774e9fabae27ff3a90e4c67dbbb2f78376930 Jul 2 08:55:06.966795 systemd-resolved[279]: Positive Trust Anchors: Jul 2 08:55:06.966812 systemd-resolved[279]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 2 08:55:06.966842 systemd-resolved[279]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa corp home internal intranet lan local private test Jul 2 08:55:06.971491 systemd-resolved[279]: Defaulting to hostname 'linux'. Jul 2 08:55:06.972429 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 2 08:55:06.973496 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 2 08:55:07.018345 kernel: SCSI subsystem initialized Jul 2 08:55:07.023326 kernel: Loading iSCSI transport class v2.0-870. Jul 2 08:55:07.031329 kernel: iscsi: registered transport (tcp) Jul 2 08:55:07.044341 kernel: iscsi: registered transport (qla4xxx) Jul 2 08:55:07.044358 kernel: QLogic iSCSI HBA Driver Jul 2 08:55:07.085938 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 2 08:55:07.103444 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 2 08:55:07.120800 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 2 08:55:07.120853 kernel: device-mapper: uevent: version 1.0.3 Jul 2 08:55:07.120864 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jul 2 08:55:07.168333 kernel: raid6: neonx8 gen() 15751 MB/s Jul 2 08:55:07.185327 kernel: raid6: neonx4 gen() 15660 MB/s Jul 2 08:55:07.202328 kernel: raid6: neonx2 gen() 13255 MB/s Jul 2 08:55:07.219327 kernel: raid6: neonx1 gen() 10470 MB/s Jul 2 08:55:07.236318 kernel: raid6: int64x8 gen() 6946 MB/s Jul 2 08:55:07.253317 kernel: raid6: int64x4 gen() 7334 MB/s Jul 2 08:55:07.270324 kernel: raid6: int64x2 gen() 6123 MB/s Jul 2 08:55:07.287315 kernel: raid6: int64x1 gen() 5053 MB/s Jul 2 08:55:07.287329 kernel: raid6: using algorithm neonx8 gen() 15751 MB/s Jul 2 08:55:07.304334 kernel: raid6: .... xor() 11926 MB/s, rmw enabled Jul 2 08:55:07.304365 kernel: raid6: using neon recovery algorithm Jul 2 08:55:07.309589 kernel: xor: measuring software checksum speed Jul 2 08:55:07.309606 kernel: 8regs : 19864 MB/sec Jul 2 08:55:07.310455 kernel: 32regs : 19711 MB/sec Jul 2 08:55:07.311653 kernel: arm64_neon : 27215 MB/sec Jul 2 08:55:07.311676 kernel: xor: using function: arm64_neon (27215 MB/sec) Jul 2 08:55:07.363330 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 2 08:55:07.374121 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 2 08:55:07.386475 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 2 08:55:07.397772 systemd-udevd[463]: Using default interface naming scheme 'v255'. Jul 2 08:55:07.400849 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 2 08:55:07.414464 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 2 08:55:07.425521 dracut-pre-trigger[470]: rd.md=0: removing MD RAID activation Jul 2 08:55:07.452357 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 2 08:55:07.466497 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 2 08:55:07.505324 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 2 08:55:07.514474 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 2 08:55:07.524882 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 2 08:55:07.526773 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 2 08:55:07.528136 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 2 08:55:07.529735 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 2 08:55:07.536516 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 2 08:55:07.548367 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 2 08:55:07.551340 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Jul 2 08:55:07.568409 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jul 2 08:55:07.568511 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 2 08:55:07.562045 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 2 08:55:07.562163 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 2 08:55:07.564078 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 2 08:55:07.564929 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 2 08:55:07.565063 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 2 08:55:07.565915 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 2 08:55:07.576558 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 2 08:55:07.586246 kernel: BTRFS: device fsid ad4b0605-c88d-4cc1-aa96-32e9393058b1 devid 1 transid 34 /dev/vda3 scanned by (udev-worker) (524) Jul 2 08:55:07.589342 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (519) Jul 2 08:55:07.590577 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jul 2 08:55:07.593347 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 2 08:55:07.597904 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jul 2 08:55:07.606764 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jul 2 08:55:07.607729 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jul 2 08:55:07.613537 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 2 08:55:07.629442 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 2 08:55:07.631058 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 2 08:55:07.637342 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 2 08:55:07.661585 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 2 08:55:08.652320 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 2 08:55:08.652618 disk-uuid[552]: The operation has completed successfully. Jul 2 08:55:08.674960 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 2 08:55:08.675068 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 2 08:55:08.696452 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 2 08:55:08.699136 sh[575]: Success Jul 2 08:55:08.715322 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jul 2 08:55:08.742871 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 2 08:55:08.754618 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 2 08:55:08.757341 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 2 08:55:08.772406 kernel: BTRFS info (device dm-0): first mount of filesystem ad4b0605-c88d-4cc1-aa96-32e9393058b1 Jul 2 08:55:08.772447 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jul 2 08:55:08.772465 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jul 2 08:55:08.772476 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jul 2 08:55:08.772486 kernel: BTRFS info (device dm-0): using free space tree Jul 2 08:55:08.777655 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 2 08:55:08.778692 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 2 08:55:08.792433 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 2 08:55:08.794003 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 2 08:55:08.801940 kernel: BTRFS info (device vda6): first mount of filesystem d4c1a64e-1f65-4195-ac94-8abb45f4a96e Jul 2 08:55:08.801974 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 2 08:55:08.801985 kernel: BTRFS info (device vda6): using free space tree Jul 2 08:55:08.805426 kernel: BTRFS info (device vda6): auto enabling async discard Jul 2 08:55:08.813605 systemd[1]: mnt-oem.mount: Deactivated successfully. Jul 2 08:55:08.818218 kernel: BTRFS info (device vda6): last unmount of filesystem d4c1a64e-1f65-4195-ac94-8abb45f4a96e Jul 2 08:55:08.824917 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 2 08:55:08.831470 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 2 08:55:08.898665 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 2 08:55:08.916643 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 2 08:55:08.928480 ignition[676]: Ignition 2.18.0 Jul 2 08:55:08.928490 ignition[676]: Stage: fetch-offline Jul 2 08:55:08.928522 ignition[676]: no configs at "/usr/lib/ignition/base.d" Jul 2 08:55:08.928529 ignition[676]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 2 08:55:08.928630 ignition[676]: parsed url from cmdline: "" Jul 2 08:55:08.928633 ignition[676]: no config URL provided Jul 2 08:55:08.928641 ignition[676]: reading system config file "/usr/lib/ignition/user.ign" Jul 2 08:55:08.928648 ignition[676]: no config at "/usr/lib/ignition/user.ign" Jul 2 08:55:08.928672 ignition[676]: op(1): [started] loading QEMU firmware config module Jul 2 08:55:08.928676 ignition[676]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 2 08:55:08.944035 ignition[676]: op(1): [finished] loading QEMU firmware config module Jul 2 08:55:08.947497 ignition[676]: parsing config with SHA512: db671598689d91d82921c1596278c5347fbef6cd5dd9ddb158c662e727f4a7e76a2ab4282478e2348ee1e29b8b57b4d1b022149856de5b78e892f3313a9f9cdc Jul 2 08:55:08.948082 systemd-networkd[765]: lo: Link UP Jul 2 08:55:08.948091 systemd-networkd[765]: lo: Gained carrier Jul 2 08:55:08.948786 systemd-networkd[765]: Enumeration completed Jul 2 08:55:08.948872 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 2 08:55:08.949171 systemd-networkd[765]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 2 08:55:08.949174 systemd-networkd[765]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 2 08:55:08.953805 ignition[676]: fetch-offline: fetch-offline passed Jul 2 08:55:08.949850 systemd-networkd[765]: eth0: Link UP Jul 2 08:55:08.953955 ignition[676]: Ignition finished successfully Jul 2 08:55:08.949852 systemd-networkd[765]: eth0: Gained carrier Jul 2 08:55:08.949859 systemd-networkd[765]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 2 08:55:08.950424 systemd[1]: Reached target network.target - Network. Jul 2 08:55:08.953589 unknown[676]: fetched base config from "system" Jul 2 08:55:08.953596 unknown[676]: fetched user config from "qemu" Jul 2 08:55:08.956112 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 2 08:55:08.957451 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 2 08:55:08.965469 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 2 08:55:08.975378 systemd-networkd[765]: eth0: DHCPv4 address 10.0.0.16/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 2 08:55:08.978056 ignition[771]: Ignition 2.18.0 Jul 2 08:55:08.978067 ignition[771]: Stage: kargs Jul 2 08:55:08.978219 ignition[771]: no configs at "/usr/lib/ignition/base.d" Jul 2 08:55:08.978229 ignition[771]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 2 08:55:08.978845 ignition[771]: kargs: kargs passed Jul 2 08:55:08.982364 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 2 08:55:08.978891 ignition[771]: Ignition finished successfully Jul 2 08:55:08.984769 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 2 08:55:08.997592 ignition[780]: Ignition 2.18.0 Jul 2 08:55:08.997602 ignition[780]: Stage: disks Jul 2 08:55:08.997747 ignition[780]: no configs at "/usr/lib/ignition/base.d" Jul 2 08:55:08.997756 ignition[780]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 2 08:55:08.998362 ignition[780]: disks: disks passed Jul 2 08:55:08.998401 ignition[780]: Ignition finished successfully Jul 2 08:55:09.001986 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 2 08:55:09.004128 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 2 08:55:09.006403 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 2 08:55:09.007922 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 2 08:55:09.009759 systemd[1]: Reached target sysinit.target - System Initialization. Jul 2 08:55:09.011241 systemd[1]: Reached target basic.target - Basic System. Jul 2 08:55:09.024490 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 2 08:55:09.032474 systemd-resolved[279]: Detected conflict on linux IN A 10.0.0.16 Jul 2 08:55:09.032488 systemd-resolved[279]: Hostname conflict, changing published hostname from 'linux' to 'linux11'. Jul 2 08:55:09.034923 systemd-fsck[791]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jul 2 08:55:09.037607 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 2 08:55:09.050442 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 2 08:55:09.092325 kernel: EXT4-fs (vda9): mounted filesystem c1692a6b-74d8-4bda-be0c-9d706985f1ed r/w with ordered data mode. Quota mode: none. Jul 2 08:55:09.092516 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 2 08:55:09.093642 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 2 08:55:09.110388 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 2 08:55:09.111934 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 2 08:55:09.113052 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 2 08:55:09.113137 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 2 08:55:09.113165 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 2 08:55:09.119069 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (799) Jul 2 08:55:09.119047 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 2 08:55:09.120372 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 2 08:55:09.123784 kernel: BTRFS info (device vda6): first mount of filesystem d4c1a64e-1f65-4195-ac94-8abb45f4a96e Jul 2 08:55:09.123802 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 2 08:55:09.123812 kernel: BTRFS info (device vda6): using free space tree Jul 2 08:55:09.126322 kernel: BTRFS info (device vda6): auto enabling async discard Jul 2 08:55:09.127439 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 2 08:55:09.164296 initrd-setup-root[823]: cut: /sysroot/etc/passwd: No such file or directory Jul 2 08:55:09.168233 initrd-setup-root[830]: cut: /sysroot/etc/group: No such file or directory Jul 2 08:55:09.172018 initrd-setup-root[837]: cut: /sysroot/etc/shadow: No such file or directory Jul 2 08:55:09.175943 initrd-setup-root[844]: cut: /sysroot/etc/gshadow: No such file or directory Jul 2 08:55:09.244664 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 2 08:55:09.249407 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 2 08:55:09.250716 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 2 08:55:09.256327 kernel: BTRFS info (device vda6): last unmount of filesystem d4c1a64e-1f65-4195-ac94-8abb45f4a96e Jul 2 08:55:09.268633 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 2 08:55:09.273493 ignition[913]: INFO : Ignition 2.18.0 Jul 2 08:55:09.273493 ignition[913]: INFO : Stage: mount Jul 2 08:55:09.274842 ignition[913]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 2 08:55:09.274842 ignition[913]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 2 08:55:09.274842 ignition[913]: INFO : mount: mount passed Jul 2 08:55:09.274842 ignition[913]: INFO : Ignition finished successfully Jul 2 08:55:09.275589 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 2 08:55:09.283420 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 2 08:55:09.770262 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 2 08:55:09.787480 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 2 08:55:09.793587 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (927) Jul 2 08:55:09.793624 kernel: BTRFS info (device vda6): first mount of filesystem d4c1a64e-1f65-4195-ac94-8abb45f4a96e Jul 2 08:55:09.794325 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 2 08:55:09.794340 kernel: BTRFS info (device vda6): using free space tree Jul 2 08:55:09.796323 kernel: BTRFS info (device vda6): auto enabling async discard Jul 2 08:55:09.797647 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 2 08:55:09.820036 ignition[944]: INFO : Ignition 2.18.0 Jul 2 08:55:09.820036 ignition[944]: INFO : Stage: files Jul 2 08:55:09.821623 ignition[944]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 2 08:55:09.821623 ignition[944]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 2 08:55:09.821623 ignition[944]: DEBUG : files: compiled without relabeling support, skipping Jul 2 08:55:09.824765 ignition[944]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 2 08:55:09.824765 ignition[944]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 2 08:55:09.824765 ignition[944]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 2 08:55:09.824765 ignition[944]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 2 08:55:09.829844 ignition[944]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 2 08:55:09.829844 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 2 08:55:09.829844 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 2 08:55:09.829844 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" Jul 2 08:55:09.829844 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" Jul 2 08:55:09.829844 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" Jul 2 08:55:09.829844 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" Jul 2 08:55:09.829844 ignition[944]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Jul 2 08:55:09.829844 ignition[944]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 2 08:55:09.829844 ignition[944]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 2 08:55:09.829844 ignition[944]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Jul 2 08:55:09.829844 ignition[944]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Jul 2 08:55:09.824818 unknown[944]: wrote ssh authorized keys file for user: core Jul 2 08:55:09.851174 ignition[944]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 2 08:55:09.853477 ignition[944]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 2 08:55:09.855447 ignition[944]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Jul 2 08:55:09.855447 ignition[944]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 2 08:55:09.855447 ignition[944]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 2 08:55:09.855447 ignition[944]: INFO : files: files passed Jul 2 08:55:09.855447 ignition[944]: INFO : Ignition finished successfully Jul 2 08:55:09.856054 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 2 08:55:09.867473 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 2 08:55:09.868970 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 2 08:55:09.870864 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 2 08:55:09.871346 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 2 08:55:09.877402 initrd-setup-root-after-ignition[973]: grep: /sysroot/oem/oem-release: No such file or directory Jul 2 08:55:09.880857 initrd-setup-root-after-ignition[975]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 2 08:55:09.880857 initrd-setup-root-after-ignition[975]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 2 08:55:09.883935 initrd-setup-root-after-ignition[979]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 2 08:55:09.885863 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 2 08:55:09.887050 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 2 08:55:09.893473 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 2 08:55:09.912944 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 2 08:55:09.913059 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 2 08:55:09.914858 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 2 08:55:09.916341 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 2 08:55:09.917814 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 2 08:55:09.918621 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 2 08:55:09.933977 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 2 08:55:09.936125 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 2 08:55:09.947789 systemd[1]: Stopped target network.target - Network. Jul 2 08:55:09.948541 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 2 08:55:09.949973 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 2 08:55:09.951630 systemd[1]: Stopped target timers.target - Timer Units. Jul 2 08:55:09.953090 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 2 08:55:09.953211 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 2 08:55:09.955368 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 2 08:55:09.957009 systemd[1]: Stopped target basic.target - Basic System. Jul 2 08:55:09.958359 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 2 08:55:09.959729 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 2 08:55:09.961218 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 2 08:55:09.962979 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 2 08:55:09.964537 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 2 08:55:09.966161 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 2 08:55:09.967699 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 2 08:55:09.969061 systemd[1]: Stopped target swap.target - Swaps. Jul 2 08:55:09.970314 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 2 08:55:09.970442 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 2 08:55:09.972387 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 2 08:55:09.973972 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 2 08:55:09.975485 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 2 08:55:09.975590 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 2 08:55:09.977243 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 2 08:55:09.977365 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 2 08:55:09.980001 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 2 08:55:09.980120 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 2 08:55:09.981859 systemd[1]: Stopped target paths.target - Path Units. Jul 2 08:55:09.983130 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 2 08:55:09.986376 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 2 08:55:09.987329 systemd[1]: Stopped target slices.target - Slice Units. Jul 2 08:55:09.988894 systemd[1]: Stopped target sockets.target - Socket Units. Jul 2 08:55:09.990121 systemd[1]: iscsid.socket: Deactivated successfully. Jul 2 08:55:09.990210 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 2 08:55:09.991347 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 2 08:55:09.991428 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 2 08:55:09.992588 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 2 08:55:09.992694 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 2 08:55:09.994069 systemd[1]: ignition-files.service: Deactivated successfully. Jul 2 08:55:09.994162 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 2 08:55:10.006462 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 2 08:55:10.007121 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 2 08:55:10.007241 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 2 08:55:10.009983 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 2 08:55:10.011385 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 2 08:55:10.013038 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 2 08:55:10.014383 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 2 08:55:10.015752 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 2 08:55:10.017391 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 2 08:55:10.017524 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 2 08:55:10.022264 ignition[1000]: INFO : Ignition 2.18.0 Jul 2 08:55:10.022264 ignition[1000]: INFO : Stage: umount Jul 2 08:55:10.022264 ignition[1000]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 2 08:55:10.022264 ignition[1000]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 2 08:55:10.022264 ignition[1000]: INFO : umount: umount passed Jul 2 08:55:10.022264 ignition[1000]: INFO : Ignition finished successfully Jul 2 08:55:10.021391 systemd-networkd[765]: eth0: DHCPv6 lease lost Jul 2 08:55:10.022621 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 2 08:55:10.022716 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 2 08:55:10.027623 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 2 08:55:10.028163 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 2 08:55:10.028286 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 2 08:55:10.030066 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 2 08:55:10.030233 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 2 08:55:10.031473 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 2 08:55:10.031576 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 2 08:55:10.034298 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 2 08:55:10.034420 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 2 08:55:10.037298 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 2 08:55:10.039360 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 2 08:55:10.040738 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 2 08:55:10.040782 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 2 08:55:10.042152 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 2 08:55:10.042195 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 2 08:55:10.043879 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 2 08:55:10.043924 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 2 08:55:10.045257 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 2 08:55:10.045292 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 2 08:55:10.046929 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 2 08:55:10.046974 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 2 08:55:10.065427 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 2 08:55:10.066096 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 2 08:55:10.066155 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 2 08:55:10.067841 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 2 08:55:10.067885 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 2 08:55:10.069332 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 2 08:55:10.069374 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 2 08:55:10.071173 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 2 08:55:10.071213 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Jul 2 08:55:10.072838 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 2 08:55:10.083041 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 2 08:55:10.083156 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 2 08:55:10.084910 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 2 08:55:10.085034 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 2 08:55:10.086923 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 2 08:55:10.086986 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 2 08:55:10.088886 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 2 08:55:10.088916 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 2 08:55:10.090404 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 2 08:55:10.090449 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 2 08:55:10.092748 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 2 08:55:10.092787 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 2 08:55:10.094514 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 2 08:55:10.094569 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 2 08:55:10.097597 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 2 08:55:10.098413 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 2 08:55:10.098466 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 2 08:55:10.099936 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 2 08:55:10.099975 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 2 08:55:10.106803 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 2 08:55:10.108296 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 2 08:55:10.110249 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 2 08:55:10.112568 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 2 08:55:10.121806 systemd[1]: Switching root. Jul 2 08:55:10.148327 systemd-journald[236]: Journal stopped Jul 2 08:55:10.765382 systemd-journald[236]: Received SIGTERM from PID 1 (systemd). Jul 2 08:55:10.765446 kernel: SELinux: policy capability network_peer_controls=1 Jul 2 08:55:10.765459 kernel: SELinux: policy capability open_perms=1 Jul 2 08:55:10.765469 kernel: SELinux: policy capability extended_socket_class=1 Jul 2 08:55:10.765483 kernel: SELinux: policy capability always_check_network=0 Jul 2 08:55:10.765493 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 2 08:55:10.765507 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 2 08:55:10.765517 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 2 08:55:10.765526 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 2 08:55:10.765536 kernel: audit: type=1403 audit(1719910510.210:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 2 08:55:10.765561 systemd[1]: Successfully loaded SELinux policy in 33.188ms. Jul 2 08:55:10.765588 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.407ms. Jul 2 08:55:10.765600 systemd[1]: systemd 255 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) Jul 2 08:55:10.765612 systemd[1]: Detected virtualization kvm. Jul 2 08:55:10.765623 systemd[1]: Detected architecture arm64. Jul 2 08:55:10.765634 systemd[1]: Detected first boot. Jul 2 08:55:10.765644 systemd[1]: Initializing machine ID from VM UUID. Jul 2 08:55:10.765654 zram_generator::config[1043]: No configuration found. Jul 2 08:55:10.765668 systemd[1]: Populated /etc with preset unit settings. Jul 2 08:55:10.765679 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 2 08:55:10.765689 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 2 08:55:10.765699 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 2 08:55:10.765711 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 2 08:55:10.765722 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 2 08:55:10.765734 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 2 08:55:10.765745 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 2 08:55:10.765756 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 2 08:55:10.765768 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 2 08:55:10.765779 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 2 08:55:10.765790 systemd[1]: Created slice user.slice - User and Session Slice. Jul 2 08:55:10.765800 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 2 08:55:10.765811 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 2 08:55:10.765825 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 2 08:55:10.765837 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 2 08:55:10.765848 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 2 08:55:10.765858 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 2 08:55:10.765869 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jul 2 08:55:10.765880 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 2 08:55:10.765891 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 2 08:55:10.765901 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 2 08:55:10.765913 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 2 08:55:10.765926 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 2 08:55:10.765937 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 2 08:55:10.765948 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 2 08:55:10.765975 systemd[1]: Reached target slices.target - Slice Units. Jul 2 08:55:10.765986 systemd[1]: Reached target swap.target - Swaps. Jul 2 08:55:10.765996 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 2 08:55:10.766008 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 2 08:55:10.766019 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 2 08:55:10.766032 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 2 08:55:10.766043 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 2 08:55:10.766053 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 2 08:55:10.766064 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 2 08:55:10.766074 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 2 08:55:10.766085 systemd[1]: Mounting media.mount - External Media Directory... Jul 2 08:55:10.766096 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 2 08:55:10.766107 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 2 08:55:10.766117 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 2 08:55:10.766131 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jul 2 08:55:10.766143 systemd[1]: Reached target machines.target - Containers. Jul 2 08:55:10.766153 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 2 08:55:10.766164 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 2 08:55:10.766175 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 2 08:55:10.766186 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 2 08:55:10.766197 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 2 08:55:10.766207 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 2 08:55:10.766220 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 2 08:55:10.766231 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 2 08:55:10.766242 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 2 08:55:10.766255 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 2 08:55:10.766266 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 2 08:55:10.766277 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 2 08:55:10.766288 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 2 08:55:10.766298 kernel: fuse: init (API version 7.39) Jul 2 08:55:10.766403 systemd[1]: Stopped systemd-fsck-usr.service. Jul 2 08:55:10.766418 kernel: loop: module loaded Jul 2 08:55:10.766428 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 2 08:55:10.766438 kernel: ACPI: bus type drm_connector registered Jul 2 08:55:10.766449 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 2 08:55:10.766460 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 2 08:55:10.766470 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 2 08:55:10.766481 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 2 08:55:10.766491 systemd[1]: verity-setup.service: Deactivated successfully. Jul 2 08:55:10.766502 systemd[1]: Stopped verity-setup.service. Jul 2 08:55:10.766515 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 2 08:55:10.766526 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 2 08:55:10.766536 systemd[1]: Mounted media.mount - External Media Directory. Jul 2 08:55:10.766547 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 2 08:55:10.766585 systemd-journald[1110]: Collecting audit messages is disabled. Jul 2 08:55:10.766608 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 2 08:55:10.766619 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 2 08:55:10.766631 systemd-journald[1110]: Journal started Jul 2 08:55:10.766652 systemd-journald[1110]: Runtime Journal (/run/log/journal/b645bd6b0dc54d38aef13006b19112ea) is 5.9M, max 47.3M, 41.4M free. Jul 2 08:55:10.568346 systemd[1]: Queued start job for default target multi-user.target. Jul 2 08:55:10.585205 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jul 2 08:55:10.585569 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 2 08:55:10.769329 systemd[1]: Started systemd-journald.service - Journal Service. Jul 2 08:55:10.771347 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 2 08:55:10.772527 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 2 08:55:10.773794 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 2 08:55:10.773949 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 2 08:55:10.775175 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 2 08:55:10.775320 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 2 08:55:10.776569 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 2 08:55:10.776711 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 2 08:55:10.777987 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 2 08:55:10.778116 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 2 08:55:10.780648 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 2 08:55:10.780794 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 2 08:55:10.782065 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 2 08:55:10.782196 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 2 08:55:10.784673 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 2 08:55:10.786049 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 2 08:55:10.787271 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 2 08:55:10.799731 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 2 08:55:10.816444 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 2 08:55:10.818378 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 2 08:55:10.819298 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 2 08:55:10.819353 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 2 08:55:10.821120 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jul 2 08:55:10.823071 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 2 08:55:10.824936 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 2 08:55:10.825819 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 2 08:55:10.828500 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 2 08:55:10.830390 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 2 08:55:10.831415 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 2 08:55:10.832474 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 2 08:55:10.835071 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 2 08:55:10.837133 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 2 08:55:10.839300 systemd-journald[1110]: Time spent on flushing to /var/log/journal/b645bd6b0dc54d38aef13006b19112ea is 27.119ms for 824 entries. Jul 2 08:55:10.839300 systemd-journald[1110]: System Journal (/var/log/journal/b645bd6b0dc54d38aef13006b19112ea) is 8.0M, max 195.6M, 187.6M free. Jul 2 08:55:10.870941 systemd-journald[1110]: Received client request to flush runtime journal. Jul 2 08:55:10.840543 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 2 08:55:10.845354 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 2 08:55:10.849513 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 2 08:55:10.850815 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 2 08:55:10.852048 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 2 08:55:10.855864 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 2 08:55:10.857165 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 2 08:55:10.862759 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 2 08:55:10.865736 (sd-merge)[1165]: No extensions found. Jul 2 08:55:10.874559 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jul 2 08:55:10.877067 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jul 2 08:55:10.881716 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 2 08:55:10.883185 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 2 08:55:10.884371 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 2 08:55:10.887123 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 2 08:55:10.891246 systemd[1]: Starting ensure-sysext.service... Jul 2 08:55:10.893287 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 2 08:55:10.897543 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Jul 2 08:55:10.906894 udevadm[1168]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jul 2 08:55:10.910441 systemd[1]: Reloading requested from client PID 1173 ('systemctl') (unit ensure-sysext.service)... Jul 2 08:55:10.910458 systemd[1]: Reloading... Jul 2 08:55:10.935856 systemd-tmpfiles[1175]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 2 08:55:10.936281 systemd-tmpfiles[1175]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 2 08:55:10.937490 systemd-tmpfiles[1175]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 2 08:55:10.941514 systemd-tmpfiles[1174]: ACLs are not supported, ignoring. Jul 2 08:55:10.941531 systemd-tmpfiles[1174]: ACLs are not supported, ignoring. Jul 2 08:55:10.942526 systemd-tmpfiles[1175]: ACLs are not supported, ignoring. Jul 2 08:55:10.942597 systemd-tmpfiles[1175]: ACLs are not supported, ignoring. Jul 2 08:55:10.947266 systemd-tmpfiles[1175]: Detected autofs mount point /boot during canonicalization of boot. Jul 2 08:55:10.947277 systemd-tmpfiles[1175]: Skipping /boot Jul 2 08:55:10.956765 systemd-tmpfiles[1175]: Detected autofs mount point /boot during canonicalization of boot. Jul 2 08:55:10.956778 systemd-tmpfiles[1175]: Skipping /boot Jul 2 08:55:10.973339 zram_generator::config[1204]: No configuration found. Jul 2 08:55:11.089653 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 2 08:55:11.089816 systemd[1]: Reloading finished in 179 ms. Jul 2 08:55:11.103263 ldconfig[1150]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 2 08:55:11.110088 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 2 08:55:11.112331 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jul 2 08:55:11.125674 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 2 08:55:11.126951 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Jul 2 08:55:11.135215 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jul 2 08:55:11.137237 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 2 08:55:11.139565 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 2 08:55:11.143612 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 2 08:55:11.145493 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 2 08:55:11.147995 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 2 08:55:11.153546 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 2 08:55:11.155370 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 2 08:55:11.158599 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 2 08:55:11.159392 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 2 08:55:11.166624 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 2 08:55:11.167869 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 2 08:55:11.168026 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 2 08:55:11.170058 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 2 08:55:11.170186 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 2 08:55:11.176471 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 2 08:55:11.176631 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 2 08:55:11.181175 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 2 08:55:11.184428 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 2 08:55:11.188347 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 2 08:55:11.189185 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 2 08:55:11.189873 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 2 08:55:11.191195 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 2 08:55:11.192602 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 2 08:55:11.194003 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 2 08:55:11.194118 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 2 08:55:11.205125 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 2 08:55:11.207018 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 2 08:55:11.211517 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 2 08:55:11.213145 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 2 08:55:11.214174 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 2 08:55:11.214334 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jul 2 08:55:11.215041 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 2 08:55:11.215191 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 2 08:55:11.216548 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 2 08:55:11.216673 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 2 08:55:11.219190 systemd[1]: Finished ensure-sysext.service. Jul 2 08:55:11.220543 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 2 08:55:11.223000 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 2 08:55:11.229493 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jul 2 08:55:11.230841 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 2 08:55:11.230989 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 2 08:55:11.233047 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 2 08:55:11.234540 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 2 08:55:11.234683 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 2 08:55:11.240221 augenrules[1287]: No rules Jul 2 08:55:11.242572 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jul 2 08:55:11.272512 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jul 2 08:55:11.273623 systemd[1]: Reached target time-set.target - System Time Set. Jul 2 08:55:11.275906 systemd-resolved[1247]: Positive Trust Anchors: Jul 2 08:55:11.276172 systemd-resolved[1247]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 2 08:55:11.276244 systemd-resolved[1247]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa corp home internal intranet lan local private test Jul 2 08:55:11.281935 systemd-resolved[1247]: Defaulting to hostname 'linux'. Jul 2 08:55:11.283360 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 2 08:55:11.284320 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 2 08:55:11.364352 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 2 08:55:11.378465 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 2 08:55:11.380388 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 2 08:55:11.391491 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 2 08:55:11.395899 systemd-udevd[1298]: Using default interface naming scheme 'v255'. Jul 2 08:55:11.408607 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 2 08:55:11.417559 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 2 08:55:11.443359 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1318) Jul 2 08:55:11.443438 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (1314) Jul 2 08:55:11.445143 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jul 2 08:55:11.484516 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 2 08:55:11.487331 systemd-networkd[1308]: lo: Link UP Jul 2 08:55:11.487339 systemd-networkd[1308]: lo: Gained carrier Jul 2 08:55:11.489834 systemd-networkd[1308]: Enumeration completed Jul 2 08:55:11.491480 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 2 08:55:11.492555 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 2 08:55:11.493559 systemd[1]: Reached target network.target - Network. Jul 2 08:55:11.494063 systemd-networkd[1308]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 2 08:55:11.494067 systemd-networkd[1308]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 2 08:55:11.496504 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 2 08:55:11.496602 systemd-networkd[1308]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 2 08:55:11.496627 systemd-networkd[1308]: eth0: Link UP Jul 2 08:55:11.496629 systemd-networkd[1308]: eth0: Gained carrier Jul 2 08:55:11.496637 systemd-networkd[1308]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 2 08:55:11.507867 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 2 08:55:11.512370 systemd-networkd[1308]: eth0: DHCPv4 address 10.0.0.16/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 2 08:55:11.513025 systemd-timesyncd[1286]: Network configuration changed, trying to establish connection. Jul 2 08:55:11.513870 systemd-timesyncd[1286]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 2 08:55:11.513991 systemd-timesyncd[1286]: Initial clock synchronization to Tue 2024-07-02 08:55:11.538985 UTC. Jul 2 08:55:11.532543 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 2 08:55:11.543342 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jul 2 08:55:11.545562 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jul 2 08:55:11.575316 lvm[1338]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 2 08:55:11.584616 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 2 08:55:11.603569 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jul 2 08:55:11.604747 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 2 08:55:11.606409 systemd[1]: Reached target sysinit.target - System Initialization. Jul 2 08:55:11.607251 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 2 08:55:11.608203 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 2 08:55:11.609371 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 2 08:55:11.610250 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 2 08:55:11.611204 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 2 08:55:11.612107 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 2 08:55:11.612138 systemd[1]: Reached target paths.target - Path Units. Jul 2 08:55:11.612786 systemd[1]: Reached target timers.target - Timer Units. Jul 2 08:55:11.614119 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 2 08:55:11.629086 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 2 08:55:11.629911 systemd[1]: Reached target sockets.target - Socket Units. Jul 2 08:55:11.630593 systemd[1]: Reached target basic.target - Basic System. Jul 2 08:55:11.631253 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 2 08:55:11.631290 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 2 08:55:11.632463 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 2 08:55:11.634068 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 2 08:55:11.635856 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 2 08:55:11.636606 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Jul 2 08:55:11.637774 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jul 2 08:55:11.642502 jq[1345]: false Jul 2 08:55:11.642697 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 2 08:55:11.646100 lvm[1347]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 2 08:55:11.646479 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 2 08:55:11.652388 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 2 08:55:11.657578 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 2 08:55:11.661518 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 2 08:55:11.661921 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 2 08:55:11.662873 systemd[1]: Starting update-engine.service - Update Engine... Jul 2 08:55:11.665398 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 2 08:55:11.665956 dbus-daemon[1344]: [system] SELinux support is enabled Jul 2 08:55:11.667927 extend-filesystems[1346]: Found vda Jul 2 08:55:11.667927 extend-filesystems[1346]: Found vda1 Jul 2 08:55:11.667927 extend-filesystems[1346]: Found vda2 Jul 2 08:55:11.667927 extend-filesystems[1346]: Found vda3 Jul 2 08:55:11.667927 extend-filesystems[1346]: Found usr Jul 2 08:55:11.667927 extend-filesystems[1346]: Found vda4 Jul 2 08:55:11.667927 extend-filesystems[1346]: Found vda6 Jul 2 08:55:11.667927 extend-filesystems[1346]: Found vda7 Jul 2 08:55:11.667927 extend-filesystems[1346]: Found vda9 Jul 2 08:55:11.667927 extend-filesystems[1346]: Checking size of /dev/vda9 Jul 2 08:55:11.666994 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 2 08:55:11.670075 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 2 08:55:11.681218 jq[1361]: true Jul 2 08:55:11.671355 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 2 08:55:11.671640 systemd[1]: motdgen.service: Deactivated successfully. Jul 2 08:55:11.671779 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 2 08:55:11.672880 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 2 08:55:11.673003 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 2 08:55:11.677153 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Jul 2 08:55:11.677199 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 2 08:55:11.678901 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jul 2 08:55:11.678917 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 2 08:55:11.680649 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jul 2 08:55:11.692423 extend-filesystems[1346]: Old size kept for /dev/vda9 Jul 2 08:55:11.693063 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 2 08:55:11.693230 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 2 08:55:11.700352 jq[1369]: true Jul 2 08:55:11.715007 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (1306) Jul 2 08:55:11.721105 update_engine[1360]: I0702 08:55:11.720913 1360 main.cc:92] Flatcar Update Engine starting Jul 2 08:55:11.723042 systemd-logind[1358]: Watching system buttons on /dev/input/event0 (Power Button) Jul 2 08:55:11.723765 systemd-logind[1358]: New seat seat0. Jul 2 08:55:11.725067 update_engine[1360]: I0702 08:55:11.725034 1360 update_check_scheduler.cc:74] Next update check in 5m7s Jul 2 08:55:11.725337 systemd[1]: Started update-engine.service - Update Engine. Jul 2 08:55:11.728697 systemd[1]: Started systemd-logind.service - User Login Management. Jul 2 08:55:11.736580 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 2 08:55:11.748268 bash[1391]: Updated "/home/core/.ssh/authorized_keys" Jul 2 08:55:11.749963 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 2 08:55:11.751836 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 2 08:55:11.761189 locksmithd[1387]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 2 08:55:12.485043 sshd_keygen[1362]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 2 08:55:12.505344 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 2 08:55:12.519532 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 2 08:55:12.524538 systemd[1]: issuegen.service: Deactivated successfully. Jul 2 08:55:12.526339 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 2 08:55:12.528522 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 2 08:55:12.541530 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 2 08:55:12.543859 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 2 08:55:12.545595 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jul 2 08:55:12.546582 systemd[1]: Reached target getty.target - Login Prompts. Jul 2 08:55:12.751564 systemd-networkd[1308]: eth0: Gained IPv6LL Jul 2 08:55:12.753802 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 2 08:55:12.755145 systemd[1]: Reached target network-online.target - Network is Online. Jul 2 08:55:12.771526 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 2 08:55:12.773234 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 2 08:55:12.787704 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 2 08:55:12.787983 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 2 08:55:12.789151 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 2 08:55:12.792789 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 2 08:55:12.793906 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 2 08:55:12.801369 systemd[1]: Startup finished in 548ms (kernel) + 3.500s (initrd) + 2.624s (userspace) = 6.673s. Jul 2 08:55:19.995879 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 2 08:55:19.996971 systemd[1]: Started sshd@0-10.0.0.16:22-10.0.0.1:60602.service - OpenSSH per-connection server daemon (10.0.0.1:60602). Jul 2 08:55:20.047801 sshd[1433]: Accepted publickey for core from 10.0.0.1 port 60602 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:20.049582 sshd[1433]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:20.058031 systemd-logind[1358]: New session 1 of user core. Jul 2 08:55:20.059038 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 2 08:55:20.073539 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 2 08:55:20.084335 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 2 08:55:20.086598 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 2 08:55:20.093063 (systemd)[1437]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:20.165520 systemd[1437]: Queued start job for default target default.target. Jul 2 08:55:20.180177 systemd[1437]: Created slice app.slice - User Application Slice. Jul 2 08:55:20.180208 systemd[1437]: Reached target paths.target - Paths. Jul 2 08:55:20.180234 systemd[1437]: Reached target timers.target - Timers. Jul 2 08:55:20.181378 systemd[1437]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 2 08:55:20.190376 systemd[1437]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 2 08:55:20.190437 systemd[1437]: Reached target sockets.target - Sockets. Jul 2 08:55:20.190450 systemd[1437]: Reached target basic.target - Basic System. Jul 2 08:55:20.190487 systemd[1437]: Reached target default.target - Main User Target. Jul 2 08:55:20.190511 systemd[1437]: Startup finished in 92ms. Jul 2 08:55:20.190744 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 2 08:55:20.191972 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 2 08:55:20.245481 systemd[1]: Started sshd@1-10.0.0.16:22-10.0.0.1:42522.service - OpenSSH per-connection server daemon (10.0.0.1:42522). Jul 2 08:55:20.286874 sshd[1448]: Accepted publickey for core from 10.0.0.1 port 42522 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:20.288028 sshd[1448]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:20.292050 systemd-logind[1358]: New session 2 of user core. Jul 2 08:55:20.302459 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 2 08:55:20.353483 sshd[1448]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:20.362412 systemd[1]: sshd@1-10.0.0.16:22-10.0.0.1:42522.service: Deactivated successfully. Jul 2 08:55:20.364627 systemd[1]: session-2.scope: Deactivated successfully. Jul 2 08:55:20.366524 systemd-logind[1358]: Session 2 logged out. Waiting for processes to exit. Jul 2 08:55:20.378961 systemd[1]: Started sshd@2-10.0.0.16:22-10.0.0.1:42530.service - OpenSSH per-connection server daemon (10.0.0.1:42530). Jul 2 08:55:20.380191 systemd-logind[1358]: Removed session 2. Jul 2 08:55:20.411944 sshd[1455]: Accepted publickey for core from 10.0.0.1 port 42530 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:20.413020 sshd[1455]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:20.416278 systemd-logind[1358]: New session 3 of user core. Jul 2 08:55:20.429449 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 2 08:55:20.477108 sshd[1455]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:20.485524 systemd[1]: sshd@2-10.0.0.16:22-10.0.0.1:42530.service: Deactivated successfully. Jul 2 08:55:20.487545 systemd[1]: session-3.scope: Deactivated successfully. Jul 2 08:55:20.488706 systemd-logind[1358]: Session 3 logged out. Waiting for processes to exit. Jul 2 08:55:20.504614 systemd[1]: Started sshd@3-10.0.0.16:22-10.0.0.1:42536.service - OpenSSH per-connection server daemon (10.0.0.1:42536). Jul 2 08:55:20.505393 systemd-logind[1358]: Removed session 3. Jul 2 08:55:20.538129 sshd[1462]: Accepted publickey for core from 10.0.0.1 port 42536 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:20.539211 sshd[1462]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:20.542626 systemd-logind[1358]: New session 4 of user core. Jul 2 08:55:20.560450 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 2 08:55:20.611375 sshd[1462]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:20.619621 systemd[1]: sshd@3-10.0.0.16:22-10.0.0.1:42536.service: Deactivated successfully. Jul 2 08:55:20.621008 systemd[1]: session-4.scope: Deactivated successfully. Jul 2 08:55:20.623389 systemd-logind[1358]: Session 4 logged out. Waiting for processes to exit. Jul 2 08:55:20.624447 systemd[1]: Started sshd@4-10.0.0.16:22-10.0.0.1:42546.service - OpenSSH per-connection server daemon (10.0.0.1:42546). Jul 2 08:55:20.625174 systemd-logind[1358]: Removed session 4. Jul 2 08:55:20.661753 sshd[1469]: Accepted publickey for core from 10.0.0.1 port 42546 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:20.662834 sshd[1469]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:20.666186 systemd-logind[1358]: New session 5 of user core. Jul 2 08:55:20.686455 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 2 08:55:20.742076 sudo[1472]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jul 2 08:55:20.744121 sudo[1472]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jul 2 08:55:20.757017 sudo[1472]: pam_unix(sudo:session): session closed for user root Jul 2 08:55:20.758573 sshd[1469]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:20.776857 systemd[1]: sshd@4-10.0.0.16:22-10.0.0.1:42546.service: Deactivated successfully. Jul 2 08:55:20.778690 systemd[1]: session-5.scope: Deactivated successfully. Jul 2 08:55:20.780063 systemd-logind[1358]: Session 5 logged out. Waiting for processes to exit. Jul 2 08:55:20.781440 systemd[1]: Started sshd@5-10.0.0.16:22-10.0.0.1:42558.service - OpenSSH per-connection server daemon (10.0.0.1:42558). Jul 2 08:55:20.784652 systemd-logind[1358]: Removed session 5. Jul 2 08:55:20.820005 sshd[1477]: Accepted publickey for core from 10.0.0.1 port 42558 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:20.821032 sshd[1477]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:20.824562 systemd-logind[1358]: New session 6 of user core. Jul 2 08:55:20.836442 systemd[1]: Started session-6.scope - Session 6 of User core. Jul 2 08:55:20.886939 sudo[1481]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Jul 2 08:55:20.887159 sudo[1481]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jul 2 08:55:20.889971 sudo[1481]: pam_unix(sudo:session): session closed for user root Jul 2 08:55:20.894081 sudo[1480]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Jul 2 08:55:20.894548 sudo[1480]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jul 2 08:55:20.910522 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Jul 2 08:55:20.911628 auditctl[1484]: No rules Jul 2 08:55:20.911934 systemd[1]: audit-rules.service: Deactivated successfully. Jul 2 08:55:20.913347 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Jul 2 08:55:20.915491 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jul 2 08:55:20.937163 augenrules[1502]: No rules Jul 2 08:55:20.938275 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jul 2 08:55:20.939240 sudo[1480]: pam_unix(sudo:session): session closed for user root Jul 2 08:55:20.941493 sshd[1477]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:20.951570 systemd[1]: sshd@5-10.0.0.16:22-10.0.0.1:42558.service: Deactivated successfully. Jul 2 08:55:20.952923 systemd[1]: session-6.scope: Deactivated successfully. Jul 2 08:55:20.955367 systemd-logind[1358]: Session 6 logged out. Waiting for processes to exit. Jul 2 08:55:20.956440 systemd[1]: Started sshd@6-10.0.0.16:22-10.0.0.1:42566.service - OpenSSH per-connection server daemon (10.0.0.1:42566). Jul 2 08:55:20.958632 systemd-logind[1358]: Removed session 6. Jul 2 08:55:20.993911 sshd[1511]: Accepted publickey for core from 10.0.0.1 port 42566 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:20.995107 sshd[1511]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:20.998704 systemd-logind[1358]: New session 7 of user core. Jul 2 08:55:21.015437 systemd[1]: Started session-7.scope - Session 7 of User core. Jul 2 08:55:21.062797 sshd[1511]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:21.075499 systemd[1]: sshd@6-10.0.0.16:22-10.0.0.1:42566.service: Deactivated successfully. Jul 2 08:55:21.076953 systemd[1]: session-7.scope: Deactivated successfully. Jul 2 08:55:21.078153 systemd-logind[1358]: Session 7 logged out. Waiting for processes to exit. Jul 2 08:55:21.088550 systemd[1]: Started sshd@7-10.0.0.16:22-10.0.0.1:42576.service - OpenSSH per-connection server daemon (10.0.0.1:42576). Jul 2 08:55:21.089315 systemd-logind[1358]: Removed session 7. Jul 2 08:55:21.123291 sshd[1519]: Accepted publickey for core from 10.0.0.1 port 42576 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:21.124570 sshd[1519]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:21.128349 systemd-logind[1358]: New session 8 of user core. Jul 2 08:55:21.142438 systemd[1]: Started session-8.scope - Session 8 of User core. Jul 2 08:55:21.675618 sshd[1519]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:21.692685 systemd[1]: sshd@7-10.0.0.16:22-10.0.0.1:42576.service: Deactivated successfully. Jul 2 08:55:21.694034 systemd[1]: session-8.scope: Deactivated successfully. Jul 2 08:55:21.695210 systemd-logind[1358]: Session 8 logged out. Waiting for processes to exit. Jul 2 08:55:21.696333 systemd[1]: Started sshd@8-10.0.0.16:22-10.0.0.1:42584.service - OpenSSH per-connection server daemon (10.0.0.1:42584). Jul 2 08:55:21.696988 systemd-logind[1358]: Removed session 8. Jul 2 08:55:21.734230 sshd[1535]: Accepted publickey for core from 10.0.0.1 port 42584 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:21.735402 sshd[1535]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:21.738687 systemd-logind[1358]: New session 9 of user core. Jul 2 08:55:21.748485 systemd[1]: Started session-9.scope - Session 9 of User core. Jul 2 08:55:25.584829 sudo[1538]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mv docker.raw containerd.raw /etc/extensions/ Jul 2 08:55:25.585052 sudo[1538]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jul 2 08:55:25.753365 sudo[1538]: pam_unix(sudo:session): session closed for user root Jul 2 08:55:25.754969 sshd[1535]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:25.774987 systemd[1]: sshd@8-10.0.0.16:22-10.0.0.1:42584.service: Deactivated successfully. Jul 2 08:55:25.776785 systemd[1]: session-9.scope: Deactivated successfully. Jul 2 08:55:25.778408 systemd[1]: session-9.scope: Consumed 3.549s CPU time. Jul 2 08:55:25.780503 systemd-logind[1358]: Session 9 logged out. Waiting for processes to exit. Jul 2 08:55:25.781490 systemd[1]: Started sshd@9-10.0.0.16:22-10.0.0.1:42592.service - OpenSSH per-connection server daemon (10.0.0.1:42592). Jul 2 08:55:25.782443 systemd-logind[1358]: Removed session 9. Jul 2 08:55:25.818550 sshd[1596]: Accepted publickey for core from 10.0.0.1 port 42592 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:25.819671 sshd[1596]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:25.823364 systemd-logind[1358]: New session 10 of user core. Jul 2 08:55:25.832433 systemd[1]: Started session-10.scope - Session 10 of User core. Jul 2 08:55:25.881712 sudo[1599]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart systemd-sysext Jul 2 08:55:25.882751 sudo[1599]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jul 2 08:55:25.890503 systemd[1]: ensure-sysext.service: Deactivated successfully. Jul 2 08:55:25.890856 systemd[1]: Stopped ensure-sysext.service. Jul 2 08:55:25.890916 systemd[1]: Stopping ensure-sysext.service... Jul 2 08:55:25.899613 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 2 08:55:25.904107 systemd[1]: systemd-sysext.service: Deactivated successfully. Jul 2 08:55:25.905390 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 2 08:55:25.907509 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 2 08:55:25.916437 kernel: loop0: detected capacity change from 0 to 301296 Jul 2 08:55:25.916480 kernel: block loop0: the capability attribute has been deprecated. Jul 2 08:55:25.921319 kernel: EXT4-fs (loop0): mounted filesystem 997b9bae-1ffc-49c1-8fce-bef1735cf537 ro without journal. Quota mode: none. Jul 2 08:55:25.924328 kernel: EXT4-fs (loop0): unmounting filesystem 997b9bae-1ffc-49c1-8fce-bef1735cf537. Jul 2 08:55:25.957326 kernel: loop1: detected capacity change from 0 to 315088 Jul 2 08:55:25.961334 kernel: EXT4-fs (loop1): mounted filesystem 5d031f81-bad1-4eb5-b275-a9129a3e58a8 ro without journal. Quota mode: none. Jul 2 08:55:25.964324 kernel: EXT4-fs (loop1): unmounting filesystem 5d031f81-bad1-4eb5-b275-a9129a3e58a8. Jul 2 08:55:25.989329 kernel: loop2: detected capacity change from 0 to 301296 Jul 2 08:55:25.994756 kernel: EXT4-fs (loop2): mounted filesystem 997b9bae-1ffc-49c1-8fce-bef1735cf537 ro without journal. Quota mode: none. Jul 2 08:55:25.994812 kernel: loop3: detected capacity change from 0 to 315088 Jul 2 08:55:25.998335 kernel: EXT4-fs (loop3): mounted filesystem 5d031f81-bad1-4eb5-b275-a9129a3e58a8 ro without journal. Quota mode: none. Jul 2 08:55:25.998683 (sd-merge)[1610]: Using extensions 'containerd', 'docker'. Jul 2 08:55:25.999062 (sd-merge)[1610]: Merged extensions into '/usr'. Jul 2 08:55:26.002386 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 2 08:55:26.004513 sudo[1599]: pam_unix(sudo:session): session closed for user root Jul 2 08:55:26.006022 sshd[1596]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:26.009583 systemd[1]: Starting ensure-sysext.service... Jul 2 08:55:26.009892 systemd[1]: sshd@9-10.0.0.16:22-10.0.0.1:42592.service: Deactivated successfully. Jul 2 08:55:26.011454 systemd[1]: session-10.scope: Deactivated successfully. Jul 2 08:55:26.012065 systemd-logind[1358]: Session 10 logged out. Waiting for processes to exit. Jul 2 08:55:26.031638 systemd[1]: Started sshd@10-10.0.0.16:22-10.0.0.1:42600.service - OpenSSH per-connection server daemon (10.0.0.1:42600). Jul 2 08:55:26.032103 systemd[1]: Reloading requested from client PID 1614 ('systemctl') (unit ensure-sysext.service)... Jul 2 08:55:26.032113 systemd[1]: Reloading... Jul 2 08:55:26.032396 systemd-logind[1358]: Removed session 10. Jul 2 08:55:26.089332 zram_generator::config[1654]: No configuration found. Jul 2 08:55:26.234458 systemd[1]: /usr/lib/systemd/system/docker.socket:5: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 2 08:55:26.286499 systemd[1]: Reloading finished in 254 ms. Jul 2 08:55:26.333095 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 2 08:55:26.334490 systemd[1]: Starting containerd.service - containerd container runtime... Jul 2 08:55:26.334744 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 2 08:55:26.337176 systemd[1]: Stopped target sockets.target - Socket Units. Jul 2 08:55:26.337192 systemd[1]: Stopping sockets.target - Socket Units... Jul 2 08:55:26.337260 systemd[1]: Reached target sockets.target - Socket Units. Jul 2 08:55:26.338115 systemd[1]: Stopped target timers.target - Timer Units. Jul 2 08:55:26.338129 systemd[1]: Stopping timers.target - Timer Units... Jul 2 08:55:26.338196 systemd[1]: Reached target timers.target - Timer Units. Jul 2 08:55:26.341493 systemd[1]: Stopped target multi-user.target - Multi-User System. Jul 2 08:55:26.341525 systemd[1]: Stopping multi-user.target - Multi-User System... Jul 2 08:55:26.341567 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 2 08:55:26.342828 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 2 08:55:26.343814 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 2 08:55:26.345607 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 2 08:55:26.348709 sshd[1618]: Accepted publickey for core from 10.0.0.1 port 42600 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:26.349218 sshd[1618]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:26.349470 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 2 08:55:26.351679 jq[1693]: false Jul 2 08:55:26.352670 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 2 08:55:26.355662 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 2 08:55:26.355853 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 2 08:55:26.355998 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 2 08:55:26.356671 extend-filesystems[1694]: Found loop2 Jul 2 08:55:26.357677 extend-filesystems[1694]: Found loop3 Jul 2 08:55:26.357677 extend-filesystems[1694]: Found vda Jul 2 08:55:26.357677 extend-filesystems[1694]: Found vda1 Jul 2 08:55:26.357677 extend-filesystems[1694]: Found vda2 Jul 2 08:55:26.357677 extend-filesystems[1694]: Found vda3 Jul 2 08:55:26.357677 extend-filesystems[1694]: Found usr Jul 2 08:55:26.357677 extend-filesystems[1694]: Found vda4 Jul 2 08:55:26.357677 extend-filesystems[1694]: Found vda6 Jul 2 08:55:26.357677 extend-filesystems[1694]: Found vda7 Jul 2 08:55:26.357677 extend-filesystems[1694]: Found vda9 Jul 2 08:55:26.357677 extend-filesystems[1694]: Checking size of /dev/vda9 Jul 2 08:55:26.366650 extend-filesystems[1694]: Old size kept for /dev/vda9 Jul 2 08:55:26.359942 systemd[1]: Started containerd.service - containerd container runtime. Jul 2 08:55:26.362842 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 2 08:55:26.366338 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 2 08:55:26.366874 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 2 08:55:26.367007 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 2 08:55:26.367637 systemd[1]: issuegen.service: Deactivated successfully. Jul 2 08:55:26.367764 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 2 08:55:26.368470 systemd[1]: motdgen.service: Deactivated successfully. Jul 2 08:55:26.368615 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 2 08:55:26.369367 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 2 08:55:26.369495 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 2 08:55:26.371088 systemd[1]: Finished ensure-sysext.service. Jul 2 08:55:26.383028 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (1716) Jul 2 08:55:26.382958 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 2 08:55:26.383273 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 2 08:55:26.401365 systemd-logind[1358]: New session 11 of user core. Jul 2 08:55:26.419485 systemd[1]: Started session-11.scope - Session 11 of User core. Jul 2 08:55:26.419947 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Jul 2 08:55:26.420119 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 2 08:55:26.605016 containerd[1702]: time="2024-07-02T08:55:26.602486925Z" level=info msg="starting containerd" revision=1c90a442489720eec95342e1789ee8a5e1b9536f version=v1.6.9 Jul 2 08:55:26.623558 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 2 08:55:26.623662 (dockerd)[1746]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Jul 2 08:55:26.626940 containerd[1702]: time="2024-07-02T08:55:26.626888195Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jul 2 08:55:26.627066 containerd[1702]: time="2024-07-02T08:55:26.627038431Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:26.628852 containerd[1702]: time="2024-07-02T08:55:26.628565927Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.36-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jul 2 08:55:26.628852 containerd[1702]: time="2024-07-02T08:55:26.628830581Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:26.629089 containerd[1702]: time="2024-07-02T08:55:26.629052093Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jul 2 08:55:26.629089 containerd[1702]: time="2024-07-02T08:55:26.629077987Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:26.629141 containerd[1702]: time="2024-07-02T08:55:26.629093194Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Jul 2 08:55:26.629141 containerd[1702]: time="2024-07-02T08:55:26.629102799Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:26.629186 containerd[1702]: time="2024-07-02T08:55:26.629176237Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:26.629426 containerd[1702]: time="2024-07-02T08:55:26.629404793Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:26.629545 containerd[1702]: time="2024-07-02T08:55:26.629526494Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jul 2 08:55:26.629572 containerd[1702]: time="2024-07-02T08:55:26.629546705Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jul 2 08:55:26.629613 containerd[1702]: time="2024-07-02T08:55:26.629597891Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Jul 2 08:55:26.629640 containerd[1702]: time="2024-07-02T08:55:26.629614299Z" level=info msg="metadata content store policy set" policy=shared Jul 2 08:55:26.637516 containerd[1702]: time="2024-07-02T08:55:26.637489898Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jul 2 08:55:26.637578 containerd[1702]: time="2024-07-02T08:55:26.637525996Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jul 2 08:55:26.637578 containerd[1702]: time="2024-07-02T08:55:26.637539163Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jul 2 08:55:26.637620 containerd[1702]: time="2024-07-02T08:55:26.637585386Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jul 2 08:55:26.637620 containerd[1702]: time="2024-07-02T08:55:26.637601354Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jul 2 08:55:26.637659 containerd[1702]: time="2024-07-02T08:55:26.637618883Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jul 2 08:55:26.637659 containerd[1702]: time="2024-07-02T08:55:26.637632290Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jul 2 08:55:26.637990 containerd[1702]: time="2024-07-02T08:55:26.637968021Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jul 2 08:55:26.638026 containerd[1702]: time="2024-07-02T08:55:26.637996515Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Jul 2 08:55:26.638026 containerd[1702]: time="2024-07-02T08:55:26.638013284Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jul 2 08:55:26.638078 containerd[1702]: time="2024-07-02T08:55:26.638025890Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jul 2 08:55:26.638078 containerd[1702]: time="2024-07-02T08:55:26.638038296Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jul 2 08:55:26.638184 containerd[1702]: time="2024-07-02T08:55:26.638162960Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jul 2 08:55:26.638284 containerd[1702]: time="2024-07-02T08:55:26.638267653Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jul 2 08:55:26.638544 containerd[1702]: time="2024-07-02T08:55:26.638528025Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jul 2 08:55:26.638573 containerd[1702]: time="2024-07-02T08:55:26.638558520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.638600 containerd[1702]: time="2024-07-02T08:55:26.638571287Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jul 2 08:55:26.638731 containerd[1702]: time="2024-07-02T08:55:26.638718642Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.638762 containerd[1702]: time="2024-07-02T08:55:26.638736611Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.638762 containerd[1702]: time="2024-07-02T08:55:26.638749938Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.638817 containerd[1702]: time="2024-07-02T08:55:26.638760903Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.638817 containerd[1702]: time="2024-07-02T08:55:26.638772989Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.638817 containerd[1702]: time="2024-07-02T08:55:26.638784795Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.638817 containerd[1702]: time="2024-07-02T08:55:26.638797802Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.638817 containerd[1702]: time="2024-07-02T08:55:26.638810408Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.638919 containerd[1702]: time="2024-07-02T08:55:26.638822374Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jul 2 08:55:26.638979 containerd[1702]: time="2024-07-02T08:55:26.638959004Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.639009 containerd[1702]: time="2024-07-02T08:55:26.638989499Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.639009 containerd[1702]: time="2024-07-02T08:55:26.639005227Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.639310 containerd[1702]: time="2024-07-02T08:55:26.639265880Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jul 2 08:55:26.639871 containerd[1702]: time="2024-07-02T08:55:26.639714587Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Jul 2 08:55:26.639871 containerd[1702]: time="2024-07-02T08:55:26.639771656Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jul 2 08:55:26.640019 containerd[1702]: time="2024-07-02T08:55:26.639883553Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Jul 2 08:55:26.640019 containerd[1702]: time="2024-07-02T08:55:26.639930937Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jul 2 08:55:26.640375 containerd[1702]: time="2024-07-02T08:55:26.640134281Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:false SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.6 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jul 2 08:55:26.640375 containerd[1702]: time="2024-07-02T08:55:26.640194431Z" level=info msg="Connect containerd service" Jul 2 08:55:26.640375 containerd[1702]: time="2024-07-02T08:55:26.640227368Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jul 2 08:55:26.641010 containerd[1702]: time="2024-07-02T08:55:26.640982111Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Jul 2 08:55:26.641292 containerd[1702]: time="2024-07-02T08:55:26.641274820Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 2 08:55:26.641352 containerd[1702]: time="2024-07-02T08:55:26.641343134Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 2 08:55:26.641379 containerd[1702]: time="2024-07-02T08:55:26.641360503Z" level=info msg="containerd successfully booted in 0.040235s" Jul 2 08:55:26.641445 containerd[1702]: time="2024-07-02T08:55:26.641410649Z" level=info msg="Start subscribing containerd event" Jul 2 08:55:26.641472 containerd[1702]: time="2024-07-02T08:55:26.641464476Z" level=info msg="Start recovering state" Jul 2 08:55:26.641541 containerd[1702]: time="2024-07-02T08:55:26.641526908Z" level=info msg="Start event monitor" Jul 2 08:55:26.644730 containerd[1702]: time="2024-07-02T08:55:26.644708563Z" level=info msg="Start snapshots syncer" Jul 2 08:55:26.644730 containerd[1702]: time="2024-07-02T08:55:26.644730894Z" level=info msg="Start cni network conf syncer for default" Jul 2 08:55:26.644730 containerd[1702]: time="2024-07-02T08:55:26.644738178Z" level=info msg="Start streaming server" Jul 2 08:55:26.845367 dockerd[1746]: time="2024-07-02T08:55:26.845294412Z" level=info msg="Starting up" Jul 2 08:55:26.850577 dockerd[1746]: time="2024-07-02T08:55:26.850514062Z" level=info msg="parsed scheme: \"unix\"" module=grpc Jul 2 08:55:26.850577 dockerd[1746]: time="2024-07-02T08:55:26.850552241Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Jul 2 08:55:26.850577 dockerd[1746]: time="2024-07-02T08:55:26.850577734Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc Jul 2 08:55:26.850734 dockerd[1746]: time="2024-07-02T08:55:26.850588580Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Jul 2 08:55:26.860281 dockerd[1746]: time="2024-07-02T08:55:26.860188294Z" level=info msg="parsed scheme: \"unix\"" module=grpc Jul 2 08:55:26.860281 dockerd[1746]: time="2024-07-02T08:55:26.860219510Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Jul 2 08:55:26.860281 dockerd[1746]: time="2024-07-02T08:55:26.860235718Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc Jul 2 08:55:26.860281 dockerd[1746]: time="2024-07-02T08:55:26.860243842Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Jul 2 08:55:27.009104 dockerd[1746]: time="2024-07-02T08:55:27.009053999Z" level=info msg="Loading containers: start." Jul 2 08:55:27.086787 kernel: Initializing XFRM netlink socket Jul 2 08:55:27.100967 dockerd[1746]: time="2024-07-02T08:55:27.100920027Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Jul 2 08:55:27.146228 systemd-networkd[1308]: docker0: Link UP Jul 2 08:55:27.155758 dockerd[1746]: time="2024-07-02T08:55:27.155699053Z" level=info msg="Loading containers: done." Jul 2 08:55:27.189773 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2869754336-merged.mount: Deactivated successfully. Jul 2 08:55:27.190889 dockerd[1746]: time="2024-07-02T08:55:27.190574288Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Jul 2 08:55:27.191043 dockerd[1746]: time="2024-07-02T08:55:27.191014224Z" level=info msg="Docker daemon" commit=3056208 graphdriver(s)=overlay2 version=20.10.21 Jul 2 08:55:27.191142 dockerd[1746]: time="2024-07-02T08:55:27.191128200Z" level=info msg="Daemon has completed initialization" Jul 2 08:55:27.205983 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 2 08:55:27.212166 dockerd[1746]: time="2024-07-02T08:55:27.211944240Z" level=info msg="API listen on /run/docker.sock" Jul 2 08:55:28.193551 systemd[1]: var-lib-docker-overlay2-13609680968b0826f9a5e51db1ce130614250b973a90486fd5e8078b7699d859\x2dinit-merged.mount: Deactivated successfully. Jul 2 08:55:28.221591 kernel: docker0: port 1(veth9d9df39) entered blocking state Jul 2 08:55:28.221703 kernel: docker0: port 1(veth9d9df39) entered disabled state Jul 2 08:55:28.221723 kernel: veth9d9df39: entered allmulticast mode Jul 2 08:55:28.221739 kernel: veth9d9df39: entered promiscuous mode Jul 2 08:55:28.222153 systemd-networkd[1308]: veth9d9df39: Link UP Jul 2 08:55:28.222607 kernel: docker0: port 1(veth9d9df39) entered blocking state Jul 2 08:55:28.222642 kernel: docker0: port 1(veth9d9df39) entered forwarding state Jul 2 08:55:28.223598 kernel: docker0: port 1(veth9d9df39) entered disabled state Jul 2 08:55:28.274819 containerd[1702]: time="2024-07-02T08:55:28.274719266Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 2 08:55:28.274819 containerd[1702]: time="2024-07-02T08:55:28.274768850Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 2 08:55:28.274819 containerd[1702]: time="2024-07-02T08:55:28.274780055Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 2 08:55:28.275355 containerd[1702]: time="2024-07-02T08:55:28.274955459Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/a6b7b9c63f178cf792746a52876f0aef11fcdfcfbde780909012328a3452364d pid=1882 runtime=io.containerd.runc.v2 Jul 2 08:55:28.294459 systemd[1]: Started docker-a6b7b9c63f178cf792746a52876f0aef11fcdfcfbde780909012328a3452364d.scope - libcontainer container a6b7b9c63f178cf792746a52876f0aef11fcdfcfbde780909012328a3452364d. Jul 2 08:55:28.365334 kernel: eth0: renamed from veth6acf739 Jul 2 08:55:28.374997 systemd-networkd[1308]: veth9d9df39: Gained carrier Jul 2 08:55:28.375254 systemd-networkd[1308]: docker0: Gained carrier Jul 2 08:55:28.375368 kernel: docker0: port 1(veth9d9df39) entered blocking state Jul 2 08:55:28.375402 kernel: docker0: port 1(veth9d9df39) entered forwarding state Jul 2 08:55:28.377058 systemd-resolved[1247]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 2 08:55:28.397130 systemd[1]: docker-a6b7b9c63f178cf792746a52876f0aef11fcdfcfbde780909012328a3452364d.scope: Deactivated successfully. Jul 2 08:55:28.408173 dockerd[1746]: time="2024-07-02T08:55:28.408121156Z" level=info msg="ignoring event" container=a6b7b9c63f178cf792746a52876f0aef11fcdfcfbde780909012328a3452364d module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Jul 2 08:55:28.408490 containerd[1702]: time="2024-07-02T08:55:28.408166338Z" level=info msg="shim disconnected" id=a6b7b9c63f178cf792746a52876f0aef11fcdfcfbde780909012328a3452364d Jul 2 08:55:28.408490 containerd[1702]: time="2024-07-02T08:55:28.408337900Z" level=warning msg="cleaning up after shim disconnected" id=a6b7b9c63f178cf792746a52876f0aef11fcdfcfbde780909012328a3452364d namespace=moby Jul 2 08:55:28.408490 containerd[1702]: time="2024-07-02T08:55:28.408351706Z" level=info msg="cleaning up dead shim" Jul 2 08:55:28.414490 containerd[1702]: time="2024-07-02T08:55:28.414454214Z" level=warning msg="cleanup warnings time=\"2024-07-02T08:55:28Z\" level=info msg=\"starting signal loop\" namespace=moby pid=1935 runtime=io.containerd.runc.v2\n" Jul 2 08:55:28.418143 systemd-networkd[1308]: veth9d9df39: Lost carrier Jul 2 08:55:28.418871 kernel: docker0: port 1(veth9d9df39) entered disabled state Jul 2 08:55:28.418927 kernel: veth6acf739: renamed from eth0 Jul 2 08:55:28.433833 systemd-networkd[1308]: veth9d9df39: Link DOWN Jul 2 08:55:28.435832 kernel: docker0: port 1(veth9d9df39) entered disabled state Jul 2 08:55:28.435902 kernel: veth9d9df39 (unregistering): left allmulticast mode Jul 2 08:55:28.435921 kernel: veth9d9df39 (unregistering): left promiscuous mode Jul 2 08:55:28.435943 kernel: docker0: port 1(veth9d9df39) entered disabled state Jul 2 08:55:28.470026 sshd[1618]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:28.481882 systemd[1]: sshd@10-10.0.0.16:22-10.0.0.1:42600.service: Deactivated successfully. Jul 2 08:55:28.483773 systemd[1]: session-11.scope: Deactivated successfully. Jul 2 08:55:28.485902 systemd-logind[1358]: Session 11 logged out. Waiting for processes to exit. Jul 2 08:55:28.501617 systemd[1]: Started sshd@11-10.0.0.16:22-10.0.0.1:42614.service - OpenSSH per-connection server daemon (10.0.0.1:42614). Jul 2 08:55:28.502470 systemd-logind[1358]: Removed session 11. Jul 2 08:55:28.535840 sshd[1954]: Accepted publickey for core from 10.0.0.1 port 42614 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:28.537095 sshd[1954]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:28.540909 systemd-logind[1358]: New session 12 of user core. Jul 2 08:55:28.550469 systemd[1]: Started session-12.scope - Session 12 of User core. Jul 2 08:55:28.616668 sshd[1954]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:28.622648 systemd[1]: sshd@11-10.0.0.16:22-10.0.0.1:42614.service: Deactivated successfully. Jul 2 08:55:28.624191 systemd[1]: session-12.scope: Deactivated successfully. Jul 2 08:55:28.624764 systemd-logind[1358]: Session 12 logged out. Waiting for processes to exit. Jul 2 08:55:28.626443 systemd[1]: Started sshd@12-10.0.0.16:22-10.0.0.1:42620.service - OpenSSH per-connection server daemon (10.0.0.1:42620). Jul 2 08:55:28.627150 systemd-logind[1358]: Removed session 12. Jul 2 08:55:28.664694 sshd[1964]: Accepted publickey for core from 10.0.0.1 port 42620 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:28.665799 sshd[1964]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:28.669368 systemd-logind[1358]: New session 13 of user core. Jul 2 08:55:28.676439 systemd[1]: Started session-13.scope - Session 13 of User core. Jul 2 08:55:29.191728 systemd[1]: var-lib-docker-overlay2-13609680968b0826f9a5e51db1ce130614250b973a90486fd5e8078b7699d859-merged.mount: Deactivated successfully. Jul 2 08:55:29.263521 systemd-networkd[1308]: docker0: Lost carrier Jul 2 08:55:29.647438 systemd-networkd[1308]: docker0: Gained IPv6LL Jul 2 08:55:32.485968 sudo[1967]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mv docker.raw containerd.raw /etc/extensions/ Jul 2 08:55:32.486219 sudo[1967]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jul 2 08:55:32.646283 sudo[1967]: pam_unix(sudo:session): session closed for user root Jul 2 08:55:32.649388 sshd[1964]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:32.657003 systemd[1]: sshd@12-10.0.0.16:22-10.0.0.1:42620.service: Deactivated successfully. Jul 2 08:55:32.658844 systemd[1]: session-13.scope: Deactivated successfully. Jul 2 08:55:32.659021 systemd[1]: session-13.scope: Consumed 3.444s CPU time. Jul 2 08:55:32.661501 systemd-logind[1358]: Session 13 logged out. Waiting for processes to exit. Jul 2 08:55:32.675585 systemd[1]: Started sshd@13-10.0.0.16:22-10.0.0.1:33112.service - OpenSSH per-connection server daemon (10.0.0.1:33112). Jul 2 08:55:32.676503 systemd-logind[1358]: Removed session 13. Jul 2 08:55:32.709477 sshd[2024]: Accepted publickey for core from 10.0.0.1 port 33112 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:32.710735 sshd[2024]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:32.714367 systemd-logind[1358]: New session 14 of user core. Jul 2 08:55:32.726438 systemd[1]: Started session-14.scope - Session 14 of User core. Jul 2 08:55:32.776296 sudo[2028]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart systemd-sysext Jul 2 08:55:32.776563 sudo[2028]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jul 2 08:55:32.784234 systemd[1]: ensure-sysext.service: Deactivated successfully. Jul 2 08:55:32.784412 systemd[1]: Stopped ensure-sysext.service. Jul 2 08:55:32.784467 systemd[1]: Stopping ensure-sysext.service... Jul 2 08:55:32.798549 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 2 08:55:32.802132 systemd-sysext[2030]: Unmerged '/usr'. Jul 2 08:55:32.806576 systemd[1]: systemd-sysext.service: Deactivated successfully. Jul 2 08:55:32.806778 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 2 08:55:32.810242 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 2 08:55:32.818346 kernel: loop4: detected capacity change from 0 to 301272 Jul 2 08:55:32.823335 kernel: EXT4-fs (loop4): mounted filesystem c42d86f0-b759-4dc9-8d80-316b4b6ef13b ro without journal. Quota mode: none. Jul 2 08:55:32.826330 kernel: EXT4-fs (loop4): unmounting filesystem c42d86f0-b759-4dc9-8d80-316b4b6ef13b. Jul 2 08:55:32.852330 kernel: loop5: detected capacity change from 0 to 301344 Jul 2 08:55:32.856322 kernel: EXT4-fs (loop5): mounted filesystem 4b1019dd-16bd-4edc-8537-847ba97ea6e4 ro without journal. Quota mode: none. Jul 2 08:55:32.858336 kernel: EXT4-fs (loop5): unmounting filesystem 4b1019dd-16bd-4edc-8537-847ba97ea6e4. Jul 2 08:55:32.895373 kernel: loop6: detected capacity change from 0 to 301272 Jul 2 08:55:32.900965 kernel: EXT4-fs (loop6): mounted filesystem c42d86f0-b759-4dc9-8d80-316b4b6ef13b ro without journal. Quota mode: none. Jul 2 08:55:32.901122 kernel: loop7: detected capacity change from 0 to 301344 Jul 2 08:55:32.905331 kernel: EXT4-fs (loop7): mounted filesystem 4b1019dd-16bd-4edc-8537-847ba97ea6e4 ro without journal. Quota mode: none. Jul 2 08:55:32.904945 (sd-merge)[2039]: Using extensions 'containerd', 'docker'. Jul 2 08:55:32.905336 (sd-merge)[2039]: Merged extensions into '/usr'. Jul 2 08:55:32.907973 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 2 08:55:32.909470 sudo[2028]: pam_unix(sudo:session): session closed for user root Jul 2 08:55:32.914878 sudo[2027]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart docker containerd Jul 2 08:55:32.915132 sudo[2027]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jul 2 08:55:32.915947 systemd[1]: Starting ensure-sysext.service... Jul 2 08:55:32.920676 systemd[1]: Reloading requested from client PID 2043 ('systemctl') (unit ensure-sysext.service)... Jul 2 08:55:32.920691 systemd[1]: Reloading... Jul 2 08:55:32.976468 zram_generator::config[2084]: No configuration found. Jul 2 08:55:33.115686 systemd[1]: /usr/lib/systemd/system/docker.socket:5: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 2 08:55:33.168050 systemd[1]: Reloading finished in 247 ms. Jul 2 08:55:33.213173 systemd[1]: Stopped target sockets.target - Socket Units. Jul 2 08:55:33.213191 systemd[1]: Stopping sockets.target - Socket Units... Jul 2 08:55:33.213285 systemd[1]: Stopped target timers.target - Timer Units. Jul 2 08:55:33.213293 systemd[1]: Stopping timers.target - Timer Units... Jul 2 08:55:33.213505 systemd[1]: Reached target timers.target - Timer Units. Jul 2 08:55:33.213837 dockerd[1746]: time="2024-07-02T08:55:33.213793788Z" level=info msg="Processing signal 'terminated'" Jul 2 08:55:33.214407 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jul 2 08:55:33.214735 dockerd[1746]: time="2024-07-02T08:55:33.214688952Z" level=info msg="stopping event stream following graceful shutdown" error="" module=libcontainerd namespace=moby Jul 2 08:55:33.218358 dockerd[1746]: time="2024-07-02T08:55:33.218319908Z" level=info msg="Daemon shutdown complete" Jul 2 08:55:33.220111 systemd[1]: docker.service: Deactivated successfully. Jul 2 08:55:33.220365 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jul 2 08:55:33.221501 systemd[1]: Stopped target multi-user.target - Multi-User System. Jul 2 08:55:33.221529 systemd[1]: Stopping multi-user.target - Multi-User System... Jul 2 08:55:33.221572 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 2 08:55:33.221885 systemd[1]: docker.socket: Deactivated successfully. Jul 2 08:55:33.222209 systemd[1]: Closed docker.socket - Docker Socket for the API. Jul 2 08:55:33.222245 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jul 2 08:55:33.223936 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 2 08:55:33.229644 containerd[1702]: time="2024-07-02T08:55:33.229572604Z" level=info msg="Stop CRI service" Jul 2 08:55:33.230034 containerd[1702]: time="2024-07-02T08:55:33.229701656Z" level=info msg="Stop CRI service" Jul 2 08:55:33.229755 systemd[1]: Stopping containerd.service - containerd container runtime... Jul 2 08:55:33.231246 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 2 08:55:33.232380 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 2 08:55:33.233539 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 2 08:55:33.236698 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 2 08:55:33.238811 jq[2118]: false Jul 2 08:55:33.239998 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 2 08:55:33.243790 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 2 08:55:33.244008 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 2 08:55:33.244212 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 2 08:55:33.246428 systemd[1]: containerd.service: Deactivated successfully. Jul 2 08:55:33.246643 systemd[1]: Stopped containerd.service - containerd container runtime. Jul 2 08:55:33.247076 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 2 08:55:33.250811 extend-filesystems[2119]: Found loop2 Jul 2 08:55:33.250811 extend-filesystems[2119]: Found loop3 Jul 2 08:55:33.250811 extend-filesystems[2119]: Found loop6 Jul 2 08:55:33.250811 extend-filesystems[2119]: Found loop7 Jul 2 08:55:33.250811 extend-filesystems[2119]: Found vda Jul 2 08:55:33.250811 extend-filesystems[2119]: Found vda1 Jul 2 08:55:33.250811 extend-filesystems[2119]: Found vda2 Jul 2 08:55:33.250811 extend-filesystems[2119]: Found vda3 Jul 2 08:55:33.250811 extend-filesystems[2119]: Found usr Jul 2 08:55:33.250811 extend-filesystems[2119]: Found vda4 Jul 2 08:55:33.250811 extend-filesystems[2119]: Found vda6 Jul 2 08:55:33.250811 extend-filesystems[2119]: Found vda7 Jul 2 08:55:33.250811 extend-filesystems[2119]: Found vda9 Jul 2 08:55:33.250811 extend-filesystems[2119]: Checking size of /dev/vda9 Jul 2 08:55:33.250123 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 2 08:55:33.250284 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 2 08:55:33.250884 systemd[1]: issuegen.service: Deactivated successfully. Jul 2 08:55:33.251049 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 2 08:55:33.252357 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 2 08:55:33.252540 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 2 08:55:33.255280 systemd[1]: Finished ensure-sysext.service. Jul 2 08:55:33.259203 systemd[1]: motdgen.service: Deactivated successfully. Jul 2 08:55:33.259576 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 2 08:55:33.264850 extend-filesystems[2119]: Old size kept for /dev/vda9 Jul 2 08:55:33.264868 systemd[1]: Reached target sockets.target - Socket Units. Jul 2 08:55:33.266699 systemd[1]: Starting containerd.service - containerd container runtime... Jul 2 08:55:33.267222 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 2 08:55:33.268413 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 2 08:55:33.269088 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 2 08:55:33.269262 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 2 08:55:33.277267 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Jul 2 08:55:33.283361 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (2148) Jul 2 08:55:33.289632 systemd[1]: Started containerd.service - containerd container runtime. Jul 2 08:55:33.297040 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 2 08:55:33.299660 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 2 08:55:33.307165 (dockerd)[2158]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Jul 2 08:55:33.492453 containerd[2156]: time="2024-07-02T08:55:33.492264458Z" level=info msg="starting containerd" revision=7c3aca7a610df76212171d200ca3811ff6096eb8 version=v1.7.13 Jul 2 08:55:33.518760 containerd[2156]: time="2024-07-02T08:55:33.518539902Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jul 2 08:55:33.518760 containerd[2156]: time="2024-07-02T08:55:33.518590562Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:33.520442 containerd[2156]: time="2024-07-02T08:55:33.520383411Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.36-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jul 2 08:55:33.520442 containerd[2156]: time="2024-07-02T08:55:33.520420506Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jul 2 08:55:33.520723 containerd[2156]: time="2024-07-02T08:55:33.520447877Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:33.520723 containerd[2156]: time="2024-07-02T08:55:33.520571247Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jul 2 08:55:33.520723 containerd[2156]: time="2024-07-02T08:55:33.520587174Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:33.520723 containerd[2156]: time="2024-07-02T08:55:33.520608943Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:33.520802 containerd[2156]: time="2024-07-02T08:55:33.520741357Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:33.520802 containerd[2156]: time="2024-07-02T08:55:33.520758284Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Jul 2 08:55:33.520802 containerd[2156]: time="2024-07-02T08:55:33.520767967Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jul 2 08:55:33.520919 containerd[2156]: time="2024-07-02T08:55:33.520897380Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jul 2 08:55:33.520965 containerd[2156]: time="2024-07-02T08:55:33.520915227Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jul 2 08:55:33.521010 containerd[2156]: time="2024-07-02T08:55:33.520979053Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Jul 2 08:55:33.521010 containerd[2156]: time="2024-07-02T08:55:33.520989297Z" level=info msg="metadata content store policy set" policy=shared Jul 2 08:55:33.521550 containerd[2156]: time="2024-07-02T08:55:33.521521954Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jul 2 08:55:33.521591 containerd[2156]: time="2024-07-02T08:55:33.521552446Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jul 2 08:55:33.521591 containerd[2156]: time="2024-07-02T08:55:33.521566012Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jul 2 08:55:33.521638 containerd[2156]: time="2024-07-02T08:55:33.521598905Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jul 2 08:55:33.521638 containerd[2156]: time="2024-07-02T08:55:33.521612871Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jul 2 08:55:33.521638 containerd[2156]: time="2024-07-02T08:55:33.521622595Z" level=info msg="NRI interface is disabled by configuration." Jul 2 08:55:33.521638 containerd[2156]: time="2024-07-02T08:55:33.521634240Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jul 2 08:55:33.521875 containerd[2156]: time="2024-07-02T08:55:33.521780179Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jul 2 08:55:33.521875 containerd[2156]: time="2024-07-02T08:55:33.521801708Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jul 2 08:55:33.521875 containerd[2156]: time="2024-07-02T08:55:33.521814433Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jul 2 08:55:33.521875 containerd[2156]: time="2024-07-02T08:55:33.521826558Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jul 2 08:55:33.521875 containerd[2156]: time="2024-07-02T08:55:33.521839923Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jul 2 08:55:33.521875 containerd[2156]: time="2024-07-02T08:55:33.521854329Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jul 2 08:55:33.521875 containerd[2156]: time="2024-07-02T08:55:33.521866494Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jul 2 08:55:33.521875 containerd[2156]: time="2024-07-02T08:55:33.521879259Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jul 2 08:55:33.522053 containerd[2156]: time="2024-07-02T08:55:33.521893705Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jul 2 08:55:33.522053 containerd[2156]: time="2024-07-02T08:55:33.521906911Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jul 2 08:55:33.522053 containerd[2156]: time="2024-07-02T08:55:33.521919516Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jul 2 08:55:33.522053 containerd[2156]: time="2024-07-02T08:55:33.521968896Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jul 2 08:55:33.522053 containerd[2156]: time="2024-07-02T08:55:33.522019676Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jul 2 08:55:33.522513 containerd[2156]: time="2024-07-02T08:55:33.522325681Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jul 2 08:55:33.522513 containerd[2156]: time="2024-07-02T08:55:33.522359815Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.522513 containerd[2156]: time="2024-07-02T08:55:33.522373100Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jul 2 08:55:33.522513 containerd[2156]: time="2024-07-02T08:55:33.522395989Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jul 2 08:55:33.522878 containerd[2156]: time="2024-07-02T08:55:33.522752214Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.522878 containerd[2156]: time="2024-07-02T08:55:33.522779585Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.522878 containerd[2156]: time="2024-07-02T08:55:33.522792191Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.522878 containerd[2156]: time="2024-07-02T08:55:33.522812519Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.522878 containerd[2156]: time="2024-07-02T08:55:33.522827125Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.522878 containerd[2156]: time="2024-07-02T08:55:33.522839170Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.522878 containerd[2156]: time="2024-07-02T08:55:33.522849814Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.522878 containerd[2156]: time="2024-07-02T08:55:33.522860858Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.522878 containerd[2156]: time="2024-07-02T08:55:33.522874744Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jul 2 08:55:33.523128 containerd[2156]: time="2024-07-02T08:55:33.522899834Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.523128 containerd[2156]: time="2024-07-02T08:55:33.522912720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.523128 containerd[2156]: time="2024-07-02T08:55:33.522952376Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.523128 containerd[2156]: time="2024-07-02T08:55:33.522970543Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.523128 containerd[2156]: time="2024-07-02T08:55:33.522983788Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.523128 containerd[2156]: time="2024-07-02T08:55:33.523006238Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.523128 containerd[2156]: time="2024-07-02T08:55:33.523019083Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.523128 containerd[2156]: time="2024-07-02T08:55:33.523030247Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jul 2 08:55:33.523644 containerd[2156]: time="2024-07-02T08:55:33.523245175Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:false SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jul 2 08:55:33.523644 containerd[2156]: time="2024-07-02T08:55:33.523332250Z" level=info msg="Connect containerd service" Jul 2 08:55:33.523644 containerd[2156]: time="2024-07-02T08:55:33.523360822Z" level=info msg="using legacy CRI server" Jul 2 08:55:33.523644 containerd[2156]: time="2024-07-02T08:55:33.523368265Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 2 08:55:33.524131 containerd[2156]: time="2024-07-02T08:55:33.523573348Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jul 2 08:55:33.524736 containerd[2156]: time="2024-07-02T08:55:33.524698326Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Jul 2 08:55:33.524783 containerd[2156]: time="2024-07-02T08:55:33.524747546Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jul 2 08:55:33.524783 containerd[2156]: time="2024-07-02T08:55:33.524774557Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Jul 2 08:55:33.524823 containerd[2156]: time="2024-07-02T08:55:33.524785961Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jul 2 08:55:33.524842 containerd[2156]: time="2024-07-02T08:55:33.524817814Z" level=info msg="skipping tracing processor initialization (no tracing plugin)" error="no OpenTelemetry endpoint: skip plugin" Jul 2 08:55:33.524875 containerd[2156]: time="2024-07-02T08:55:33.524821416Z" level=info msg="Start subscribing containerd event" Jul 2 08:55:33.524895 containerd[2156]: time="2024-07-02T08:55:33.524886042Z" level=info msg="Start recovering state" Jul 2 08:55:33.525063 containerd[2156]: time="2024-07-02T08:55:33.524946306Z" level=info msg="Start event monitor" Jul 2 08:55:33.525063 containerd[2156]: time="2024-07-02T08:55:33.524964594Z" level=info msg="Start snapshots syncer" Jul 2 08:55:33.525063 containerd[2156]: time="2024-07-02T08:55:33.524975798Z" level=info msg="Start cni network conf syncer for default" Jul 2 08:55:33.525063 containerd[2156]: time="2024-07-02T08:55:33.524983321Z" level=info msg="Start streaming server" Jul 2 08:55:33.525490 containerd[2156]: time="2024-07-02T08:55:33.525291327Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 2 08:55:33.525490 containerd[2156]: time="2024-07-02T08:55:33.525375961Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 2 08:55:33.525490 containerd[2156]: time="2024-07-02T08:55:33.525399691Z" level=info msg="containerd successfully booted in 0.035225s" Jul 2 08:55:33.563593 dockerd[2158]: time="2024-07-02T08:55:33.563538078Z" level=info msg="Starting up" Jul 2 08:55:33.713091 dockerd[2158]: time="2024-07-02T08:55:33.712851551Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jul 2 08:55:33.719764 dockerd[2158]: time="2024-07-02T08:55:33.719734950Z" level=info msg="Loading containers: start." Jul 2 08:55:33.966878 dockerd[2158]: time="2024-07-02T08:55:33.966762154Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Jul 2 08:55:34.012684 dockerd[2158]: time="2024-07-02T08:55:34.012639545Z" level=info msg="Loading containers: done." Jul 2 08:55:34.039435 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck470473067-merged.mount: Deactivated successfully. Jul 2 08:55:34.041355 dockerd[2158]: time="2024-07-02T08:55:34.041228526Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Jul 2 08:55:34.041465 dockerd[2158]: time="2024-07-02T08:55:34.041443611Z" level=info msg="Docker daemon" commit=fca702d graphdriver=overlay2 version=24.0.9 Jul 2 08:55:34.041526 dockerd[2158]: time="2024-07-02T08:55:34.041504675Z" level=info msg="Daemon has completed initialization" Jul 2 08:55:34.064045 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 2 08:55:34.064848 dockerd[2158]: time="2024-07-02T08:55:34.063880009Z" level=info msg="API listen on /run/docker.sock" Jul 2 08:55:34.065230 sudo[2027]: pam_unix(sudo:session): session closed for user root Jul 2 08:55:34.066810 sshd[2024]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:34.075316 kernel: EXT4-fs (loop2): unmounting filesystem 997b9bae-1ffc-49c1-8fce-bef1735cf537. Jul 2 08:55:34.081552 kernel: EXT4-fs (loop3): unmounting filesystem 5d031f81-bad1-4eb5-b275-a9129a3e58a8. Jul 2 08:55:34.081998 systemd-logind[1358]: Session 14 logged out. Waiting for processes to exit. Jul 2 08:55:34.090568 systemd[1]: Started sshd@14-10.0.0.16:22-10.0.0.1:33120.service - OpenSSH per-connection server daemon (10.0.0.1:33120). Jul 2 08:55:34.107846 systemd[1]: sshd@13-10.0.0.16:22-10.0.0.1:33112.service: Deactivated successfully. Jul 2 08:55:34.109518 systemd[1]: session-14.scope: Deactivated successfully. Jul 2 08:55:34.111858 systemd-logind[1358]: Removed session 14. Jul 2 08:55:34.124806 sshd[2304]: Accepted publickey for core from 10.0.0.1 port 33120 ssh2: RSA SHA256:ITYl1npsZrK81BYOVTGvToao81d3ICeCJ/pBQYbYY/k Jul 2 08:55:34.126372 sshd[2304]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:55:34.130360 systemd-logind[1358]: New session 15 of user core. Jul 2 08:55:34.142476 systemd[1]: Started session-15.scope - Session 15 of User core. Jul 2 08:55:34.255734 systemd[1]: var-lib-docker-overlay2-4cf9fb77e97a31332c69aad2fc7ba0564f490542ccc597eb0d86ff9f059ba086\x2dinit-merged.mount: Deactivated successfully. Jul 2 08:55:34.273796 kernel: docker0: port 1(veth3bc10ad) entered blocking state Jul 2 08:55:34.273894 kernel: docker0: port 1(veth3bc10ad) entered disabled state Jul 2 08:55:34.273915 kernel: veth3bc10ad: entered allmulticast mode Jul 2 08:55:34.273938 kernel: veth3bc10ad: entered promiscuous mode Jul 2 08:55:34.274876 systemd-networkd[1308]: veth3bc10ad: Link UP Jul 2 08:55:34.319957 containerd[2156]: time="2024-07-02T08:55:34.319867885Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 2 08:55:34.319957 containerd[2156]: time="2024-07-02T08:55:34.319917225Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 2 08:55:34.320233 containerd[2156]: time="2024-07-02T08:55:34.319934111Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 2 08:55:34.320233 containerd[2156]: time="2024-07-02T08:55:34.320157759Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 2 08:55:34.348456 systemd[1]: Started docker-389b47ca2d774a58f8b238141d951416e8827c8eef4f92b3d9ff1e081fddd499.scope - libcontainer container 389b47ca2d774a58f8b238141d951416e8827c8eef4f92b3d9ff1e081fddd499. Jul 2 08:55:34.397336 kernel: eth0: renamed from vethd80c0c8 Jul 2 08:55:34.411792 kernel: docker0: port 1(veth3bc10ad) entered blocking state Jul 2 08:55:34.411840 kernel: docker0: port 1(veth3bc10ad) entered forwarding state Jul 2 08:55:34.411880 systemd-networkd[1308]: veth3bc10ad: Gained carrier Jul 2 08:55:34.412129 systemd-networkd[1308]: docker0: Gained carrier Jul 2 08:55:34.414540 systemd-resolved[1247]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 2 08:55:34.432297 systemd[1]: docker-389b47ca2d774a58f8b238141d951416e8827c8eef4f92b3d9ff1e081fddd499.scope: Deactivated successfully. Jul 2 08:55:34.443970 dockerd[2158]: time="2024-07-02T08:55:34.443915109Z" level=info msg="ignoring event" container=389b47ca2d774a58f8b238141d951416e8827c8eef4f92b3d9ff1e081fddd499 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Jul 2 08:55:34.444170 containerd[2156]: time="2024-07-02T08:55:34.444116828Z" level=info msg="shim disconnected" id=389b47ca2d774a58f8b238141d951416e8827c8eef4f92b3d9ff1e081fddd499 namespace=moby Jul 2 08:55:34.444170 containerd[2156]: time="2024-07-02T08:55:34.444148521Z" level=warning msg="cleaning up after shim disconnected" id=389b47ca2d774a58f8b238141d951416e8827c8eef4f92b3d9ff1e081fddd499 namespace=moby Jul 2 08:55:34.444170 containerd[2156]: time="2024-07-02T08:55:34.444157244Z" level=info msg="cleaning up dead shim" namespace=moby Jul 2 08:55:34.457337 kernel: vethd80c0c8: renamed from eth0 Jul 2 08:55:34.464146 systemd-networkd[1308]: veth3bc10ad: Lost carrier Jul 2 08:55:34.464331 kernel: docker0: port 1(veth3bc10ad) entered disabled state Jul 2 08:55:34.476031 systemd-networkd[1308]: veth3bc10ad: Link DOWN Jul 2 08:55:34.477417 kernel: docker0: port 1(veth3bc10ad) entered disabled state Jul 2 08:55:34.477469 kernel: veth3bc10ad (unregistering): left allmulticast mode Jul 2 08:55:34.477487 kernel: veth3bc10ad (unregistering): left promiscuous mode Jul 2 08:55:34.478411 kernel: docker0: port 1(veth3bc10ad) entered disabled state Jul 2 08:55:34.519883 sshd[2304]: pam_unix(sshd:session): session closed for user core Jul 2 08:55:34.523761 systemd[1]: sshd@14-10.0.0.16:22-10.0.0.1:33120.service: Deactivated successfully. Jul 2 08:55:34.525660 systemd[1]: session-15.scope: Deactivated successfully. Jul 2 08:55:34.526224 systemd-logind[1358]: Session 15 logged out. Waiting for processes to exit. Jul 2 08:55:34.526964 systemd-logind[1358]: Removed session 15. Jul 2 08:55:35.279546 systemd-networkd[1308]: docker0: Lost carrier