Aug 5 22:03:32.927016 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Aug 5 22:03:32.927037 kernel: Linux version 6.6.43-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 Aug 5 20:37:57 -00 2024 Aug 5 22:03:32.927046 kernel: KASLR enabled Aug 5 22:03:32.927052 kernel: efi: EFI v2.7 by EDK II Aug 5 22:03:32.927058 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb8fd018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 Aug 5 22:03:32.927064 kernel: random: crng init done Aug 5 22:03:32.927071 kernel: ACPI: Early table checksum verification disabled Aug 5 22:03:32.927077 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Aug 5 22:03:32.927084 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Aug 5 22:03:32.927091 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:03:32.927098 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:03:32.927104 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:03:32.927110 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:03:32.927117 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:03:32.927124 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:03:32.927132 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:03:32.927139 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:03:32.927146 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:03:32.927152 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Aug 5 22:03:32.927158 kernel: NUMA: Failed to initialise from firmware Aug 5 22:03:32.927165 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:03:32.927171 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Aug 5 22:03:32.927178 kernel: Zone ranges: Aug 5 22:03:32.927185 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:03:32.927191 kernel: DMA32 empty Aug 5 22:03:32.927199 kernel: Normal empty Aug 5 22:03:32.927206 kernel: Movable zone start for each node Aug 5 22:03:32.927212 kernel: Early memory node ranges Aug 5 22:03:32.927219 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Aug 5 22:03:32.927226 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Aug 5 22:03:32.927232 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Aug 5 22:03:32.927239 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Aug 5 22:03:32.927245 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Aug 5 22:03:32.927252 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Aug 5 22:03:32.927258 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Aug 5 22:03:32.927265 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:03:32.927272 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Aug 5 22:03:32.927280 kernel: psci: probing for conduit method from ACPI. Aug 5 22:03:32.927286 kernel: psci: PSCIv1.1 detected in firmware. Aug 5 22:03:32.927293 kernel: psci: Using standard PSCI v0.2 function IDs Aug 5 22:03:32.927302 kernel: psci: Trusted OS migration not required Aug 5 22:03:32.927309 kernel: psci: SMC Calling Convention v1.1 Aug 5 22:03:32.927316 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Aug 5 22:03:32.927325 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Aug 5 22:03:32.927332 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Aug 5 22:03:32.927339 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Aug 5 22:03:32.927346 kernel: Detected PIPT I-cache on CPU0 Aug 5 22:03:32.927353 kernel: CPU features: detected: GIC system register CPU interface Aug 5 22:03:32.927380 kernel: CPU features: detected: Hardware dirty bit management Aug 5 22:03:32.927388 kernel: CPU features: detected: Spectre-v4 Aug 5 22:03:32.927395 kernel: CPU features: detected: Spectre-BHB Aug 5 22:03:32.927402 kernel: CPU features: kernel page table isolation forced ON by KASLR Aug 5 22:03:32.927409 kernel: CPU features: detected: Kernel page table isolation (KPTI) Aug 5 22:03:32.927417 kernel: CPU features: detected: ARM erratum 1418040 Aug 5 22:03:32.927424 kernel: alternatives: applying boot alternatives Aug 5 22:03:32.927432 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=4052403b8e39e55d48e6afcca927358798017aa0d33c868bc3038260a8d9be90 Aug 5 22:03:32.927440 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 5 22:03:32.927447 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 5 22:03:32.927454 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 5 22:03:32.927464 kernel: Fallback order for Node 0: 0 Aug 5 22:03:32.927475 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Aug 5 22:03:32.927485 kernel: Policy zone: DMA Aug 5 22:03:32.927493 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 5 22:03:32.927500 kernel: software IO TLB: area num 4. Aug 5 22:03:32.927508 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Aug 5 22:03:32.927521 kernel: Memory: 2386852K/2572288K available (10240K kernel code, 2182K rwdata, 8072K rodata, 39040K init, 897K bss, 185436K reserved, 0K cma-reserved) Aug 5 22:03:32.927528 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 5 22:03:32.927535 kernel: trace event string verifier disabled Aug 5 22:03:32.927542 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 5 22:03:32.927550 kernel: rcu: RCU event tracing is enabled. Aug 5 22:03:32.927557 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 5 22:03:32.927564 kernel: Trampoline variant of Tasks RCU enabled. Aug 5 22:03:32.927571 kernel: Tracing variant of Tasks RCU enabled. Aug 5 22:03:32.927579 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 5 22:03:32.927587 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 5 22:03:32.927594 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 5 22:03:32.927603 kernel: GICv3: 256 SPIs implemented Aug 5 22:03:32.927610 kernel: GICv3: 0 Extended SPIs implemented Aug 5 22:03:32.927617 kernel: Root IRQ handler: gic_handle_irq Aug 5 22:03:32.927624 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Aug 5 22:03:32.927631 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Aug 5 22:03:32.927639 kernel: ITS [mem 0x08080000-0x0809ffff] Aug 5 22:03:32.927646 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Aug 5 22:03:32.927653 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Aug 5 22:03:32.927660 kernel: GICv3: using LPI property table @0x00000000400f0000 Aug 5 22:03:32.927667 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Aug 5 22:03:32.927674 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 5 22:03:32.927684 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:03:32.927695 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Aug 5 22:03:32.927705 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Aug 5 22:03:32.927716 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Aug 5 22:03:32.927726 kernel: arm-pv: using stolen time PV Aug 5 22:03:32.927734 kernel: Console: colour dummy device 80x25 Aug 5 22:03:32.927741 kernel: ACPI: Core revision 20230628 Aug 5 22:03:32.927748 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Aug 5 22:03:32.927755 kernel: pid_max: default: 32768 minimum: 301 Aug 5 22:03:32.927763 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Aug 5 22:03:32.927771 kernel: SELinux: Initializing. Aug 5 22:03:32.927778 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:03:32.927785 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:03:32.927793 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:03:32.927800 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:03:32.927807 kernel: rcu: Hierarchical SRCU implementation. Aug 5 22:03:32.927814 kernel: rcu: Max phase no-delay instances is 400. Aug 5 22:03:32.927821 kernel: Platform MSI: ITS@0x8080000 domain created Aug 5 22:03:32.927828 kernel: PCI/MSI: ITS@0x8080000 domain created Aug 5 22:03:32.927836 kernel: Remapping and enabling EFI services. Aug 5 22:03:32.927844 kernel: smp: Bringing up secondary CPUs ... Aug 5 22:03:32.927851 kernel: Detected PIPT I-cache on CPU1 Aug 5 22:03:32.927858 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Aug 5 22:03:32.927865 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Aug 5 22:03:32.927872 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:03:32.927879 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Aug 5 22:03:32.927886 kernel: Detected PIPT I-cache on CPU2 Aug 5 22:03:32.927893 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Aug 5 22:03:32.927901 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Aug 5 22:03:32.927909 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:03:32.927916 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Aug 5 22:03:32.927929 kernel: Detected PIPT I-cache on CPU3 Aug 5 22:03:32.927938 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Aug 5 22:03:32.927946 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Aug 5 22:03:32.927953 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:03:32.927960 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Aug 5 22:03:32.927968 kernel: smp: Brought up 1 node, 4 CPUs Aug 5 22:03:32.927975 kernel: SMP: Total of 4 processors activated. Aug 5 22:03:32.927985 kernel: CPU features: detected: 32-bit EL0 Support Aug 5 22:03:32.927993 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Aug 5 22:03:32.928000 kernel: CPU features: detected: Common not Private translations Aug 5 22:03:32.928008 kernel: CPU features: detected: CRC32 instructions Aug 5 22:03:32.928015 kernel: CPU features: detected: Enhanced Virtualization Traps Aug 5 22:03:32.928023 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Aug 5 22:03:32.928030 kernel: CPU features: detected: LSE atomic instructions Aug 5 22:03:32.928038 kernel: CPU features: detected: Privileged Access Never Aug 5 22:03:32.928047 kernel: CPU features: detected: RAS Extension Support Aug 5 22:03:32.928054 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Aug 5 22:03:32.928061 kernel: CPU: All CPU(s) started at EL1 Aug 5 22:03:32.928069 kernel: alternatives: applying system-wide alternatives Aug 5 22:03:32.928076 kernel: devtmpfs: initialized Aug 5 22:03:32.928084 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 5 22:03:32.928092 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 5 22:03:32.928099 kernel: pinctrl core: initialized pinctrl subsystem Aug 5 22:03:32.928107 kernel: SMBIOS 3.0.0 present. Aug 5 22:03:32.928116 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Aug 5 22:03:32.928124 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 5 22:03:32.928132 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 5 22:03:32.928139 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 5 22:03:32.928147 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 5 22:03:32.928154 kernel: audit: initializing netlink subsys (disabled) Aug 5 22:03:32.928162 kernel: audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 Aug 5 22:03:32.928170 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 5 22:03:32.928177 kernel: cpuidle: using governor menu Aug 5 22:03:32.928186 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 5 22:03:32.928194 kernel: ASID allocator initialised with 32768 entries Aug 5 22:03:32.928201 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 5 22:03:32.928209 kernel: Serial: AMBA PL011 UART driver Aug 5 22:03:32.928216 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Aug 5 22:03:32.928224 kernel: Modules: 0 pages in range for non-PLT usage Aug 5 22:03:32.928231 kernel: Modules: 509120 pages in range for PLT usage Aug 5 22:03:32.928239 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 5 22:03:32.928246 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Aug 5 22:03:32.928255 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Aug 5 22:03:32.928263 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Aug 5 22:03:32.928270 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 5 22:03:32.928277 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Aug 5 22:03:32.928285 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Aug 5 22:03:32.928293 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Aug 5 22:03:32.928300 kernel: ACPI: Added _OSI(Module Device) Aug 5 22:03:32.928307 kernel: ACPI: Added _OSI(Processor Device) Aug 5 22:03:32.928315 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Aug 5 22:03:32.928324 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 5 22:03:32.928331 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 5 22:03:32.928339 kernel: ACPI: Interpreter enabled Aug 5 22:03:32.928346 kernel: ACPI: Using GIC for interrupt routing Aug 5 22:03:32.928354 kernel: ACPI: MCFG table detected, 1 entries Aug 5 22:03:32.928368 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Aug 5 22:03:32.928376 kernel: printk: console [ttyAMA0] enabled Aug 5 22:03:32.928383 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 5 22:03:32.928531 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 5 22:03:32.928615 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Aug 5 22:03:32.928685 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Aug 5 22:03:32.928753 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Aug 5 22:03:32.928819 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Aug 5 22:03:32.928829 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Aug 5 22:03:32.928837 kernel: PCI host bridge to bus 0000:00 Aug 5 22:03:32.928910 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Aug 5 22:03:32.928974 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Aug 5 22:03:32.929042 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Aug 5 22:03:32.929106 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 5 22:03:32.929189 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Aug 5 22:03:32.929270 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Aug 5 22:03:32.929340 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Aug 5 22:03:32.929492 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Aug 5 22:03:32.929573 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 22:03:32.929644 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 22:03:32.929713 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Aug 5 22:03:32.929783 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Aug 5 22:03:32.929847 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Aug 5 22:03:32.929908 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Aug 5 22:03:32.929973 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Aug 5 22:03:32.929983 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Aug 5 22:03:32.929991 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Aug 5 22:03:32.929999 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Aug 5 22:03:32.930007 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Aug 5 22:03:32.930015 kernel: iommu: Default domain type: Translated Aug 5 22:03:32.930022 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 5 22:03:32.930030 kernel: efivars: Registered efivars operations Aug 5 22:03:32.930038 kernel: vgaarb: loaded Aug 5 22:03:32.930047 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 5 22:03:32.930054 kernel: VFS: Disk quotas dquot_6.6.0 Aug 5 22:03:32.930062 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 5 22:03:32.930070 kernel: pnp: PnP ACPI init Aug 5 22:03:32.930148 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Aug 5 22:03:32.930159 kernel: pnp: PnP ACPI: found 1 devices Aug 5 22:03:32.930167 kernel: NET: Registered PF_INET protocol family Aug 5 22:03:32.930175 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 5 22:03:32.930184 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 5 22:03:32.930192 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 5 22:03:32.930199 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 5 22:03:32.930207 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 5 22:03:32.930214 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 5 22:03:32.930222 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:03:32.930230 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:03:32.930237 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 5 22:03:32.930244 kernel: PCI: CLS 0 bytes, default 64 Aug 5 22:03:32.930253 kernel: kvm [1]: HYP mode not available Aug 5 22:03:32.930260 kernel: Initialise system trusted keyrings Aug 5 22:03:32.930267 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 5 22:03:32.930275 kernel: Key type asymmetric registered Aug 5 22:03:32.930282 kernel: Asymmetric key parser 'x509' registered Aug 5 22:03:32.930289 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Aug 5 22:03:32.930296 kernel: io scheduler mq-deadline registered Aug 5 22:03:32.930303 kernel: io scheduler kyber registered Aug 5 22:03:32.930311 kernel: io scheduler bfq registered Aug 5 22:03:32.930320 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Aug 5 22:03:32.930327 kernel: ACPI: button: Power Button [PWRB] Aug 5 22:03:32.930335 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Aug 5 22:03:32.930414 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Aug 5 22:03:32.930425 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 5 22:03:32.930432 kernel: thunder_xcv, ver 1.0 Aug 5 22:03:32.930439 kernel: thunder_bgx, ver 1.0 Aug 5 22:03:32.930447 kernel: nicpf, ver 1.0 Aug 5 22:03:32.930454 kernel: nicvf, ver 1.0 Aug 5 22:03:32.930536 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 5 22:03:32.930600 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-08-05T22:03:32 UTC (1722895412) Aug 5 22:03:32.930610 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 5 22:03:32.930618 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Aug 5 22:03:32.930625 kernel: watchdog: Delayed init of the lockup detector failed: -19 Aug 5 22:03:32.930633 kernel: watchdog: Hard watchdog permanently disabled Aug 5 22:03:32.930640 kernel: NET: Registered PF_INET6 protocol family Aug 5 22:03:32.930647 kernel: Segment Routing with IPv6 Aug 5 22:03:32.930657 kernel: In-situ OAM (IOAM) with IPv6 Aug 5 22:03:32.930664 kernel: NET: Registered PF_PACKET protocol family Aug 5 22:03:32.930671 kernel: Key type dns_resolver registered Aug 5 22:03:32.930679 kernel: registered taskstats version 1 Aug 5 22:03:32.930686 kernel: Loading compiled-in X.509 certificates Aug 5 22:03:32.930694 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.43-flatcar: 99cab5c9e2f0f3a5ca972c2df7b3d6ed64d627d4' Aug 5 22:03:32.930701 kernel: Key type .fscrypt registered Aug 5 22:03:32.930709 kernel: Key type fscrypt-provisioning registered Aug 5 22:03:32.930719 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 5 22:03:32.930730 kernel: ima: Allocated hash algorithm: sha1 Aug 5 22:03:32.930737 kernel: ima: No architecture policies found Aug 5 22:03:32.930744 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 5 22:03:32.930751 kernel: clk: Disabling unused clocks Aug 5 22:03:32.930759 kernel: Freeing unused kernel memory: 39040K Aug 5 22:03:32.930766 kernel: Run /init as init process Aug 5 22:03:32.930773 kernel: with arguments: Aug 5 22:03:32.930780 kernel: /init Aug 5 22:03:32.930787 kernel: with environment: Aug 5 22:03:32.930795 kernel: HOME=/ Aug 5 22:03:32.930803 kernel: TERM=linux Aug 5 22:03:32.930810 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 5 22:03:32.930819 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) Aug 5 22:03:32.930829 systemd[1]: Detected virtualization kvm. Aug 5 22:03:32.930836 systemd[1]: Detected architecture arm64. Aug 5 22:03:32.930844 systemd[1]: Running in initrd. Aug 5 22:03:32.930852 systemd[1]: No hostname configured, using default hostname. Aug 5 22:03:32.930860 systemd[1]: Hostname set to . Aug 5 22:03:32.930868 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:03:32.930876 systemd[1]: Queued start job for default target initrd.target. Aug 5 22:03:32.930884 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:03:32.930892 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:03:32.930900 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 5 22:03:32.930908 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:03:32.930916 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 5 22:03:32.930925 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 5 22:03:32.930934 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 5 22:03:32.930942 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 5 22:03:32.930950 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:03:32.930958 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:03:32.930966 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:03:32.930975 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:03:32.930983 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:03:32.930991 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:03:32.930999 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:03:32.931007 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:03:32.931014 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 5 22:03:32.931022 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 5 22:03:32.931030 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:03:32.931038 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:03:32.931048 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:03:32.931056 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:03:32.931063 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 5 22:03:32.931071 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:03:32.931079 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 5 22:03:32.931087 systemd[1]: Starting systemd-fsck-usr.service... Aug 5 22:03:32.931095 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:03:32.931102 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:03:32.931110 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:03:32.931120 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 5 22:03:32.931128 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:03:32.931135 systemd[1]: Finished systemd-fsck-usr.service. Aug 5 22:03:32.931144 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 22:03:32.931170 systemd-journald[238]: Collecting audit messages is disabled. Aug 5 22:03:32.931189 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:03:32.931197 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 5 22:03:32.931206 systemd-journald[238]: Journal started Aug 5 22:03:32.931226 systemd-journald[238]: Runtime Journal (/run/log/journal/151dfd3bb6b747a0a08c021be3037482) is 5.9M, max 47.3M, 41.4M free. Aug 5 22:03:32.915804 systemd-modules-load[239]: Inserted module 'overlay' Aug 5 22:03:32.932804 systemd-modules-load[239]: Inserted module 'br_netfilter' Aug 5 22:03:32.934885 kernel: Bridge firewalling registered Aug 5 22:03:32.934906 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:03:32.937992 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:03:32.938423 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:03:32.955558 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:03:32.957590 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:03:32.959610 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:03:32.964530 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:03:32.974301 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:03:32.975896 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:03:32.977100 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:03:32.985530 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:03:32.986661 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:03:32.989439 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 5 22:03:33.002916 dracut-cmdline[280]: dracut-dracut-053 Aug 5 22:03:33.005451 dracut-cmdline[280]: 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=4052403b8e39e55d48e6afcca927358798017aa0d33c868bc3038260a8d9be90 Aug 5 22:03:33.018484 systemd-resolved[274]: Positive Trust Anchors: Aug 5 22:03:33.018502 systemd-resolved[274]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:03:33.018541 systemd-resolved[274]: 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 Aug 5 22:03:33.024716 systemd-resolved[274]: Defaulting to hostname 'linux'. Aug 5 22:03:33.025718 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:03:33.030526 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:03:33.076400 kernel: SCSI subsystem initialized Aug 5 22:03:33.081381 kernel: Loading iSCSI transport class v2.0-870. Aug 5 22:03:33.089425 kernel: iscsi: registered transport (tcp) Aug 5 22:03:33.104384 kernel: iscsi: registered transport (qla4xxx) Aug 5 22:03:33.104417 kernel: QLogic iSCSI HBA Driver Aug 5 22:03:33.148762 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 5 22:03:33.163668 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 5 22:03:33.180928 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 5 22:03:33.182178 kernel: device-mapper: uevent: version 1.0.3 Aug 5 22:03:33.182198 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 5 22:03:33.230396 kernel: raid6: neonx8 gen() 15748 MB/s Aug 5 22:03:33.247377 kernel: raid6: neonx4 gen() 15615 MB/s Aug 5 22:03:33.264377 kernel: raid6: neonx2 gen() 13221 MB/s Aug 5 22:03:33.281379 kernel: raid6: neonx1 gen() 10485 MB/s Aug 5 22:03:33.298392 kernel: raid6: int64x8 gen() 6949 MB/s Aug 5 22:03:33.315379 kernel: raid6: int64x4 gen() 7335 MB/s Aug 5 22:03:33.332383 kernel: raid6: int64x2 gen() 6123 MB/s Aug 5 22:03:33.349490 kernel: raid6: int64x1 gen() 5043 MB/s Aug 5 22:03:33.349521 kernel: raid6: using algorithm neonx8 gen() 15748 MB/s Aug 5 22:03:33.367399 kernel: raid6: .... xor() 11910 MB/s, rmw enabled Aug 5 22:03:33.367416 kernel: raid6: using neon recovery algorithm Aug 5 22:03:33.372381 kernel: xor: measuring software checksum speed Aug 5 22:03:33.373380 kernel: 8regs : 19801 MB/sec Aug 5 22:03:33.374382 kernel: 32regs : 19649 MB/sec Aug 5 22:03:33.375658 kernel: arm64_neon : 26920 MB/sec Aug 5 22:03:33.375681 kernel: xor: using function: arm64_neon (26920 MB/sec) Aug 5 22:03:33.426385 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 5 22:03:33.436827 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:03:33.445554 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:03:33.457457 systemd-udevd[462]: Using default interface naming scheme 'v255'. Aug 5 22:03:33.460646 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:03:33.463857 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 5 22:03:33.480733 dracut-pre-trigger[470]: rd.md=0: removing MD RAID activation Aug 5 22:03:33.508802 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:03:33.522587 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:03:33.563400 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:03:33.575567 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 5 22:03:33.585339 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 5 22:03:33.589827 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:03:33.591942 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:03:33.594184 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:03:33.600554 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 5 22:03:33.605233 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Aug 5 22:03:33.617536 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Aug 5 22:03:33.617666 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Aug 5 22:03:33.617678 kernel: GPT:9289727 != 19775487 Aug 5 22:03:33.617687 kernel: GPT:Alternate GPT header not at the end of the disk. Aug 5 22:03:33.617697 kernel: GPT:9289727 != 19775487 Aug 5 22:03:33.617705 kernel: GPT: Use GNU Parted to correct GPT errors. Aug 5 22:03:33.617714 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:03:33.615607 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:03:33.624849 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:03:33.624970 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:03:33.627050 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:03:33.629058 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:03:33.629216 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:03:33.634193 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:03:33.647483 kernel: BTRFS: device fsid 278882ec-4175-45f0-a12b-7fddc0d6d9a3 devid 1 transid 41 /dev/vda3 scanned by (udev-worker) (508) Aug 5 22:03:33.646685 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:03:33.650781 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (518) Aug 5 22:03:33.656409 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 5 22:03:33.661431 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Aug 5 22:03:33.662881 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:03:33.675925 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Aug 5 22:03:33.677219 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 5 22:03:33.683494 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:03:33.695523 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 5 22:03:33.697330 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:03:33.702862 disk-uuid[551]: Primary Header is updated. Aug 5 22:03:33.702862 disk-uuid[551]: Secondary Entries is updated. Aug 5 22:03:33.702862 disk-uuid[551]: Secondary Header is updated. Aug 5 22:03:33.707399 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:03:33.720484 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:03:34.718396 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:03:34.718866 disk-uuid[552]: The operation has completed successfully. Aug 5 22:03:34.744109 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 5 22:03:34.744211 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 5 22:03:34.764619 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 5 22:03:34.769679 sh[573]: Success Aug 5 22:03:34.788548 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Aug 5 22:03:34.820437 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 5 22:03:34.831848 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 5 22:03:34.835405 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 5 22:03:34.844031 kernel: BTRFS info (device dm-0): first mount of filesystem 278882ec-4175-45f0-a12b-7fddc0d6d9a3 Aug 5 22:03:34.844081 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:03:34.844092 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 5 22:03:34.845101 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 5 22:03:34.845830 kernel: BTRFS info (device dm-0): using free space tree Aug 5 22:03:34.849504 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 5 22:03:34.850857 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 5 22:03:34.860541 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 5 22:03:34.864353 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 5 22:03:34.875487 kernel: BTRFS info (device vda6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:03:34.875546 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:03:34.875559 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:03:34.878455 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:03:34.887344 systemd[1]: mnt-oem.mount: Deactivated successfully. Aug 5 22:03:34.888669 kernel: BTRFS info (device vda6): last unmount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:03:34.895235 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 5 22:03:34.903576 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 5 22:03:34.964631 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:03:34.973512 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:03:34.996749 systemd-networkd[765]: lo: Link UP Aug 5 22:03:34.996760 systemd-networkd[765]: lo: Gained carrier Aug 5 22:03:34.997437 systemd-networkd[765]: Enumeration completed Aug 5 22:03:34.997536 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:03:34.997909 systemd-networkd[765]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:03:34.997913 systemd-networkd[765]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:03:34.998601 systemd-networkd[765]: eth0: Link UP Aug 5 22:03:34.998604 systemd-networkd[765]: eth0: Gained carrier Aug 5 22:03:34.998610 systemd-networkd[765]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:03:35.000078 systemd[1]: Reached target network.target - Network. Aug 5 22:03:35.015219 ignition[676]: Ignition 2.18.0 Aug 5 22:03:35.015225 ignition[676]: Stage: fetch-offline Aug 5 22:03:35.015271 ignition[676]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:03:35.015279 ignition[676]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:03:35.015400 ignition[676]: parsed url from cmdline: "" Aug 5 22:03:35.015404 ignition[676]: no config URL provided Aug 5 22:03:35.015408 ignition[676]: reading system config file "/usr/lib/ignition/user.ign" Aug 5 22:03:35.015416 ignition[676]: no config at "/usr/lib/ignition/user.ign" Aug 5 22:03:35.015449 ignition[676]: op(1): [started] loading QEMU firmware config module Aug 5 22:03:35.015455 ignition[676]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 5 22:03:35.023674 systemd-networkd[765]: eth0: DHCPv4 address 10.0.0.53/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:03:35.026817 ignition[676]: op(1): [finished] loading QEMU firmware config module Aug 5 22:03:35.026843 ignition[676]: QEMU firmware config was not found. Ignoring... Aug 5 22:03:35.048018 ignition[676]: parsing config with SHA512: f124d0b7cea6cc84df0440ec0a54e0bc85057f90ce972c5959a0ccc1e83bc0c24da0415a12cc67a1ea9a219406e1027687378d0e10b488ddbb06acbf83bd00c8 Aug 5 22:03:35.063299 unknown[676]: fetched base config from "system" Aug 5 22:03:35.063309 unknown[676]: fetched user config from "qemu" Aug 5 22:03:35.063632 ignition[676]: fetch-offline: fetch-offline passed Aug 5 22:03:35.065512 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:03:35.063720 ignition[676]: Ignition finished successfully Aug 5 22:03:35.067123 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 5 22:03:35.083577 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 5 22:03:35.095456 ignition[771]: Ignition 2.18.0 Aug 5 22:03:35.095467 ignition[771]: Stage: kargs Aug 5 22:03:35.095638 ignition[771]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:03:35.095648 ignition[771]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:03:35.098303 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 5 22:03:35.096384 ignition[771]: kargs: kargs passed Aug 5 22:03:35.096429 ignition[771]: Ignition finished successfully Aug 5 22:03:35.108554 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 5 22:03:35.119872 ignition[780]: Ignition 2.18.0 Aug 5 22:03:35.119882 ignition[780]: Stage: disks Aug 5 22:03:35.120039 ignition[780]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:03:35.122582 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 5 22:03:35.120049 ignition[780]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:03:35.124014 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 5 22:03:35.120820 ignition[780]: disks: disks passed Aug 5 22:03:35.126434 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 5 22:03:35.120867 ignition[780]: Ignition finished successfully Aug 5 22:03:35.127581 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:03:35.129386 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:03:35.131235 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:03:35.151563 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 5 22:03:35.163568 systemd-fsck[793]: ROOT: clean, 14/553520 files, 52654/553472 blocks Aug 5 22:03:35.167590 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 5 22:03:35.179487 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 5 22:03:35.226386 kernel: EXT4-fs (vda9): mounted filesystem 44c9fced-dca5-4347-a15f-96911c2e5e61 r/w with ordered data mode. Quota mode: none. Aug 5 22:03:35.226374 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 5 22:03:35.227635 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 5 22:03:35.245497 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:03:35.247429 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 5 22:03:35.248671 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 5 22:03:35.248721 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 5 22:03:35.248745 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:03:35.256083 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 5 22:03:35.259296 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 5 22:03:35.261736 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (801) Aug 5 22:03:35.263896 kernel: BTRFS info (device vda6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:03:35.263930 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:03:35.263949 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:03:35.268389 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:03:35.270265 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:03:35.316348 initrd-setup-root[826]: cut: /sysroot/etc/passwd: No such file or directory Aug 5 22:03:35.321242 initrd-setup-root[833]: cut: /sysroot/etc/group: No such file or directory Aug 5 22:03:35.325661 initrd-setup-root[840]: cut: /sysroot/etc/shadow: No such file or directory Aug 5 22:03:35.330052 initrd-setup-root[847]: cut: /sysroot/etc/gshadow: No such file or directory Aug 5 22:03:35.425871 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 5 22:03:35.439498 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 5 22:03:35.441867 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 5 22:03:35.447393 kernel: BTRFS info (device vda6): last unmount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:03:35.468614 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 5 22:03:35.472762 ignition[915]: INFO : Ignition 2.18.0 Aug 5 22:03:35.472762 ignition[915]: INFO : Stage: mount Aug 5 22:03:35.474245 ignition[915]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:03:35.474245 ignition[915]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:03:35.474245 ignition[915]: INFO : mount: mount passed Aug 5 22:03:35.474245 ignition[915]: INFO : Ignition finished successfully Aug 5 22:03:35.475260 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 5 22:03:35.486255 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 5 22:03:35.842831 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 5 22:03:35.852575 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:03:35.858373 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (928) Aug 5 22:03:35.858675 kernel: BTRFS info (device vda6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:03:35.860480 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:03:35.860515 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:03:35.863385 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:03:35.864417 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:03:35.884153 ignition[945]: INFO : Ignition 2.18.0 Aug 5 22:03:35.884153 ignition[945]: INFO : Stage: files Aug 5 22:03:35.885704 ignition[945]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:03:35.885704 ignition[945]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:03:35.885704 ignition[945]: DEBUG : files: compiled without relabeling support, skipping Aug 5 22:03:35.888977 ignition[945]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 5 22:03:35.888977 ignition[945]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 5 22:03:35.892584 ignition[945]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 5 22:03:35.893902 ignition[945]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 5 22:03:35.893902 ignition[945]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 5 22:03:35.893168 unknown[945]: wrote ssh authorized keys file for user: core Aug 5 22:03:35.897548 ignition[945]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/dev-container-script" Aug 5 22:03:35.897548 ignition[945]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/dev-container-script" Aug 5 22:03:35.897548 ignition[945]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/download-library.sh" Aug 5 22:03:35.897548 ignition[945]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/download-library.sh" Aug 5 22:03:35.897548 ignition[945]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/home/core/main-script" Aug 5 22:03:35.897548 ignition[945]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/home/core/main-script" Aug 5 22:03:35.897548 ignition[945]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:03:35.897548 ignition[945]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:03:35.897548 ignition[945]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Aug 5 22:03:35.912351 ignition[945]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:03:35.912351 ignition[945]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:03:35.912351 ignition[945]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Aug 5 22:03:35.912351 ignition[945]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Aug 5 22:03:35.941190 ignition[945]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:03:35.945439 ignition[945]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:03:35.946975 ignition[945]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Aug 5 22:03:35.946975 ignition[945]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:03:35.946975 ignition[945]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:03:35.946975 ignition[945]: INFO : files: files passed Aug 5 22:03:35.946975 ignition[945]: INFO : Ignition finished successfully Aug 5 22:03:35.948300 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 5 22:03:35.961598 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 5 22:03:35.963303 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 5 22:03:35.965225 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 5 22:03:35.966398 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 5 22:03:35.971539 initrd-setup-root-after-ignition[980]: grep: /sysroot/oem/oem-release: No such file or directory Aug 5 22:03:35.975103 initrd-setup-root-after-ignition[982]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:03:35.975103 initrd-setup-root-after-ignition[982]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:03:35.978036 initrd-setup-root-after-ignition[986]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:03:35.977220 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:03:35.979571 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 5 22:03:35.994546 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 5 22:03:36.014957 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 5 22:03:36.015072 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 5 22:03:36.017441 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 5 22:03:36.019228 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 5 22:03:36.020991 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 5 22:03:36.021831 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 5 22:03:36.037621 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:03:36.046587 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 5 22:03:36.054521 systemd[1]: Stopped target network.target - Network. Aug 5 22:03:36.055554 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:03:36.057342 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:03:36.059373 systemd[1]: Stopped target timers.target - Timer Units. Aug 5 22:03:36.061063 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 5 22:03:36.061187 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:03:36.063694 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 5 22:03:36.065642 systemd[1]: Stopped target basic.target - Basic System. Aug 5 22:03:36.067281 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 5 22:03:36.068932 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:03:36.070820 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 5 22:03:36.072699 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 5 22:03:36.074432 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:03:36.076326 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 5 22:03:36.078277 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 5 22:03:36.079946 systemd[1]: Stopped target swap.target - Swaps. Aug 5 22:03:36.081399 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 5 22:03:36.081549 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:03:36.083777 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:03:36.084880 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:03:36.086652 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 5 22:03:36.087447 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:03:36.088676 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 5 22:03:36.088793 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 5 22:03:36.091378 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 5 22:03:36.091496 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:03:36.093755 systemd[1]: Stopped target paths.target - Path Units. Aug 5 22:03:36.095218 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 5 22:03:36.096005 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:03:36.097305 systemd[1]: Stopped target slices.target - Slice Units. Aug 5 22:03:36.098980 systemd[1]: Stopped target sockets.target - Socket Units. Aug 5 22:03:36.100702 systemd[1]: iscsid.socket: Deactivated successfully. Aug 5 22:03:36.100795 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:03:36.102207 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 5 22:03:36.102289 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:03:36.103991 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 5 22:03:36.104104 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:03:36.106241 systemd[1]: ignition-files.service: Deactivated successfully. Aug 5 22:03:36.106343 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 5 22:03:36.119098 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 5 22:03:36.119992 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 5 22:03:36.120136 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:03:36.123223 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 5 22:03:36.124792 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 5 22:03:36.128145 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 5 22:03:36.129151 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 5 22:03:36.129287 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:03:36.134485 ignition[1006]: INFO : Ignition 2.18.0 Aug 5 22:03:36.134485 ignition[1006]: INFO : Stage: umount Aug 5 22:03:36.134485 ignition[1006]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:03:36.134485 ignition[1006]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:03:36.134485 ignition[1006]: INFO : umount: umount passed Aug 5 22:03:36.134485 ignition[1006]: INFO : Ignition finished successfully Aug 5 22:03:36.135518 systemd-networkd[765]: eth0: DHCPv6 lease lost Aug 5 22:03:36.136202 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 5 22:03:36.136322 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:03:36.140741 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 5 22:03:36.142445 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 5 22:03:36.145888 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 5 22:03:36.146633 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 5 22:03:36.146740 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 5 22:03:36.148648 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 5 22:03:36.148722 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 5 22:03:36.150185 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 5 22:03:36.150259 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 5 22:03:36.152948 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 5 22:03:36.153038 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 5 22:03:36.156669 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 5 22:03:36.156702 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:03:36.158279 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 5 22:03:36.158329 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 5 22:03:36.160024 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 5 22:03:36.160072 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 5 22:03:36.161716 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 5 22:03:36.161757 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 5 22:03:36.163313 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 5 22:03:36.163378 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 5 22:03:36.165295 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 5 22:03:36.165340 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 5 22:03:36.180487 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 5 22:03:36.181289 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 5 22:03:36.181389 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:03:36.183348 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 5 22:03:36.183409 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:03:36.185306 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 5 22:03:36.185352 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 5 22:03:36.187592 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 5 22:03:36.187634 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:03:36.189645 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:03:36.200830 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 5 22:03:36.200965 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 5 22:03:36.212135 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 5 22:03:36.212268 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:03:36.213851 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 5 22:03:36.213889 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 5 22:03:36.215508 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 5 22:03:36.215546 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:03:36.217842 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 5 22:03:36.217899 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:03:36.220599 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 5 22:03:36.220644 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 5 22:03:36.223257 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:03:36.223305 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:03:36.235551 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 5 22:03:36.236598 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 5 22:03:36.236663 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:03:36.238833 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:03:36.238882 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:03:36.240990 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 5 22:03:36.241085 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 5 22:03:36.243284 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 5 22:03:36.245476 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 5 22:03:36.256126 systemd[1]: Switching root. Aug 5 22:03:36.281569 systemd-journald[238]: Journal stopped Aug 5 22:03:36.904857 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Aug 5 22:03:36.904908 kernel: SELinux: policy capability network_peer_controls=1 Aug 5 22:03:36.904923 kernel: SELinux: policy capability open_perms=1 Aug 5 22:03:36.904936 kernel: SELinux: policy capability extended_socket_class=1 Aug 5 22:03:36.904946 kernel: SELinux: policy capability always_check_network=0 Aug 5 22:03:36.904955 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 5 22:03:36.904964 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 5 22:03:36.904974 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 5 22:03:36.904983 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 5 22:03:36.904995 kernel: audit: type=1403 audit(1722895416.345:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 5 22:03:36.905009 systemd[1]: Successfully loaded SELinux policy in 32.454ms. Aug 5 22:03:36.905027 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.350ms. Aug 5 22:03:36.905038 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) Aug 5 22:03:36.905049 systemd[1]: Detected virtualization kvm. Aug 5 22:03:36.905059 systemd[1]: Detected architecture arm64. Aug 5 22:03:36.905069 systemd[1]: Detected first boot. Aug 5 22:03:36.905080 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:03:36.905090 zram_generator::config[1050]: No configuration found. Aug 5 22:03:36.905101 systemd[1]: Populated /etc with preset unit settings. Aug 5 22:03:36.905114 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 5 22:03:36.905124 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 5 22:03:36.905134 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 5 22:03:36.905145 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 5 22:03:36.905156 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 5 22:03:36.905168 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 5 22:03:36.905181 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 5 22:03:36.905192 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 5 22:03:36.905202 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 5 22:03:36.905213 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 5 22:03:36.905224 systemd[1]: Created slice user.slice - User and Session Slice. Aug 5 22:03:36.905236 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:03:36.905247 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:03:36.905257 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 5 22:03:36.905269 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 5 22:03:36.905281 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 5 22:03:36.905291 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:03:36.905302 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Aug 5 22:03:36.905313 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:03:36.905323 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 5 22:03:36.905334 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 5 22:03:36.905345 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 5 22:03:36.905369 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 5 22:03:36.905382 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:03:36.905393 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:03:36.905404 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:03:36.905415 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:03:36.905425 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 5 22:03:36.905436 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 5 22:03:36.905447 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:03:36.905457 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:03:36.905470 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:03:36.905483 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 5 22:03:36.905493 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 5 22:03:36.905509 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 5 22:03:36.905521 systemd[1]: Mounting media.mount - External Media Directory... Aug 5 22:03:36.905532 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 5 22:03:36.905543 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 5 22:03:36.905554 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 5 22:03:36.905565 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). Aug 5 22:03:36.905578 systemd[1]: Reached target machines.target - Containers. Aug 5 22:03:36.905589 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 5 22:03:36.905600 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:03:36.905611 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:03:36.905621 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 5 22:03:36.905633 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:03:36.905643 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:03:36.905654 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:03:36.905666 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 5 22:03:36.905677 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:03:36.905688 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 5 22:03:36.905700 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 5 22:03:36.905711 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 5 22:03:36.905724 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 5 22:03:36.905736 systemd[1]: Stopped systemd-fsck-usr.service. Aug 5 22:03:36.905746 kernel: fuse: init (API version 7.39) Aug 5 22:03:36.905759 kernel: ACPI: bus type drm_connector registered Aug 5 22:03:36.905776 kernel: loop: module loaded Aug 5 22:03:36.905786 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:03:36.905798 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:03:36.905809 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 5 22:03:36.905820 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 5 22:03:36.905831 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:03:36.905842 systemd[1]: verity-setup.service: Deactivated successfully. Aug 5 22:03:36.905853 systemd[1]: Stopped verity-setup.service. Aug 5 22:03:36.905883 systemd-journald[1123]: Collecting audit messages is disabled. Aug 5 22:03:36.905906 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 5 22:03:36.905918 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 5 22:03:36.905929 systemd-journald[1123]: Journal started Aug 5 22:03:36.905951 systemd-journald[1123]: Runtime Journal (/run/log/journal/151dfd3bb6b747a0a08c021be3037482) is 5.9M, max 47.3M, 41.4M free. Aug 5 22:03:36.699732 systemd[1]: Queued start job for default target multi-user.target. Aug 5 22:03:36.715659 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Aug 5 22:03:36.716021 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 5 22:03:36.909892 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:03:36.910614 systemd[1]: Mounted media.mount - External Media Directory. Aug 5 22:03:36.911723 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 5 22:03:36.912901 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 5 22:03:36.914102 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 5 22:03:36.915321 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 5 22:03:36.916747 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:03:36.918202 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 5 22:03:36.918345 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 5 22:03:36.919814 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:03:36.919974 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:03:36.921330 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:03:36.921523 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:03:36.922784 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:03:36.922922 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:03:36.924681 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 5 22:03:36.924824 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 5 22:03:36.926019 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:03:36.926150 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:03:36.927674 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:03:36.929086 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 5 22:03:36.930582 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 5 22:03:36.942721 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 5 22:03:36.953488 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 5 22:03:36.955562 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 5 22:03:36.956657 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 5 22:03:36.956700 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:03:36.958635 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Aug 5 22:03:36.960782 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 5 22:03:36.962932 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 5 22:03:36.964048 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:03:36.965490 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 5 22:03:36.967470 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 5 22:03:36.968703 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:03:36.970575 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 5 22:03:36.974460 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:03:36.976628 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:03:36.977074 systemd-journald[1123]: Time spent on flushing to /var/log/journal/151dfd3bb6b747a0a08c021be3037482 is 35.564ms for 833 entries. Aug 5 22:03:36.977074 systemd-journald[1123]: System Journal (/var/log/journal/151dfd3bb6b747a0a08c021be3037482) is 8.0M, max 195.6M, 187.6M free. Aug 5 22:03:37.030120 systemd-journald[1123]: Received client request to flush runtime journal. Aug 5 22:03:37.030170 kernel: loop0: detected capacity change from 0 to 113672 Aug 5 22:03:37.030187 kernel: block loop0: the capability attribute has been deprecated. Aug 5 22:03:36.979866 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 22:03:36.983408 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 5 22:03:36.985811 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:03:36.988192 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 5 22:03:36.989485 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 5 22:03:36.992526 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 5 22:03:36.994922 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 5 22:03:36.999033 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 5 22:03:37.009599 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Aug 5 22:03:37.014582 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 5 22:03:37.017825 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:03:37.026927 udevadm[1172]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Aug 5 22:03:37.033145 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 5 22:03:37.033984 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Aug 5 22:03:37.036394 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 5 22:03:37.037877 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 5 22:03:37.040860 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 5 22:03:37.053596 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:03:37.058389 kernel: loop1: detected capacity change from 0 to 59688 Aug 5 22:03:37.075545 systemd-tmpfiles[1181]: ACLs are not supported, ignoring. Aug 5 22:03:37.075563 systemd-tmpfiles[1181]: ACLs are not supported, ignoring. Aug 5 22:03:37.079557 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:03:37.087385 kernel: loop2: detected capacity change from 0 to 113672 Aug 5 22:03:37.091459 kernel: loop3: detected capacity change from 0 to 59688 Aug 5 22:03:37.094337 (sd-merge)[1185]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Aug 5 22:03:37.094706 (sd-merge)[1185]: Merged extensions into '/usr'. Aug 5 22:03:37.098253 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 22:03:37.105557 systemd[1]: Starting ensure-sysext.service... Aug 5 22:03:37.108596 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:03:37.114278 systemd[1]: Reloading requested from client PID 1187 ('systemctl') (unit ensure-sysext.service)... Aug 5 22:03:37.114294 systemd[1]: Reloading... Aug 5 22:03:37.149313 systemd-tmpfiles[1188]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 5 22:03:37.149609 systemd-tmpfiles[1188]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 5 22:03:37.150392 systemd-tmpfiles[1188]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 5 22:03:37.150651 systemd-tmpfiles[1188]: ACLs are not supported, ignoring. Aug 5 22:03:37.150698 systemd-tmpfiles[1188]: ACLs are not supported, ignoring. Aug 5 22:03:37.157396 systemd-tmpfiles[1188]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:03:37.157405 systemd-tmpfiles[1188]: Skipping /boot Aug 5 22:03:37.167889 systemd-tmpfiles[1188]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:03:37.169598 systemd-tmpfiles[1188]: Skipping /boot Aug 5 22:03:37.171385 zram_generator::config[1216]: No configuration found. Aug 5 22:03:37.256551 ldconfig[1155]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 5 22:03:37.265700 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Aug 5 22:03:37.303978 systemd[1]: Reloading finished in 189 ms. Aug 5 22:03:37.336399 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 5 22:03:37.348093 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:03:37.356784 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:03:37.359447 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 5 22:03:37.363536 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 5 22:03:37.368736 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:03:37.373660 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 5 22:03:37.377436 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:03:37.382592 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:03:37.386956 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:03:37.398666 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:03:37.399777 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:03:37.400561 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:03:37.402400 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:03:37.404168 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:03:37.404289 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:03:37.409169 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:03:37.412848 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 5 22:03:37.416312 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 5 22:03:37.418187 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:03:37.419076 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:03:37.424204 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 5 22:03:37.427749 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:03:37.438810 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:03:37.443649 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:03:37.454896 augenrules[1280]: No rules Aug 5 22:03:37.457309 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:03:37.458446 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:03:37.459087 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 5 22:03:37.462420 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:03:37.464019 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 5 22:03:37.465748 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:03:37.465878 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:03:37.467379 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:03:37.467513 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:03:37.469170 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:03:37.469302 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:03:37.482946 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 5 22:03:37.487334 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:03:37.488545 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:03:37.490635 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:03:37.495554 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:03:37.497584 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:03:37.498645 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:03:37.499911 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:03:37.502897 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 5 22:03:37.504004 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). Aug 5 22:03:37.504597 systemd[1]: Finished ensure-sysext.service. Aug 5 22:03:37.511308 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:03:37.511536 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:03:37.512958 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:03:37.513092 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:03:37.514486 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:03:37.514634 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:03:37.516064 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:03:37.516193 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:03:37.517750 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 5 22:03:37.524197 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:03:37.524274 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:03:37.531547 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 5 22:03:37.532208 systemd-resolved[1255]: Positive Trust Anchors: Aug 5 22:03:37.532231 systemd-resolved[1255]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:03:37.532260 systemd-resolved[1255]: 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 Aug 5 22:03:37.537134 systemd-udevd[1303]: Using default interface naming scheme 'v255'. Aug 5 22:03:37.539056 systemd-resolved[1255]: Defaulting to hostname 'linux'. Aug 5 22:03:37.545791 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:03:37.546969 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:03:37.556721 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:03:37.568593 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:03:37.579477 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 5 22:03:37.581186 systemd[1]: Reached target time-set.target - System Time Set. Aug 5 22:03:37.598755 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Aug 5 22:03:37.610417 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1325) Aug 5 22:03:37.611998 systemd-networkd[1321]: lo: Link UP Aug 5 22:03:37.612007 systemd-networkd[1321]: lo: Gained carrier Aug 5 22:03:37.614005 systemd-networkd[1321]: Enumeration completed Aug 5 22:03:37.614099 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:03:37.615795 systemd[1]: Reached target network.target - Network. Aug 5 22:03:37.616308 systemd-networkd[1321]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:03:37.616311 systemd-networkd[1321]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:03:37.616922 systemd-networkd[1321]: eth0: Link UP Aug 5 22:03:37.616931 systemd-networkd[1321]: eth0: Gained carrier Aug 5 22:03:37.616944 systemd-networkd[1321]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:03:37.624522 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 5 22:03:37.626384 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1323) Aug 5 22:03:37.628444 systemd-networkd[1321]: eth0: DHCPv4 address 10.0.0.53/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:03:37.629666 systemd-timesyncd[1311]: Network configuration changed, trying to establish connection. Aug 5 22:03:37.629700 systemd-networkd[1321]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:03:37.630263 systemd-timesyncd[1311]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 5 22:03:37.630307 systemd-timesyncd[1311]: Initial clock synchronization to Mon 2024-08-05 22:03:37.469146 UTC. Aug 5 22:03:37.660209 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:03:37.666544 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 5 22:03:37.678026 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:03:37.682863 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 5 22:03:37.688117 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 5 22:03:37.690750 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 5 22:03:37.710734 lvm[1349]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:03:37.727967 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:03:37.764406 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 5 22:03:37.765830 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:03:37.766918 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:03:37.768047 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 5 22:03:37.769257 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Aug 5 22:03:37.770660 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 5 22:03:37.771899 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 5 22:03:37.773079 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 5 22:03:37.774264 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 5 22:03:37.774300 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:03:37.775185 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:03:37.776890 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 5 22:03:37.779192 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 22:03:37.789409 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 5 22:03:37.791549 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 5 22:03:37.793020 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 22:03:37.794176 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:03:37.795120 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:03:37.796061 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:03:37.796093 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:03:37.797007 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 22:03:37.798967 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 5 22:03:37.800200 lvm[1357]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:03:37.802602 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 5 22:03:37.805801 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 5 22:03:37.806999 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). Aug 5 22:03:37.811835 jq[1360]: false Aug 5 22:03:37.812036 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 5 22:03:37.817470 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 5 22:03:37.820387 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 5 22:03:37.827378 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 5 22:03:37.829585 extend-filesystems[1361]: Found loop2 Aug 5 22:03:37.829585 extend-filesystems[1361]: Found loop3 Aug 5 22:03:37.829585 extend-filesystems[1361]: Found vda Aug 5 22:03:37.829585 extend-filesystems[1361]: Found vda1 Aug 5 22:03:37.829585 extend-filesystems[1361]: Found vda2 Aug 5 22:03:37.829585 extend-filesystems[1361]: Found vda3 Aug 5 22:03:37.829585 extend-filesystems[1361]: Found usr Aug 5 22:03:37.829585 extend-filesystems[1361]: Found vda4 Aug 5 22:03:37.829585 extend-filesystems[1361]: Found vda6 Aug 5 22:03:37.829585 extend-filesystems[1361]: Found vda7 Aug 5 22:03:37.829585 extend-filesystems[1361]: Found vda9 Aug 5 22:03:37.829585 extend-filesystems[1361]: Checking size of /dev/vda9 Aug 5 22:03:37.829537 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 5 22:03:37.848025 dbus-daemon[1359]: [system] SELinux support is enabled Aug 5 22:03:37.849449 extend-filesystems[1361]: Resized partition /dev/vda9 Aug 5 22:03:37.829947 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 5 22:03:37.852989 extend-filesystems[1382]: resize2fs 1.47.0 (5-Feb-2023) Aug 5 22:03:37.832598 systemd[1]: Starting update-engine.service - Update Engine... Aug 5 22:03:37.836512 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 5 22:03:37.856750 jq[1377]: true Aug 5 22:03:37.868812 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Aug 5 22:03:37.840649 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 5 22:03:37.843266 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 5 22:03:37.843475 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 5 22:03:37.869107 jq[1383]: true Aug 5 22:03:37.843759 systemd[1]: motdgen.service: Deactivated successfully. Aug 5 22:03:37.843892 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 5 22:03:37.848677 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 5 22:03:37.851909 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 5 22:03:37.852063 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 5 22:03:37.880390 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1316) Aug 5 22:03:37.881381 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Aug 5 22:03:37.881569 (ntainerd)[1391]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 5 22:03:37.883925 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). Aug 5 22:03:37.883950 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 5 22:03:37.885458 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). Aug 5 22:03:37.885475 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 5 22:03:37.902736 extend-filesystems[1382]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Aug 5 22:03:37.902736 extend-filesystems[1382]: old_desc_blocks = 1, new_desc_blocks = 1 Aug 5 22:03:37.902736 extend-filesystems[1382]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Aug 5 22:03:37.906703 extend-filesystems[1361]: Resized filesystem in /dev/vda9 Aug 5 22:03:37.905715 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 5 22:03:37.905881 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 5 22:03:37.923218 update_engine[1373]: I0805 22:03:37.922681 1373 main.cc:92] Flatcar Update Engine starting Aug 5 22:03:37.926597 systemd[1]: Started update-engine.service - Update Engine. Aug 5 22:03:37.926740 update_engine[1373]: I0805 22:03:37.926646 1373 update_check_scheduler.cc:74] Next update check in 3m17s Aug 5 22:03:37.934089 systemd-logind[1368]: Watching system buttons on /dev/input/event0 (Power Button) Aug 5 22:03:37.934696 systemd-logind[1368]: New seat seat0. Aug 5 22:03:37.936763 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 5 22:03:37.939018 systemd[1]: Started systemd-logind.service - User Login Management. Aug 5 22:03:37.953924 bash[1410]: Updated "/home/core/.ssh/authorized_keys" Aug 5 22:03:37.957410 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 5 22:03:37.959938 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 5 22:03:37.990095 locksmithd[1411]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 5 22:03:38.086976 containerd[1391]: time="2024-08-05T22:03:38.086829378Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Aug 5 22:03:38.110755 containerd[1391]: time="2024-08-05T22:03:38.110714533Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 22:03:38.110755 containerd[1391]: time="2024-08-05T22:03:38.110752827Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:03:38.112003 containerd[1391]: time="2024-08-05T22:03:38.111974384Z" 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.43-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:03:38.112003 containerd[1391]: time="2024-08-05T22:03:38.112002370Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:03:38.112214 containerd[1391]: time="2024-08-05T22:03:38.112186626Z" 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 Aug 5 22:03:38.112245 containerd[1391]: time="2024-08-05T22:03:38.112213397Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 22:03:38.112302 containerd[1391]: time="2024-08-05T22:03:38.112288338Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 22:03:38.112366 containerd[1391]: time="2024-08-05T22:03:38.112336666Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:03:38.112390 containerd[1391]: time="2024-08-05T22:03:38.112372176Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 22:03:38.112442 containerd[1391]: time="2024-08-05T22:03:38.112429676Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:03:38.112622 containerd[1391]: time="2024-08-05T22:03:38.112606250Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 22:03:38.112642 containerd[1391]: time="2024-08-05T22:03:38.112628826Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 22:03:38.112642 containerd[1391]: time="2024-08-05T22:03:38.112639096Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:03:38.112743 containerd[1391]: time="2024-08-05T22:03:38.112726579Z" 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 Aug 5 22:03:38.112767 containerd[1391]: time="2024-08-05T22:03:38.112742257Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 22:03:38.112801 containerd[1391]: time="2024-08-05T22:03:38.112787253Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 22:03:38.112825 containerd[1391]: time="2024-08-05T22:03:38.112803206Z" level=info msg="metadata content store policy set" policy=shared Aug 5 22:03:38.115739 containerd[1391]: time="2024-08-05T22:03:38.115706981Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 22:03:38.115739 containerd[1391]: time="2024-08-05T22:03:38.115737906Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 22:03:38.115802 containerd[1391]: time="2024-08-05T22:03:38.115749665Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 22:03:38.115880 containerd[1391]: time="2024-08-05T22:03:38.115866819Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 22:03:38.115908 containerd[1391]: time="2024-08-05T22:03:38.115885045Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 22:03:38.115908 containerd[1391]: time="2024-08-05T22:03:38.115895785Z" level=info msg="NRI interface is disabled by configuration." Aug 5 22:03:38.115941 containerd[1391]: time="2024-08-05T22:03:38.115906916Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 22:03:38.116046 containerd[1391]: time="2024-08-05T22:03:38.116018936Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 22:03:38.116046 containerd[1391]: time="2024-08-05T22:03:38.116041512Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 22:03:38.116095 containerd[1391]: time="2024-08-05T22:03:38.116055270Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 22:03:38.116095 containerd[1391]: time="2024-08-05T22:03:38.116068283Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 22:03:38.116095 containerd[1391]: time="2024-08-05T22:03:38.116081139Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 22:03:38.116152 containerd[1391]: time="2024-08-05T22:03:38.116097209Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 22:03:38.116152 containerd[1391]: time="2024-08-05T22:03:38.116110026Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 22:03:38.116152 containerd[1391]: time="2024-08-05T22:03:38.116129074Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 22:03:38.116152 containerd[1391]: time="2024-08-05T22:03:38.116143616Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 22:03:38.116221 containerd[1391]: time="2024-08-05T22:03:38.116160352Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 22:03:38.116221 containerd[1391]: time="2024-08-05T22:03:38.116172581Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 22:03:38.116221 containerd[1391]: time="2024-08-05T22:03:38.116183203Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 22:03:38.116285 containerd[1391]: time="2024-08-05T22:03:38.116269472Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 22:03:38.116603 containerd[1391]: time="2024-08-05T22:03:38.116572646Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 22:03:38.116643 containerd[1391]: time="2024-08-05T22:03:38.116606158Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.116643 containerd[1391]: time="2024-08-05T22:03:38.116621288Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 22:03:38.116683 containerd[1391]: time="2024-08-05T22:03:38.116642022Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 22:03:38.117303 containerd[1391]: time="2024-08-05T22:03:38.117265460Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117303 containerd[1391]: time="2024-08-05T22:03:38.117296072Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117354 containerd[1391]: time="2024-08-05T22:03:38.117310888Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117385 containerd[1391]: time="2024-08-05T22:03:38.117323469Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117412 containerd[1391]: time="2024-08-05T22:03:38.117383595Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117412 containerd[1391]: time="2024-08-05T22:03:38.117397039Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117412 containerd[1391]: time="2024-08-05T22:03:38.117408484Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117461 containerd[1391]: time="2024-08-05T22:03:38.117419066Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117461 containerd[1391]: time="2024-08-05T22:03:38.117431374Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 22:03:38.117596 containerd[1391]: time="2024-08-05T22:03:38.117564206Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117596 containerd[1391]: time="2024-08-05T22:03:38.117589409Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117646 containerd[1391]: time="2024-08-05T22:03:38.117601402Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117646 containerd[1391]: time="2024-08-05T22:03:38.117614258Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117646 containerd[1391]: time="2024-08-05T22:03:38.117625899Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117646 containerd[1391]: time="2024-08-05T22:03:38.117638442Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117714 containerd[1391]: time="2024-08-05T22:03:38.117649652Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.117714 containerd[1391]: time="2024-08-05T22:03:38.117660274Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 22:03:38.118076 containerd[1391]: time="2024-08-05T22:03:38.118009895Z" 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:true 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 ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} 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}" Aug 5 22:03:38.118188 containerd[1391]: time="2024-08-05T22:03:38.118071510Z" level=info msg="Connect containerd service" Aug 5 22:03:38.118188 containerd[1391]: time="2024-08-05T22:03:38.118126108Z" level=info msg="using legacy CRI server" Aug 5 22:03:38.118188 containerd[1391]: time="2024-08-05T22:03:38.118134222Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 22:03:38.118289 containerd[1391]: time="2024-08-05T22:03:38.118261959Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 22:03:38.118962 containerd[1391]: time="2024-08-05T22:03:38.118924005Z" 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" Aug 5 22:03:38.118994 containerd[1391]: time="2024-08-05T22:03:38.118981191Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 22:03:38.119014 containerd[1391]: time="2024-08-05T22:03:38.119000122Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Aug 5 22:03:38.119014 containerd[1391]: time="2024-08-05T22:03:38.119010430Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 22:03:38.119049 containerd[1391]: time="2024-08-05T22:03:38.119021797Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Aug 5 22:03:38.119160 containerd[1391]: time="2024-08-05T22:03:38.119118256Z" level=info msg="Start subscribing containerd event" Aug 5 22:03:38.119197 containerd[1391]: time="2024-08-05T22:03:38.119168544Z" level=info msg="Start recovering state" Aug 5 22:03:38.119242 containerd[1391]: time="2024-08-05T22:03:38.119229022Z" level=info msg="Start event monitor" Aug 5 22:03:38.119263 containerd[1391]: time="2024-08-05T22:03:38.119243446Z" level=info msg="Start snapshots syncer" Aug 5 22:03:38.119263 containerd[1391]: time="2024-08-05T22:03:38.119252265Z" level=info msg="Start cni network conf syncer for default" Aug 5 22:03:38.119263 containerd[1391]: time="2024-08-05T22:03:38.119259045Z" level=info msg="Start streaming server" Aug 5 22:03:38.119640 containerd[1391]: time="2024-08-05T22:03:38.119610509Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 22:03:38.119687 containerd[1391]: time="2024-08-05T22:03:38.119674201Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 22:03:38.119746 containerd[1391]: time="2024-08-05T22:03:38.119733542Z" level=info msg="containerd successfully booted in 0.034204s" Aug 5 22:03:38.119832 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 22:03:38.559181 sshd_keygen[1378]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 5 22:03:38.577363 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 5 22:03:38.597079 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 5 22:03:38.602510 systemd[1]: issuegen.service: Deactivated successfully. Aug 5 22:03:38.604404 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 5 22:03:38.606978 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 5 22:03:38.621074 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 5 22:03:38.625918 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 5 22:03:38.628175 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Aug 5 22:03:38.629724 systemd[1]: Reached target getty.target - Login Prompts. Aug 5 22:03:38.833590 systemd-networkd[1321]: eth0: Gained IPv6LL Aug 5 22:03:38.835904 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 5 22:03:38.837835 systemd[1]: Reached target network-online.target - Network is Online. Aug 5 22:03:38.848642 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 5 22:03:38.850973 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 5 22:03:38.865600 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 5 22:03:38.865804 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 5 22:03:38.867272 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 5 22:03:38.870149 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 5 22:03:38.871576 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 5 22:03:38.872970 systemd[1]: Startup finished in 599ms (kernel) + 3.630s (initrd) + 2.561s (userspace) = 6.790s. Aug 5 22:03:45.722986 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 5 22:03:45.738966 systemd[1]: Started sshd@0-10.0.0.53:22-10.0.0.1:57748.service - OpenSSH per-connection server daemon (10.0.0.1:57748). Aug 5 22:03:45.789733 sshd[1461]: Accepted publickey for core from 10.0.0.1 port 57748 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:03:45.791483 sshd[1461]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:03:45.798615 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 5 22:03:45.810606 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 5 22:03:45.812463 systemd-logind[1368]: New session 1 of user core. Aug 5 22:03:45.819609 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 5 22:03:45.821782 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 5 22:03:45.828661 (systemd)[1465]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:03:45.898827 systemd[1465]: Queued start job for default target default.target. Aug 5 22:03:45.909241 systemd[1465]: Created slice app.slice - User Application Slice. Aug 5 22:03:45.909268 systemd[1465]: Reached target paths.target - Paths. Aug 5 22:03:45.909280 systemd[1465]: Reached target timers.target - Timers. Aug 5 22:03:45.910485 systemd[1465]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 5 22:03:45.920217 systemd[1465]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 5 22:03:45.920284 systemd[1465]: Reached target sockets.target - Sockets. Aug 5 22:03:45.920296 systemd[1465]: Reached target basic.target - Basic System. Aug 5 22:03:45.920332 systemd[1465]: Reached target default.target - Main User Target. Aug 5 22:03:45.920394 systemd[1465]: Startup finished in 86ms. Aug 5 22:03:45.920667 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 5 22:03:45.921966 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 5 22:03:45.983649 systemd[1]: Started sshd@1-10.0.0.53:22-10.0.0.1:57762.service - OpenSSH per-connection server daemon (10.0.0.1:57762). Aug 5 22:03:46.017086 sshd[1476]: Accepted publickey for core from 10.0.0.1 port 57762 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:03:46.018336 sshd[1476]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:03:46.021897 systemd-logind[1368]: New session 2 of user core. Aug 5 22:03:46.031489 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 5 22:03:46.083124 sshd[1476]: pam_unix(sshd:session): session closed for user core Aug 5 22:03:46.092595 systemd[1]: sshd@1-10.0.0.53:22-10.0.0.1:57762.service: Deactivated successfully. Aug 5 22:03:46.096021 systemd[1]: session-2.scope: Deactivated successfully. Aug 5 22:03:46.098151 systemd-logind[1368]: Session 2 logged out. Waiting for processes to exit. Aug 5 22:03:46.098603 systemd[1]: Started sshd@2-10.0.0.53:22-10.0.0.1:57764.service - OpenSSH per-connection server daemon (10.0.0.1:57764). Aug 5 22:03:46.099913 systemd-logind[1368]: Removed session 2. Aug 5 22:03:46.133061 sshd[1483]: Accepted publickey for core from 10.0.0.1 port 57764 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:03:46.134326 sshd[1483]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:03:46.137955 systemd-logind[1368]: New session 3 of user core. Aug 5 22:03:46.155548 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 5 22:03:46.205679 sshd[1483]: pam_unix(sshd:session): session closed for user core Aug 5 22:03:46.223858 systemd[1]: sshd@2-10.0.0.53:22-10.0.0.1:57764.service: Deactivated successfully. Aug 5 22:03:46.225238 systemd[1]: session-3.scope: Deactivated successfully. Aug 5 22:03:46.227560 systemd-logind[1368]: Session 3 logged out. Waiting for processes to exit. Aug 5 22:03:46.236603 systemd[1]: Started sshd@3-10.0.0.53:22-10.0.0.1:57774.service - OpenSSH per-connection server daemon (10.0.0.1:57774). Aug 5 22:03:46.237568 systemd-logind[1368]: Removed session 3. Aug 5 22:03:46.267741 sshd[1490]: Accepted publickey for core from 10.0.0.1 port 57774 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:03:46.268890 sshd[1490]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:03:46.272954 systemd-logind[1368]: New session 4 of user core. Aug 5 22:03:46.286505 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 5 22:03:46.338458 sshd[1490]: pam_unix(sshd:session): session closed for user core Aug 5 22:03:46.346793 systemd[1]: sshd@3-10.0.0.53:22-10.0.0.1:57774.service: Deactivated successfully. Aug 5 22:03:46.349741 systemd[1]: session-4.scope: Deactivated successfully. Aug 5 22:03:46.351009 systemd-logind[1368]: Session 4 logged out. Waiting for processes to exit. Aug 5 22:03:46.352255 systemd[1]: Started sshd@4-10.0.0.53:22-10.0.0.1:57784.service - OpenSSH per-connection server daemon (10.0.0.1:57784). Aug 5 22:03:46.352999 systemd-logind[1368]: Removed session 4. Aug 5 22:03:46.387212 sshd[1497]: Accepted publickey for core from 10.0.0.1 port 57784 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:03:46.388481 sshd[1497]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:03:46.392579 systemd-logind[1368]: New session 5 of user core. Aug 5 22:03:46.403520 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 5 22:03:46.461402 sudo[1500]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Aug 5 22:03:46.461644 sudo[1500]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:03:46.476121 sudo[1500]: pam_unix(sudo:session): session closed for user root Aug 5 22:03:46.477866 sshd[1497]: pam_unix(sshd:session): session closed for user core Aug 5 22:03:46.486733 systemd[1]: sshd@4-10.0.0.53:22-10.0.0.1:57784.service: Deactivated successfully. Aug 5 22:03:46.488173 systemd[1]: session-5.scope: Deactivated successfully. Aug 5 22:03:46.491524 systemd-logind[1368]: Session 5 logged out. Waiting for processes to exit. Aug 5 22:03:46.502748 systemd[1]: Started sshd@5-10.0.0.53:22-10.0.0.1:57788.service - OpenSSH per-connection server daemon (10.0.0.1:57788). Aug 5 22:03:46.503518 systemd-logind[1368]: Removed session 5. Aug 5 22:03:46.534198 sshd[1505]: Accepted publickey for core from 10.0.0.1 port 57788 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:03:46.535662 sshd[1505]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:03:46.539530 systemd-logind[1368]: New session 6 of user core. Aug 5 22:03:46.551527 systemd[1]: Started session-6.scope - Session 6 of User core. Aug 5 22:03:46.602522 sudo[1509]: 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 Aug 5 22:03:46.602757 sudo[1509]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:03:46.605840 sudo[1509]: pam_unix(sudo:session): session closed for user root Aug 5 22:03:46.610568 sudo[1508]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Aug 5 22:03:46.610828 sudo[1508]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:03:46.628710 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Aug 5 22:03:46.629969 auditctl[1512]: No rules Aug 5 22:03:46.630274 systemd[1]: audit-rules.service: Deactivated successfully. Aug 5 22:03:46.630448 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Aug 5 22:03:46.634671 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:03:46.656236 augenrules[1530]: No rules Aug 5 22:03:46.657449 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:03:46.658506 sudo[1508]: pam_unix(sudo:session): session closed for user root Aug 5 22:03:46.660098 sshd[1505]: pam_unix(sshd:session): session closed for user core Aug 5 22:03:46.672792 systemd[1]: sshd@5-10.0.0.53:22-10.0.0.1:57788.service: Deactivated successfully. Aug 5 22:03:46.674239 systemd[1]: session-6.scope: Deactivated successfully. Aug 5 22:03:46.675456 systemd-logind[1368]: Session 6 logged out. Waiting for processes to exit. Aug 5 22:03:46.689833 systemd[1]: Started sshd@6-10.0.0.53:22-10.0.0.1:57790.service - OpenSSH per-connection server daemon (10.0.0.1:57790). Aug 5 22:03:46.690712 systemd-logind[1368]: Removed session 6. Aug 5 22:03:46.720129 sshd[1538]: Accepted publickey for core from 10.0.0.1 port 57790 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:03:46.721420 sshd[1538]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:03:46.725047 systemd-logind[1368]: New session 7 of user core. Aug 5 22:03:46.740534 systemd[1]: Started session-7.scope - Session 7 of User core. Aug 5 22:04:08.806236 sudo[1557]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemd-nspawn --console=pipe --setenv=PORTAGE_BINHOST=http://bincache.flatcar-linux.net/boards/arm64-usr/3975.2.0/pkgs --setenv=EXPECTED_VERSION=3975.2.0 --bind-ro=/lib/modules --bind-ro=/home/core/dev-container-script --bind=/home/core/dev-container-workdir-13635/src:/usr/src --bind=/home/core/dev-container-workdir-13635/tmp:/var/tmp --image=flatcar_developer_container.bin --machine=flatcar-developer-container /bin/bash /home/core/dev-container-script Aug 5 22:04:08.806507 sudo[1557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:04:08.826386 kernel: loop4: detected capacity change from 0 to 12644352 Aug 5 22:04:08.826470 kernel: loop4: p9 Aug 5 22:04:09.010808 kernel: EXT4-fs (loop4p9): mounted filesystem 5a75ac77-191e-4297-89ad-759578e06ae6 r/w with ordered data mode. Quota mode: none. Aug 5 22:04:09.018670 dbus-daemon[1359]: [system] Activating via systemd: service name='org.freedesktop.machine1' unit='dbus-org.freedesktop.machine1.service' requested by ':1.29' (uid=0 pid=1558 comm="systemd-nspawn --console=pipe --setenv=PORTAGE_BIN" label="system_u:system_r:kernel_t:s0") Aug 5 22:04:09.021837 systemd[1]: Created slice machine.slice - Virtual Machine and Container Slice. Aug 5 22:04:09.021958 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). Aug 5 22:04:09.032643 systemd[1]: Starting systemd-machined.service - Virtual Machine and Container Registration Service... Aug 5 22:04:09.048398 dbus-daemon[1359]: [system] Successfully activated service 'org.freedesktop.machine1' Aug 5 22:04:09.048851 systemd[1]: Started systemd-machined.service - Virtual Machine and Container Registration Service. Aug 5 22:04:09.051632 systemd-machined[1568]: New machine flatcar-developer-container. Aug 5 22:04:09.062571 systemd[1]: Started machine-flatcar\x2ddeveloper\x2dcontainer.scope - Container flatcar-developer-container. Aug 5 22:04:09.067750 systemd-resolved[1255]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 22:04:23.097982 update_engine[1373]: I0805 22:04:23.097427 1373 update_attempter.cc:509] Updating boot flags... Aug 5 22:04:23.142441 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (3831) Aug 5 22:04:23.168478 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (3830) Aug 5 22:06:29.565414 kernel: EXT4-fs (loop4p9): unmounting filesystem 5a75ac77-191e-4297-89ad-759578e06ae6. Aug 5 22:06:29.583100 systemd[1]: machine-flatcar\x2ddeveloper\x2dcontainer.scope: Deactivated successfully. Aug 5 22:06:29.589605 systemd[1]: machine-flatcar\x2ddeveloper\x2dcontainer.scope: Consumed 3min 36.639s CPU time. Aug 5 22:06:29.597589 systemd-machined[1568]: Machine flatcar-developer-container terminated. Aug 5 22:06:29.672431 sudo[1557]: pam_unix(sudo:session): session closed for user root Aug 5 22:06:29.688431 sshd[1538]: pam_unix(sshd:session): session closed for user core Aug 5 22:06:29.695842 systemd[1]: sshd@6-10.0.0.53:22-10.0.0.1:57790.service: Deactivated successfully. Aug 5 22:06:29.697353 systemd[1]: session-7.scope: Deactivated successfully. Aug 5 22:06:29.698487 systemd[1]: session-7.scope: Consumed 1min 274ms CPU time. Aug 5 22:06:29.698967 systemd-logind[1368]: Session 7 logged out. Waiting for processes to exit. Aug 5 22:06:29.700140 systemd-logind[1368]: Removed session 7.