Sep 4 17:37:33.913904 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Sep 4 17:37:33.913925 kernel: Linux version 6.6.48-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Wed Sep 4 15:58:01 -00 2024 Sep 4 17:37:33.913935 kernel: KASLR enabled Sep 4 17:37:33.913941 kernel: efi: EFI v2.7 by EDK II Sep 4 17:37:33.913947 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb8fd018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 Sep 4 17:37:33.913952 kernel: random: crng init done Sep 4 17:37:33.913960 kernel: ACPI: Early table checksum verification disabled Sep 4 17:37:33.913966 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Sep 4 17:37:33.913972 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Sep 4 17:37:33.913979 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:33.913985 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:33.913991 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:33.913997 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:33.914003 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:33.914011 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:33.914019 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:33.914025 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:33.914031 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:33.914038 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Sep 4 17:37:33.914044 kernel: NUMA: Failed to initialise from firmware Sep 4 17:37:33.914050 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Sep 4 17:37:33.914057 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Sep 4 17:37:33.914063 kernel: Zone ranges: Sep 4 17:37:33.914069 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Sep 4 17:37:33.914076 kernel: DMA32 empty Sep 4 17:37:33.914083 kernel: Normal empty Sep 4 17:37:33.914090 kernel: Movable zone start for each node Sep 4 17:37:33.914096 kernel: Early memory node ranges Sep 4 17:37:33.914102 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Sep 4 17:37:33.914109 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Sep 4 17:37:33.914115 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Sep 4 17:37:33.914121 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Sep 4 17:37:33.914128 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Sep 4 17:37:33.914143 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Sep 4 17:37:33.914150 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Sep 4 17:37:33.914157 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Sep 4 17:37:33.914163 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Sep 4 17:37:33.914172 kernel: psci: probing for conduit method from ACPI. Sep 4 17:37:33.914179 kernel: psci: PSCIv1.1 detected in firmware. Sep 4 17:37:33.914185 kernel: psci: Using standard PSCI v0.2 function IDs Sep 4 17:37:33.914194 kernel: psci: Trusted OS migration not required Sep 4 17:37:33.914201 kernel: psci: SMC Calling Convention v1.1 Sep 4 17:37:33.914221 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Sep 4 17:37:33.914229 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Sep 4 17:37:33.914236 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Sep 4 17:37:33.914243 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 4 17:37:33.914250 kernel: Detected PIPT I-cache on CPU0 Sep 4 17:37:33.914257 kernel: CPU features: detected: GIC system register CPU interface Sep 4 17:37:33.914264 kernel: CPU features: detected: Hardware dirty bit management Sep 4 17:37:33.914271 kernel: CPU features: detected: Spectre-v4 Sep 4 17:37:33.914277 kernel: CPU features: detected: Spectre-BHB Sep 4 17:37:33.914284 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 4 17:37:33.914291 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 4 17:37:33.914307 kernel: CPU features: detected: ARM erratum 1418040 Sep 4 17:37:33.914314 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 4 17:37:33.914321 kernel: alternatives: applying boot alternatives Sep 4 17:37:33.914329 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=28a986328b36e7de6a755f88bb335afbeb3e3932bc9a20c5f8e57b952c2d23a9 Sep 4 17:37:33.914336 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 4 17:37:33.914343 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 4 17:37:33.914350 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 4 17:37:33.914357 kernel: Fallback order for Node 0: 0 Sep 4 17:37:33.914365 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Sep 4 17:37:33.914372 kernel: Policy zone: DMA Sep 4 17:37:33.914378 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 4 17:37:33.914387 kernel: software IO TLB: area num 4. Sep 4 17:37:33.914393 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Sep 4 17:37:33.914401 kernel: Memory: 2386596K/2572288K available (10240K kernel code, 2184K rwdata, 8084K rodata, 39296K init, 897K bss, 185692K reserved, 0K cma-reserved) Sep 4 17:37:33.914408 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 4 17:37:33.914415 kernel: trace event string verifier disabled Sep 4 17:37:33.914421 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 4 17:37:33.914429 kernel: rcu: RCU event tracing is enabled. Sep 4 17:37:33.914436 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 4 17:37:33.914443 kernel: Trampoline variant of Tasks RCU enabled. Sep 4 17:37:33.914449 kernel: Tracing variant of Tasks RCU enabled. Sep 4 17:37:33.914456 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 4 17:37:33.914463 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 4 17:37:33.914472 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 4 17:37:33.914478 kernel: GICv3: 256 SPIs implemented Sep 4 17:37:33.914485 kernel: GICv3: 0 Extended SPIs implemented Sep 4 17:37:33.914492 kernel: Root IRQ handler: gic_handle_irq Sep 4 17:37:33.914499 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Sep 4 17:37:33.914505 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Sep 4 17:37:33.914512 kernel: ITS [mem 0x08080000-0x0809ffff] Sep 4 17:37:33.914520 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Sep 4 17:37:33.914527 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Sep 4 17:37:33.914534 kernel: GICv3: using LPI property table @0x00000000400f0000 Sep 4 17:37:33.914540 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Sep 4 17:37:33.914548 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 4 17:37:33.914555 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 4 17:37:33.914562 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Sep 4 17:37:33.914569 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Sep 4 17:37:33.914577 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Sep 4 17:37:33.914584 kernel: arm-pv: using stolen time PV Sep 4 17:37:33.914591 kernel: Console: colour dummy device 80x25 Sep 4 17:37:33.914598 kernel: ACPI: Core revision 20230628 Sep 4 17:37:33.914605 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Sep 4 17:37:33.914612 kernel: pid_max: default: 32768 minimum: 301 Sep 4 17:37:33.914621 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Sep 4 17:37:33.914628 kernel: landlock: Up and running. Sep 4 17:37:33.914635 kernel: SELinux: Initializing. Sep 4 17:37:33.914641 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 17:37:33.914649 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 17:37:33.914655 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Sep 4 17:37:33.914663 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Sep 4 17:37:33.914670 kernel: rcu: Hierarchical SRCU implementation. Sep 4 17:37:33.914677 kernel: rcu: Max phase no-delay instances is 400. Sep 4 17:37:33.914683 kernel: Platform MSI: ITS@0x8080000 domain created Sep 4 17:37:33.914692 kernel: PCI/MSI: ITS@0x8080000 domain created Sep 4 17:37:33.914699 kernel: Remapping and enabling EFI services. Sep 4 17:37:33.914706 kernel: smp: Bringing up secondary CPUs ... Sep 4 17:37:33.914712 kernel: Detected PIPT I-cache on CPU1 Sep 4 17:37:33.914719 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Sep 4 17:37:33.914726 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Sep 4 17:37:33.914733 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 4 17:37:33.914740 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Sep 4 17:37:33.914747 kernel: Detected PIPT I-cache on CPU2 Sep 4 17:37:33.914756 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Sep 4 17:37:33.914763 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Sep 4 17:37:33.914775 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 4 17:37:33.914784 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Sep 4 17:37:33.914792 kernel: Detected PIPT I-cache on CPU3 Sep 4 17:37:33.914799 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Sep 4 17:37:33.914806 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Sep 4 17:37:33.914814 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 4 17:37:33.914821 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Sep 4 17:37:33.914830 kernel: smp: Brought up 1 node, 4 CPUs Sep 4 17:37:33.914837 kernel: SMP: Total of 4 processors activated. Sep 4 17:37:33.914844 kernel: CPU features: detected: 32-bit EL0 Support Sep 4 17:37:33.914852 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 4 17:37:33.914859 kernel: CPU features: detected: Common not Private translations Sep 4 17:37:33.914867 kernel: CPU features: detected: CRC32 instructions Sep 4 17:37:33.914874 kernel: CPU features: detected: Enhanced Virtualization Traps Sep 4 17:37:33.914881 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 4 17:37:33.914891 kernel: CPU features: detected: LSE atomic instructions Sep 4 17:37:33.914898 kernel: CPU features: detected: Privileged Access Never Sep 4 17:37:33.914906 kernel: CPU features: detected: RAS Extension Support Sep 4 17:37:33.914913 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 4 17:37:33.914921 kernel: CPU: All CPU(s) started at EL1 Sep 4 17:37:33.914929 kernel: alternatives: applying system-wide alternatives Sep 4 17:37:33.914937 kernel: devtmpfs: initialized Sep 4 17:37:33.914944 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 4 17:37:33.914952 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 4 17:37:33.914962 kernel: pinctrl core: initialized pinctrl subsystem Sep 4 17:37:33.914969 kernel: SMBIOS 3.0.0 present. Sep 4 17:37:33.914977 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Sep 4 17:37:33.914984 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 4 17:37:33.914991 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 4 17:37:33.914999 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 4 17:37:33.915006 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 4 17:37:33.915014 kernel: audit: initializing netlink subsys (disabled) Sep 4 17:37:33.915021 kernel: audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 Sep 4 17:37:33.915030 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 4 17:37:33.915037 kernel: cpuidle: using governor menu Sep 4 17:37:33.915044 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 4 17:37:33.915052 kernel: ASID allocator initialised with 32768 entries Sep 4 17:37:33.915059 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 4 17:37:33.915067 kernel: Serial: AMBA PL011 UART driver Sep 4 17:37:33.915074 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 4 17:37:33.915081 kernel: Modules: 0 pages in range for non-PLT usage Sep 4 17:37:33.915089 kernel: Modules: 509056 pages in range for PLT usage Sep 4 17:37:33.915098 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 4 17:37:33.915105 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 4 17:37:33.915113 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 4 17:37:33.915120 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 4 17:37:33.915127 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 4 17:37:33.915138 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 4 17:37:33.915146 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 4 17:37:33.915153 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 4 17:37:33.915161 kernel: ACPI: Added _OSI(Module Device) Sep 4 17:37:33.915169 kernel: ACPI: Added _OSI(Processor Device) Sep 4 17:37:33.915177 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Sep 4 17:37:33.915184 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 4 17:37:33.915192 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 4 17:37:33.915199 kernel: ACPI: Interpreter enabled Sep 4 17:37:33.915207 kernel: ACPI: Using GIC for interrupt routing Sep 4 17:37:33.915215 kernel: ACPI: MCFG table detected, 1 entries Sep 4 17:37:33.915222 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Sep 4 17:37:33.915230 kernel: printk: console [ttyAMA0] enabled Sep 4 17:37:33.915238 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 4 17:37:33.915400 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 4 17:37:33.915482 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 4 17:37:33.915548 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 4 17:37:33.915612 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Sep 4 17:37:33.915674 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Sep 4 17:37:33.915684 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Sep 4 17:37:33.915695 kernel: PCI host bridge to bus 0000:00 Sep 4 17:37:33.915768 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Sep 4 17:37:33.915828 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 4 17:37:33.915893 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Sep 4 17:37:33.915952 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 4 17:37:33.916037 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Sep 4 17:37:33.916116 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Sep 4 17:37:33.916265 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Sep 4 17:37:33.916369 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Sep 4 17:37:33.916443 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Sep 4 17:37:33.916510 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Sep 4 17:37:33.916578 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Sep 4 17:37:33.916647 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Sep 4 17:37:33.916711 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Sep 4 17:37:33.916778 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 4 17:37:33.916837 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Sep 4 17:37:33.916847 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 4 17:37:33.916855 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 4 17:37:33.916862 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 4 17:37:33.916870 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 4 17:37:33.916878 kernel: iommu: Default domain type: Translated Sep 4 17:37:33.916885 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 4 17:37:33.916895 kernel: efivars: Registered efivars operations Sep 4 17:37:33.916902 kernel: vgaarb: loaded Sep 4 17:37:33.916910 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 4 17:37:33.916917 kernel: VFS: Disk quotas dquot_6.6.0 Sep 4 17:37:33.916925 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 4 17:37:33.916933 kernel: pnp: PnP ACPI init Sep 4 17:37:33.917011 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Sep 4 17:37:33.917022 kernel: pnp: PnP ACPI: found 1 devices Sep 4 17:37:33.917031 kernel: NET: Registered PF_INET protocol family Sep 4 17:37:33.917039 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 4 17:37:33.917047 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 4 17:37:33.917055 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 4 17:37:33.917062 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 4 17:37:33.917070 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 4 17:37:33.917078 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 4 17:37:33.917085 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 17:37:33.917093 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 17:37:33.917102 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 4 17:37:33.917109 kernel: PCI: CLS 0 bytes, default 64 Sep 4 17:37:33.917117 kernel: kvm [1]: HYP mode not available Sep 4 17:37:33.917125 kernel: Initialise system trusted keyrings Sep 4 17:37:33.917143 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 4 17:37:33.917152 kernel: Key type asymmetric registered Sep 4 17:37:33.917160 kernel: Asymmetric key parser 'x509' registered Sep 4 17:37:33.917168 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 4 17:37:33.917175 kernel: io scheduler mq-deadline registered Sep 4 17:37:33.917184 kernel: io scheduler kyber registered Sep 4 17:37:33.917192 kernel: io scheduler bfq registered Sep 4 17:37:33.917200 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 4 17:37:33.917208 kernel: ACPI: button: Power Button [PWRB] Sep 4 17:37:33.917216 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 4 17:37:33.917305 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Sep 4 17:37:33.917316 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 4 17:37:33.917324 kernel: thunder_xcv, ver 1.0 Sep 4 17:37:33.917331 kernel: thunder_bgx, ver 1.0 Sep 4 17:37:33.917341 kernel: nicpf, ver 1.0 Sep 4 17:37:33.917348 kernel: nicvf, ver 1.0 Sep 4 17:37:33.917427 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 4 17:37:33.917492 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-09-04T17:37:33 UTC (1725471453) Sep 4 17:37:33.917502 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 4 17:37:33.917510 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Sep 4 17:37:33.917517 kernel: watchdog: Delayed init of the lockup detector failed: -19 Sep 4 17:37:33.917525 kernel: watchdog: Hard watchdog permanently disabled Sep 4 17:37:33.917534 kernel: NET: Registered PF_INET6 protocol family Sep 4 17:37:33.917542 kernel: Segment Routing with IPv6 Sep 4 17:37:33.917549 kernel: In-situ OAM (IOAM) with IPv6 Sep 4 17:37:33.917557 kernel: NET: Registered PF_PACKET protocol family Sep 4 17:37:33.917564 kernel: Key type dns_resolver registered Sep 4 17:37:33.917571 kernel: registered taskstats version 1 Sep 4 17:37:33.917578 kernel: Loading compiled-in X.509 certificates Sep 4 17:37:33.917586 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.48-flatcar: 6782952639b29daf968f5d0c3e73fb25e5af1d5e' Sep 4 17:37:33.917593 kernel: Key type .fscrypt registered Sep 4 17:37:33.917602 kernel: Key type fscrypt-provisioning registered Sep 4 17:37:33.917609 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 4 17:37:33.917617 kernel: ima: Allocated hash algorithm: sha1 Sep 4 17:37:33.917624 kernel: ima: No architecture policies found Sep 4 17:37:33.917632 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 4 17:37:33.917639 kernel: clk: Disabling unused clocks Sep 4 17:37:33.917647 kernel: Freeing unused kernel memory: 39296K Sep 4 17:37:33.917655 kernel: Run /init as init process Sep 4 17:37:33.917662 kernel: with arguments: Sep 4 17:37:33.917671 kernel: /init Sep 4 17:37:33.917678 kernel: with environment: Sep 4 17:37:33.917685 kernel: HOME=/ Sep 4 17:37:33.917693 kernel: TERM=linux Sep 4 17:37:33.917700 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 4 17:37:33.917709 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) Sep 4 17:37:33.917718 systemd[1]: Detected virtualization kvm. Sep 4 17:37:33.917727 systemd[1]: Detected architecture arm64. Sep 4 17:37:33.917735 systemd[1]: Running in initrd. Sep 4 17:37:33.917743 systemd[1]: No hostname configured, using default hostname. Sep 4 17:37:33.917750 systemd[1]: Hostname set to . Sep 4 17:37:33.917758 systemd[1]: Initializing machine ID from VM UUID. Sep 4 17:37:33.917766 systemd[1]: Queued start job for default target initrd.target. Sep 4 17:37:33.917774 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 17:37:33.917782 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 17:37:33.917790 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 4 17:37:33.917800 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 17:37:33.917808 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 4 17:37:33.917816 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 4 17:37:33.917826 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 4 17:37:33.917834 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 4 17:37:33.917843 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 17:37:33.917853 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 17:37:33.917861 systemd[1]: Reached target paths.target - Path Units. Sep 4 17:37:33.917869 systemd[1]: Reached target slices.target - Slice Units. Sep 4 17:37:33.917877 systemd[1]: Reached target swap.target - Swaps. Sep 4 17:37:33.917885 systemd[1]: Reached target timers.target - Timer Units. Sep 4 17:37:33.917893 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 17:37:33.917901 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 17:37:33.917909 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 4 17:37:33.917918 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Sep 4 17:37:33.917928 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 17:37:33.917936 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 17:37:33.917944 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 17:37:33.917952 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 17:37:33.917960 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 4 17:37:33.917969 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 17:37:33.917976 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 4 17:37:33.917984 systemd[1]: Starting systemd-fsck-usr.service... Sep 4 17:37:33.917992 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 17:37:33.918001 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 17:37:33.918010 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:37:33.918017 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 4 17:37:33.918025 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 17:37:33.918033 systemd[1]: Finished systemd-fsck-usr.service. Sep 4 17:37:33.918058 systemd-journald[238]: Collecting audit messages is disabled. Sep 4 17:37:33.918080 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 4 17:37:33.918088 kernel: Bridge firewalling registered Sep 4 17:37:33.918097 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 17:37:33.918105 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 17:37:33.918114 systemd-journald[238]: Journal started Sep 4 17:37:33.918139 systemd-journald[238]: Runtime Journal (/run/log/journal/4e44dc513c7b44eaba76d4349dfdc730) is 5.9M, max 47.3M, 41.4M free. Sep 4 17:37:33.896649 systemd-modules-load[239]: Inserted module 'overlay' Sep 4 17:37:33.920265 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 17:37:33.912873 systemd-modules-load[239]: Inserted module 'br_netfilter' Sep 4 17:37:33.921471 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:37:33.923506 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 17:37:33.927371 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 17:37:33.929212 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 17:37:33.933763 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 17:37:33.937005 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 17:37:33.944929 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 17:37:33.946212 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 17:37:33.948880 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 17:37:33.951289 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:37:33.965501 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 4 17:37:33.968004 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 17:37:33.977281 dracut-cmdline[276]: dracut-dracut-053 Sep 4 17:37:33.980210 dracut-cmdline[276]: 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=28a986328b36e7de6a755f88bb335afbeb3e3932bc9a20c5f8e57b952c2d23a9 Sep 4 17:37:34.000921 systemd-resolved[282]: Positive Trust Anchors: Sep 4 17:37:34.000941 systemd-resolved[282]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 17:37:34.000974 systemd-resolved[282]: 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 resolver.arpa corp home internal intranet lan local private test Sep 4 17:37:34.007419 systemd-resolved[282]: Defaulting to hostname 'linux'. Sep 4 17:37:34.008781 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 17:37:34.010841 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 17:37:34.059328 kernel: SCSI subsystem initialized Sep 4 17:37:34.064361 kernel: Loading iSCSI transport class v2.0-870. Sep 4 17:37:34.072323 kernel: iscsi: registered transport (tcp) Sep 4 17:37:34.089705 kernel: iscsi: registered transport (qla4xxx) Sep 4 17:37:34.089764 kernel: QLogic iSCSI HBA Driver Sep 4 17:37:34.136951 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 4 17:37:34.147489 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 4 17:37:34.167076 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 4 17:37:34.168428 kernel: device-mapper: uevent: version 1.0.3 Sep 4 17:37:34.168460 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Sep 4 17:37:34.184035 kernel: hrtimer: interrupt took 5848120 ns Sep 4 17:37:34.231337 kernel: raid6: neonx8 gen() 15760 MB/s Sep 4 17:37:34.248324 kernel: raid6: neonx4 gen() 15656 MB/s Sep 4 17:37:34.265323 kernel: raid6: neonx2 gen() 13224 MB/s Sep 4 17:37:34.282316 kernel: raid6: neonx1 gen() 10445 MB/s Sep 4 17:37:34.299363 kernel: raid6: int64x8 gen() 6928 MB/s Sep 4 17:37:34.316387 kernel: raid6: int64x4 gen() 7268 MB/s Sep 4 17:37:34.333349 kernel: raid6: int64x2 gen() 6121 MB/s Sep 4 17:37:34.350583 kernel: raid6: int64x1 gen() 5050 MB/s Sep 4 17:37:34.350650 kernel: raid6: using algorithm neonx8 gen() 15760 MB/s Sep 4 17:37:34.368521 kernel: raid6: .... xor() 11929 MB/s, rmw enabled Sep 4 17:37:34.368579 kernel: raid6: using neon recovery algorithm Sep 4 17:37:34.374726 kernel: xor: measuring software checksum speed Sep 4 17:37:34.374760 kernel: 8regs : 19883 MB/sec Sep 4 17:37:34.375774 kernel: 32regs : 19720 MB/sec Sep 4 17:37:34.376708 kernel: arm64_neon : 27143 MB/sec Sep 4 17:37:34.376744 kernel: xor: using function: arm64_neon (27143 MB/sec) Sep 4 17:37:34.434323 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 4 17:37:34.448164 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 4 17:37:34.459461 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 17:37:34.472385 systemd-udevd[465]: Using default interface naming scheme 'v255'. Sep 4 17:37:34.475610 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 17:37:34.484666 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 4 17:37:34.498794 dracut-pre-trigger[472]: rd.md=0: removing MD RAID activation Sep 4 17:37:34.534774 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 17:37:34.548523 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 17:37:34.591359 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 17:37:34.606778 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 4 17:37:34.623361 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 4 17:37:34.624810 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 17:37:34.627345 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 17:37:34.629915 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 17:37:34.637661 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 4 17:37:34.647705 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 4 17:37:34.651476 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Sep 4 17:37:34.653212 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 4 17:37:34.665344 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 17:37:34.668249 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 17:37:34.668504 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:37:34.672642 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 17:37:34.677470 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 17:37:34.677644 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:37:34.682640 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:37:34.690110 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (514) Sep 4 17:37:34.690153 kernel: BTRFS: device fsid 3e706a0f-a579-4862-bc52-e66e95e66d87 devid 1 transid 42 /dev/vda3 scanned by (udev-worker) (520) Sep 4 17:37:34.694656 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:37:34.708931 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 4 17:37:34.710583 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:37:34.719402 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 4 17:37:34.728531 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 4 17:37:34.732921 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 4 17:37:34.734441 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 4 17:37:34.752532 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 4 17:37:34.754613 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 17:37:34.768655 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 17:37:34.781330 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:37:35.784339 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 17:37:35.784396 disk-uuid[554]: The operation has completed successfully. Sep 4 17:37:35.808965 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 4 17:37:35.809079 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 4 17:37:35.830523 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 4 17:37:35.834721 sh[575]: Success Sep 4 17:37:35.849400 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Sep 4 17:37:35.886863 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 4 17:37:35.902819 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 4 17:37:35.904952 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 4 17:37:35.916217 kernel: BTRFS info (device dm-0): first mount of filesystem 3e706a0f-a579-4862-bc52-e66e95e66d87 Sep 4 17:37:35.916262 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 4 17:37:35.916274 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Sep 4 17:37:35.918900 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 4 17:37:35.918914 kernel: BTRFS info (device dm-0): using free space tree Sep 4 17:37:35.922483 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 4 17:37:35.923924 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 4 17:37:35.924716 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 4 17:37:35.927683 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 4 17:37:35.938658 kernel: BTRFS info (device vda6): first mount of filesystem e85e5091-8620-4def-b250-7009f4048f6e Sep 4 17:37:35.938718 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 4 17:37:35.938729 kernel: BTRFS info (device vda6): using free space tree Sep 4 17:37:35.942315 kernel: BTRFS info (device vda6): auto enabling async discard Sep 4 17:37:35.951166 systemd[1]: mnt-oem.mount: Deactivated successfully. Sep 4 17:37:35.953031 kernel: BTRFS info (device vda6): last unmount of filesystem e85e5091-8620-4def-b250-7009f4048f6e Sep 4 17:37:35.960597 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 4 17:37:35.966653 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 4 17:37:36.038080 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 17:37:36.056532 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 17:37:36.088919 systemd-networkd[763]: lo: Link UP Sep 4 17:37:36.088933 systemd-networkd[763]: lo: Gained carrier Sep 4 17:37:36.089658 systemd-networkd[763]: Enumeration completed Sep 4 17:37:36.090170 systemd-networkd[763]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:37:36.090173 systemd-networkd[763]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 17:37:36.091039 systemd-networkd[763]: eth0: Link UP Sep 4 17:37:36.091042 systemd-networkd[763]: eth0: Gained carrier Sep 4 17:37:36.091050 systemd-networkd[763]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:37:36.091435 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 17:37:36.092592 systemd[1]: Reached target network.target - Network. Sep 4 17:37:36.104227 ignition[674]: Ignition 2.19.0 Sep 4 17:37:36.104236 ignition[674]: Stage: fetch-offline Sep 4 17:37:36.104273 ignition[674]: no configs at "/usr/lib/ignition/base.d" Sep 4 17:37:36.105348 systemd-networkd[763]: eth0: DHCPv4 address 10.0.0.117/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 4 17:37:36.104281 ignition[674]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:37:36.104452 ignition[674]: parsed url from cmdline: "" Sep 4 17:37:36.104456 ignition[674]: no config URL provided Sep 4 17:37:36.104460 ignition[674]: reading system config file "/usr/lib/ignition/user.ign" Sep 4 17:37:36.104468 ignition[674]: no config at "/usr/lib/ignition/user.ign" Sep 4 17:37:36.104493 ignition[674]: op(1): [started] loading QEMU firmware config module Sep 4 17:37:36.104497 ignition[674]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 4 17:37:36.118716 ignition[674]: op(1): [finished] loading QEMU firmware config module Sep 4 17:37:36.121785 ignition[674]: parsing config with SHA512: 5d950dde10b912d06815d46070b67985037feb4156812e197b2a29edde67d34e8e2f7fe26bf86e0f5d7691de88099181753b51835b2cdeb96525e197bfd53ad0 Sep 4 17:37:36.126732 unknown[674]: fetched base config from "system" Sep 4 17:37:36.126742 unknown[674]: fetched user config from "qemu" Sep 4 17:37:36.126907 ignition[674]: fetch-offline: fetch-offline passed Sep 4 17:37:36.126987 ignition[674]: Ignition finished successfully Sep 4 17:37:36.130166 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 17:37:36.132916 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 4 17:37:36.146516 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 4 17:37:36.159500 ignition[771]: Ignition 2.19.0 Sep 4 17:37:36.159513 ignition[771]: Stage: kargs Sep 4 17:37:36.159703 ignition[771]: no configs at "/usr/lib/ignition/base.d" Sep 4 17:37:36.159712 ignition[771]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:37:36.160462 ignition[771]: kargs: kargs passed Sep 4 17:37:36.160508 ignition[771]: Ignition finished successfully Sep 4 17:37:36.163582 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 4 17:37:36.174478 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 4 17:37:36.192533 ignition[779]: Ignition 2.19.0 Sep 4 17:37:36.192544 ignition[779]: Stage: disks Sep 4 17:37:36.192759 ignition[779]: no configs at "/usr/lib/ignition/base.d" Sep 4 17:37:36.192769 ignition[779]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:37:36.196466 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 4 17:37:36.194572 ignition[779]: disks: disks passed Sep 4 17:37:36.197834 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 4 17:37:36.194629 ignition[779]: Ignition finished successfully Sep 4 17:37:36.199478 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 4 17:37:36.201138 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 17:37:36.203031 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 17:37:36.204643 systemd[1]: Reached target basic.target - Basic System. Sep 4 17:37:36.212464 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 4 17:37:36.225349 systemd-fsck[789]: ROOT: clean, 14/553520 files, 52654/553472 blocks Sep 4 17:37:36.230352 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 4 17:37:36.244442 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 4 17:37:36.290326 kernel: EXT4-fs (vda9): mounted filesystem 901d46b0-2319-4536-8a6d-46889db73e8c r/w with ordered data mode. Quota mode: none. Sep 4 17:37:36.290381 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 4 17:37:36.291658 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 4 17:37:36.304393 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 17:37:36.306288 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 4 17:37:36.307663 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 4 17:37:36.307708 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 4 17:37:36.314253 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (797) Sep 4 17:37:36.307732 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 17:37:36.315445 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 4 17:37:36.319741 kernel: BTRFS info (device vda6): first mount of filesystem e85e5091-8620-4def-b250-7009f4048f6e Sep 4 17:37:36.319765 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 4 17:37:36.319776 kernel: BTRFS info (device vda6): using free space tree Sep 4 17:37:36.319753 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 4 17:37:36.322824 kernel: BTRFS info (device vda6): auto enabling async discard Sep 4 17:37:36.324680 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 17:37:36.363694 initrd-setup-root[821]: cut: /sysroot/etc/passwd: No such file or directory Sep 4 17:37:36.367849 initrd-setup-root[828]: cut: /sysroot/etc/group: No such file or directory Sep 4 17:37:36.371254 initrd-setup-root[835]: cut: /sysroot/etc/shadow: No such file or directory Sep 4 17:37:36.374664 initrd-setup-root[842]: cut: /sysroot/etc/gshadow: No such file or directory Sep 4 17:37:36.461110 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 4 17:37:36.471389 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 4 17:37:36.473011 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 4 17:37:36.479316 kernel: BTRFS info (device vda6): last unmount of filesystem e85e5091-8620-4def-b250-7009f4048f6e Sep 4 17:37:36.499746 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 4 17:37:36.511165 ignition[912]: INFO : Ignition 2.19.0 Sep 4 17:37:36.511165 ignition[912]: INFO : Stage: mount Sep 4 17:37:36.512905 ignition[912]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 17:37:36.512905 ignition[912]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:37:36.512905 ignition[912]: INFO : mount: mount passed Sep 4 17:37:36.512905 ignition[912]: INFO : Ignition finished successfully Sep 4 17:37:36.513502 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 4 17:37:36.515866 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 4 17:37:36.914657 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 4 17:37:36.923499 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 17:37:36.930351 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (924) Sep 4 17:37:36.930392 kernel: BTRFS info (device vda6): first mount of filesystem e85e5091-8620-4def-b250-7009f4048f6e Sep 4 17:37:36.930403 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 4 17:37:36.931804 kernel: BTRFS info (device vda6): using free space tree Sep 4 17:37:36.934317 kernel: BTRFS info (device vda6): auto enabling async discard Sep 4 17:37:36.935203 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 17:37:36.953767 ignition[941]: INFO : Ignition 2.19.0 Sep 4 17:37:36.953767 ignition[941]: INFO : Stage: files Sep 4 17:37:36.955529 ignition[941]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 17:37:36.955529 ignition[941]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:37:36.955529 ignition[941]: DEBUG : files: compiled without relabeling support, skipping Sep 4 17:37:36.955529 ignition[941]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 4 17:37:36.955529 ignition[941]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 4 17:37:36.961702 ignition[941]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 4 17:37:36.961702 ignition[941]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 4 17:37:36.961702 ignition[941]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 4 17:37:36.961702 ignition[941]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 17:37:36.961702 ignition[941]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 17:37:36.961702 ignition[941]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Sep 4 17:37:36.961702 ignition[941]: INFO : files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 4 17:37:36.961702 ignition[941]: INFO : files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 4 17:37:36.961702 ignition[941]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Sep 4 17:37:36.961702 ignition[941]: INFO : files: createResultFile: createFiles: op(6): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 4 17:37:36.961702 ignition[941]: INFO : files: createResultFile: createFiles: op(6): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 4 17:37:36.961702 ignition[941]: INFO : files: files passed Sep 4 17:37:36.961702 ignition[941]: INFO : Ignition finished successfully Sep 4 17:37:36.957516 unknown[941]: wrote ssh authorized keys file for user: core Sep 4 17:37:36.961820 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 4 17:37:36.978487 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 4 17:37:36.981220 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 4 17:37:36.983200 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 4 17:37:36.983313 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 4 17:37:36.990204 initrd-setup-root-after-ignition[967]: grep: /sysroot/oem/oem-release: No such file or directory Sep 4 17:37:36.991976 initrd-setup-root-after-ignition[969]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 17:37:36.991976 initrd-setup-root-after-ignition[969]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 4 17:37:36.994832 initrd-setup-root-after-ignition[973]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 17:37:36.997906 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 17:37:36.999463 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 4 17:37:37.017500 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 4 17:37:37.036692 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 4 17:37:37.036814 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 4 17:37:37.039006 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 4 17:37:37.040827 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 4 17:37:37.042568 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 4 17:37:37.043351 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 4 17:37:37.058683 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 17:37:37.061152 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 4 17:37:37.072432 systemd[1]: Stopped target network.target - Network. Sep 4 17:37:37.073389 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 4 17:37:37.075195 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 17:37:37.077222 systemd[1]: Stopped target timers.target - Timer Units. Sep 4 17:37:37.079076 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 4 17:37:37.079212 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 17:37:37.081632 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 4 17:37:37.083680 systemd[1]: Stopped target basic.target - Basic System. Sep 4 17:37:37.085317 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 4 17:37:37.087004 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 17:37:37.088878 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 4 17:37:37.090827 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 4 17:37:37.092577 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 17:37:37.094498 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 4 17:37:37.096360 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 4 17:37:37.098118 systemd[1]: Stopped target swap.target - Swaps. Sep 4 17:37:37.099643 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 4 17:37:37.099767 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 4 17:37:37.102015 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 4 17:37:37.103168 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 17:37:37.105020 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 4 17:37:37.105101 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 17:37:37.107001 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 4 17:37:37.107129 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 4 17:37:37.109748 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 4 17:37:37.109865 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 17:37:37.112088 systemd[1]: Stopped target paths.target - Path Units. Sep 4 17:37:37.113585 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 4 17:37:37.117330 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 17:37:37.119407 systemd[1]: Stopped target slices.target - Slice Units. Sep 4 17:37:37.121434 systemd[1]: Stopped target sockets.target - Socket Units. Sep 4 17:37:37.122970 systemd[1]: iscsid.socket: Deactivated successfully. Sep 4 17:37:37.123057 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 17:37:37.124588 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 4 17:37:37.124669 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 17:37:37.126219 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 4 17:37:37.126338 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 17:37:37.128086 systemd[1]: ignition-files.service: Deactivated successfully. Sep 4 17:37:37.128197 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 4 17:37:37.137504 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 4 17:37:37.138423 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 4 17:37:37.138563 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 17:37:37.141187 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 4 17:37:37.143256 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 4 17:37:37.145027 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 4 17:37:37.146754 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 4 17:37:37.146885 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 17:37:37.153178 ignition[994]: INFO : Ignition 2.19.0 Sep 4 17:37:37.153178 ignition[994]: INFO : Stage: umount Sep 4 17:37:37.153178 ignition[994]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 17:37:37.153178 ignition[994]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:37:37.153178 ignition[994]: INFO : umount: umount passed Sep 4 17:37:37.153178 ignition[994]: INFO : Ignition finished successfully Sep 4 17:37:37.148800 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 4 17:37:37.148894 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 17:37:37.152267 systemd-networkd[763]: eth0: DHCPv6 lease lost Sep 4 17:37:37.152618 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 4 17:37:37.152709 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 4 17:37:37.158430 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 4 17:37:37.158928 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 4 17:37:37.159033 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 4 17:37:37.161170 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 4 17:37:37.161255 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 4 17:37:37.162743 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 4 17:37:37.162827 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 4 17:37:37.165567 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 4 17:37:37.165663 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 4 17:37:37.168763 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 4 17:37:37.168795 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 4 17:37:37.170637 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 4 17:37:37.170682 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 4 17:37:37.172352 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 4 17:37:37.172398 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 4 17:37:37.174015 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 4 17:37:37.174054 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 4 17:37:37.175645 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 4 17:37:37.175691 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 4 17:37:37.177290 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 4 17:37:37.177450 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 4 17:37:37.189398 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 4 17:37:37.190349 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 4 17:37:37.190405 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 17:37:37.192332 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 4 17:37:37.192373 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 4 17:37:37.194187 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 4 17:37:37.194229 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 4 17:37:37.196055 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 4 17:37:37.196096 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 17:37:37.198230 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 17:37:37.209489 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 4 17:37:37.209604 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 4 17:37:37.212952 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 4 17:37:37.213099 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 17:37:37.215224 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 4 17:37:37.215260 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 4 17:37:37.217157 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 4 17:37:37.217190 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 17:37:37.218893 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 4 17:37:37.218942 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 4 17:37:37.221830 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 4 17:37:37.221876 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 4 17:37:37.224504 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 17:37:37.224549 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:37:37.238445 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 4 17:37:37.239468 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 4 17:37:37.239525 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 17:37:37.241522 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 17:37:37.241567 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:37:37.246290 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 4 17:37:37.246412 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 4 17:37:37.247689 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 4 17:37:37.249987 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 4 17:37:37.259019 systemd[1]: Switching root. Sep 4 17:37:37.285986 systemd-journald[238]: Journal stopped Sep 4 17:37:37.943606 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Sep 4 17:37:37.943661 kernel: SELinux: policy capability network_peer_controls=1 Sep 4 17:37:37.943678 kernel: SELinux: policy capability open_perms=1 Sep 4 17:37:37.943688 kernel: SELinux: policy capability extended_socket_class=1 Sep 4 17:37:37.943702 kernel: SELinux: policy capability always_check_network=0 Sep 4 17:37:37.943715 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 4 17:37:37.943725 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 4 17:37:37.943735 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 4 17:37:37.943744 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 4 17:37:37.943754 kernel: audit: type=1403 audit(1725471457.353:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 4 17:37:37.943764 systemd[1]: Successfully loaded SELinux policy in 32.516ms. Sep 4 17:37:37.943778 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.745ms. Sep 4 17:37:37.943794 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) Sep 4 17:37:37.943805 systemd[1]: Detected virtualization kvm. Sep 4 17:37:37.943816 systemd[1]: Detected architecture arm64. Sep 4 17:37:37.943827 systemd[1]: Detected first boot. Sep 4 17:37:37.943838 systemd[1]: Initializing machine ID from VM UUID. Sep 4 17:37:37.943849 zram_generator::config[1037]: No configuration found. Sep 4 17:37:37.943864 systemd[1]: Populated /etc with preset unit settings. Sep 4 17:37:37.943874 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 4 17:37:37.943885 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 4 17:37:37.943896 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 4 17:37:37.943909 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 4 17:37:37.943920 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 4 17:37:37.943930 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 4 17:37:37.943941 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 4 17:37:37.943952 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 4 17:37:37.943963 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 4 17:37:37.943974 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 4 17:37:37.943984 systemd[1]: Created slice user.slice - User and Session Slice. Sep 4 17:37:37.943995 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 17:37:37.944008 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 17:37:37.944019 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 4 17:37:37.944032 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 4 17:37:37.944042 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 4 17:37:37.944053 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 17:37:37.944066 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 4 17:37:37.944077 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 17:37:37.944087 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 4 17:37:37.944098 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 4 17:37:37.944112 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 4 17:37:37.944131 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 4 17:37:37.944144 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 17:37:37.944155 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 17:37:37.944167 systemd[1]: Reached target slices.target - Slice Units. Sep 4 17:37:37.944178 systemd[1]: Reached target swap.target - Swaps. Sep 4 17:37:37.944189 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 4 17:37:37.944199 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 4 17:37:37.944210 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 17:37:37.944221 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 17:37:37.944231 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 17:37:37.944242 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 4 17:37:37.944252 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 4 17:37:37.944265 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 4 17:37:37.944277 systemd[1]: Mounting media.mount - External Media Directory... Sep 4 17:37:37.944288 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 4 17:37:37.944305 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 4 17:37:37.944318 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 4 17:37:37.944330 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). Sep 4 17:37:37.944341 systemd[1]: Reached target machines.target - Containers. Sep 4 17:37:37.944352 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 4 17:37:37.944362 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 17:37:37.944376 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 17:37:37.944386 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 4 17:37:37.944397 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:37:37.944408 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 17:37:37.944418 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:37:37.944429 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 4 17:37:37.944440 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 17:37:37.944451 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 4 17:37:37.944463 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 4 17:37:37.944474 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 4 17:37:37.944485 kernel: fuse: init (API version 7.39) Sep 4 17:37:37.944495 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 4 17:37:37.944506 systemd[1]: Stopped systemd-fsck-usr.service. Sep 4 17:37:37.944519 kernel: loop: module loaded Sep 4 17:37:37.944529 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 17:37:37.944539 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 17:37:37.944550 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 4 17:37:37.944562 kernel: ACPI: bus type drm_connector registered Sep 4 17:37:37.944572 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 4 17:37:37.944583 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 17:37:37.944593 systemd[1]: verity-setup.service: Deactivated successfully. Sep 4 17:37:37.944604 systemd[1]: Stopped verity-setup.service. Sep 4 17:37:37.944634 systemd-journald[1104]: Collecting audit messages is disabled. Sep 4 17:37:37.944656 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 4 17:37:37.944667 systemd-journald[1104]: Journal started Sep 4 17:37:37.944690 systemd-journald[1104]: Runtime Journal (/run/log/journal/4e44dc513c7b44eaba76d4349dfdc730) is 5.9M, max 47.3M, 41.4M free. Sep 4 17:37:37.734592 systemd[1]: Queued start job for default target multi-user.target. Sep 4 17:37:37.754440 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 4 17:37:37.754798 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 4 17:37:37.946992 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 17:37:37.947596 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 4 17:37:37.948813 systemd[1]: Mounted media.mount - External Media Directory. Sep 4 17:37:37.949903 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 4 17:37:37.951083 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 4 17:37:37.952383 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 4 17:37:37.953681 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 4 17:37:37.956333 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 17:37:37.957810 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 4 17:37:37.957941 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 4 17:37:37.959399 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:37:37.959566 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:37:37.960923 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 17:37:37.961070 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 17:37:37.962430 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:37:37.962561 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:37:37.964014 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 4 17:37:37.965421 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 4 17:37:37.966705 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 17:37:37.966850 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 17:37:37.968272 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 17:37:37.971607 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 4 17:37:37.973088 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 4 17:37:37.985054 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 17:37:37.992413 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 4 17:37:37.994448 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 4 17:37:37.995558 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 4 17:37:37.995595 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 17:37:37.997532 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Sep 4 17:37:37.999802 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 4 17:37:38.001930 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 4 17:37:38.003067 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:37:38.004242 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 4 17:37:38.006244 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 4 17:37:38.008228 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 17:37:38.010513 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 4 17:37:38.012454 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 17:37:38.017452 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 17:37:38.017989 systemd-journald[1104]: Time spent on flushing to /var/log/journal/4e44dc513c7b44eaba76d4349dfdc730 is 16.929ms for 817 entries. Sep 4 17:37:38.017989 systemd-journald[1104]: System Journal (/var/log/journal/4e44dc513c7b44eaba76d4349dfdc730) is 8.0M, max 195.6M, 187.6M free. Sep 4 17:37:38.056604 systemd-journald[1104]: Received client request to flush runtime journal. Sep 4 17:37:38.056657 kernel: loop0: detected capacity change from 0 to 114288 Sep 4 17:37:38.020673 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 4 17:37:38.029509 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 4 17:37:38.032007 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 17:37:38.036321 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 4 17:37:38.037741 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 4 17:37:38.039367 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 4 17:37:38.040940 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 4 17:37:38.044712 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 4 17:37:38.054462 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Sep 4 17:37:38.057608 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Sep 4 17:37:38.061669 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 4 17:37:38.069318 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 4 17:37:38.074942 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 17:37:38.081988 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 4 17:37:38.082872 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Sep 4 17:37:38.088499 udevadm[1159]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Sep 4 17:37:38.095344 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 4 17:37:38.098403 kernel: loop1: detected capacity change from 0 to 65520 Sep 4 17:37:38.103456 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 17:37:38.128423 systemd-tmpfiles[1167]: ACLs are not supported, ignoring. Sep 4 17:37:38.128440 systemd-tmpfiles[1167]: ACLs are not supported, ignoring. Sep 4 17:37:38.131333 kernel: loop2: detected capacity change from 0 to 114288 Sep 4 17:37:38.132978 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 17:37:38.142333 kernel: loop3: detected capacity change from 0 to 65520 Sep 4 17:37:38.146264 (sd-merge)[1173]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 4 17:37:38.146635 (sd-merge)[1173]: Merged extensions into '/usr'. Sep 4 17:37:38.149352 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 4 17:37:38.157485 systemd[1]: Starting ensure-sysext.service... Sep 4 17:37:38.161521 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 17:37:38.167829 systemd[1]: Reloading requested from client PID 1176 ('systemctl') (unit ensure-sysext.service)... Sep 4 17:37:38.167843 systemd[1]: Reloading... Sep 4 17:37:38.185197 systemd-tmpfiles[1177]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 4 17:37:38.185507 systemd-tmpfiles[1177]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 4 17:37:38.186170 systemd-tmpfiles[1177]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 4 17:37:38.186419 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Sep 4 17:37:38.186465 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Sep 4 17:37:38.190842 systemd-tmpfiles[1177]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 17:37:38.190974 systemd-tmpfiles[1177]: Skipping /boot Sep 4 17:37:38.198541 systemd-tmpfiles[1177]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 17:37:38.198628 systemd-tmpfiles[1177]: Skipping /boot Sep 4 17:37:38.235325 zram_generator::config[1203]: No configuration found. Sep 4 17:37:38.334688 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. Sep 4 17:37:38.353866 ldconfig[1142]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 4 17:37:38.371735 systemd[1]: Reloading finished in 203 ms. Sep 4 17:37:38.403539 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 4 17:37:38.407285 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 17:37:38.413413 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Sep 4 17:37:38.415778 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 4 17:37:38.420475 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 4 17:37:38.428259 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 17:37:38.436627 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 4 17:37:38.441902 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 4 17:37:38.444896 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 17:37:38.446539 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:37:38.455625 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:37:38.459754 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 17:37:38.460958 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:37:38.461875 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:37:38.463107 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:37:38.464853 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:37:38.464994 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:37:38.476847 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 17:37:38.477004 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 17:37:38.478919 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 4 17:37:38.482947 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 17:37:38.493696 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:37:38.500987 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:37:38.502256 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:37:38.502835 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 4 17:37:38.504656 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 4 17:37:38.506491 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:37:38.506896 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:37:38.510780 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:37:38.510968 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:37:38.516000 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 17:37:38.517611 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:37:38.521686 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 17:37:38.529619 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:37:38.534638 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 17:37:38.535933 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:37:38.537196 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 4 17:37:38.538936 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 4 17:37:38.540313 augenrules[1279]: No rules Sep 4 17:37:38.541051 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Sep 4 17:37:38.542708 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:37:38.542847 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:37:38.544525 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 17:37:38.544662 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 17:37:38.546336 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:37:38.546466 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:37:38.548335 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 17:37:38.548465 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 17:37:38.554926 systemd[1]: Finished ensure-sysext.service. Sep 4 17:37:38.559805 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 17:37:38.559882 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 17:37:38.561426 systemd-resolved[1246]: Positive Trust Anchors: Sep 4 17:37:38.561442 systemd-resolved[1246]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 17:37:38.561475 systemd-resolved[1246]: 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 resolver.arpa corp home internal intranet lan local private test Sep 4 17:37:38.567472 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 4 17:37:38.567620 systemd-resolved[1246]: Defaulting to hostname 'linux'. Sep 4 17:37:38.569944 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 17:37:38.572192 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 4 17:37:38.573262 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). Sep 4 17:37:38.573476 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 17:37:38.574764 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 17:37:38.584517 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 4 17:37:38.595241 systemd-udevd[1295]: Using default interface naming scheme 'v255'. Sep 4 17:37:38.614499 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 17:37:38.627930 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 17:37:38.629344 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 4 17:37:38.632939 systemd[1]: Reached target time-set.target - System Time Set. Sep 4 17:37:38.648594 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 4 17:37:38.660348 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1311) Sep 4 17:37:38.676329 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1300) Sep 4 17:37:38.689342 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1300) Sep 4 17:37:38.691744 systemd-networkd[1305]: lo: Link UP Sep 4 17:37:38.691749 systemd-networkd[1305]: lo: Gained carrier Sep 4 17:37:38.692504 systemd-networkd[1305]: Enumeration completed Sep 4 17:37:38.692621 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 17:37:38.693335 systemd-networkd[1305]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:37:38.693345 systemd-networkd[1305]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 17:37:38.693982 systemd-networkd[1305]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:37:38.694014 systemd-networkd[1305]: eth0: Link UP Sep 4 17:37:38.694017 systemd-networkd[1305]: eth0: Gained carrier Sep 4 17:37:38.694024 systemd-networkd[1305]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:37:38.694246 systemd[1]: Reached target network.target - Network. Sep 4 17:37:38.702553 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 4 17:37:38.705176 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 4 17:37:38.709512 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 4 17:37:38.710382 systemd-networkd[1305]: eth0: DHCPv4 address 10.0.0.117/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 4 17:37:38.711292 systemd-timesyncd[1294]: Network configuration changed, trying to establish connection. Sep 4 17:37:38.712133 systemd-timesyncd[1294]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 4 17:37:38.712188 systemd-timesyncd[1294]: Initial clock synchronization to Wed 2024-09-04 17:37:39.027421 UTC. Sep 4 17:37:38.727730 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 4 17:37:38.744631 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:37:38.754751 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Sep 4 17:37:38.758615 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Sep 4 17:37:38.808508 lvm[1335]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 17:37:38.810713 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:37:38.842403 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Sep 4 17:37:38.844204 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 17:37:38.845356 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 17:37:38.846488 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 4 17:37:38.847703 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 4 17:37:38.849064 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 4 17:37:38.850268 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 4 17:37:38.851484 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 4 17:37:38.852774 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 4 17:37:38.852810 systemd[1]: Reached target paths.target - Path Units. Sep 4 17:37:38.853703 systemd[1]: Reached target timers.target - Timer Units. Sep 4 17:37:38.855418 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 4 17:37:38.857751 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 17:37:38.867239 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 4 17:37:38.869748 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Sep 4 17:37:38.871371 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 17:37:38.872544 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 17:37:38.873553 systemd[1]: Reached target basic.target - Basic System. Sep 4 17:37:38.874453 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 4 17:37:38.874483 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 4 17:37:38.875392 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 17:37:38.877339 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 4 17:37:38.880440 lvm[1343]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 17:37:38.880464 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 4 17:37:38.883492 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 4 17:37:38.885522 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). Sep 4 17:37:38.889527 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 4 17:37:38.891728 jq[1346]: false Sep 4 17:37:38.894483 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 4 17:37:38.897537 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 4 17:37:38.902019 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 4 17:37:38.903961 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 4 17:37:38.904387 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 4 17:37:38.905023 systemd[1]: Starting update-engine.service - Update Engine... Sep 4 17:37:38.908788 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 4 17:37:38.911007 extend-filesystems[1347]: Found loop2 Sep 4 17:37:38.911937 extend-filesystems[1347]: Found loop3 Sep 4 17:37:38.911937 extend-filesystems[1347]: Found vda Sep 4 17:37:38.911937 extend-filesystems[1347]: Found vda1 Sep 4 17:37:38.911937 extend-filesystems[1347]: Found vda2 Sep 4 17:37:38.911937 extend-filesystems[1347]: Found vda3 Sep 4 17:37:38.911937 extend-filesystems[1347]: Found usr Sep 4 17:37:38.911937 extend-filesystems[1347]: Found vda4 Sep 4 17:37:38.911937 extend-filesystems[1347]: Found vda6 Sep 4 17:37:38.911937 extend-filesystems[1347]: Found vda7 Sep 4 17:37:38.911937 extend-filesystems[1347]: Found vda9 Sep 4 17:37:38.911937 extend-filesystems[1347]: Checking size of /dev/vda9 Sep 4 17:37:38.912361 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Sep 4 17:37:38.918486 dbus-daemon[1345]: [system] SELinux support is enabled Sep 4 17:37:38.918648 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 4 17:37:38.918810 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 4 17:37:38.927537 jq[1359]: true Sep 4 17:37:38.919140 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 4 17:37:38.923444 systemd[1]: motdgen.service: Deactivated successfully. Sep 4 17:37:38.923624 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 4 17:37:38.927366 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 4 17:37:38.927520 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 4 17:37:38.931440 extend-filesystems[1347]: Old size kept for /dev/vda9 Sep 4 17:37:38.939442 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 4 17:37:38.939615 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 4 17:37:38.959454 jq[1368]: true Sep 4 17:37:38.963040 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1311) Sep 4 17:37:38.960519 (ntainerd)[1369]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 4 17:37:38.966919 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). Sep 4 17:37:38.966966 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 4 17:37:38.968807 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). Sep 4 17:37:38.968833 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 4 17:37:38.978583 update_engine[1358]: I0904 17:37:38.978364 1358 main.cc:92] Flatcar Update Engine starting Sep 4 17:37:38.989620 update_engine[1358]: I0904 17:37:38.980417 1358 update_check_scheduler.cc:74] Next update check in 7m43s Sep 4 17:37:38.980538 systemd[1]: Started update-engine.service - Update Engine. Sep 4 17:37:38.992686 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 4 17:37:38.996038 systemd-logind[1357]: Watching system buttons on /dev/input/event0 (Power Button) Sep 4 17:37:38.996695 systemd-logind[1357]: New seat seat0. Sep 4 17:37:38.998549 systemd[1]: Started systemd-logind.service - User Login Management. Sep 4 17:37:39.050801 bash[1395]: Updated "/home/core/.ssh/authorized_keys" Sep 4 17:37:39.052641 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 4 17:37:39.054616 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 4 17:37:39.060389 locksmithd[1381]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 4 17:37:39.172034 containerd[1369]: time="2024-09-04T17:37:39.171882213Z" level=info msg="starting containerd" revision=8ccfc03e4e2b73c22899202ae09d0caf906d3863 version=v1.7.20 Sep 4 17:37:39.197889 containerd[1369]: time="2024-09-04T17:37:39.197830517Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:37:39.199374 containerd[1369]: time="2024-09-04T17:37:39.199301760Z" 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.48-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:37:39.199374 containerd[1369]: time="2024-09-04T17:37:39.199350529Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 4 17:37:39.199374 containerd[1369]: time="2024-09-04T17:37:39.199368782Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 4 17:37:39.199576 containerd[1369]: time="2024-09-04T17:37:39.199543696Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 4 17:37:39.199576 containerd[1369]: time="2024-09-04T17:37:39.199570970Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 4 17:37:39.199648 containerd[1369]: time="2024-09-04T17:37:39.199631049Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:37:39.199670 containerd[1369]: time="2024-09-04T17:37:39.199649551Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:37:39.199870 containerd[1369]: time="2024-09-04T17:37:39.199839266Z" 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 Sep 4 17:37:39.199902 containerd[1369]: time="2024-09-04T17:37:39.199866957Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 4 17:37:39.199902 containerd[1369]: time="2024-09-04T17:37:39.199883504Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:37:39.199902 containerd[1369]: time="2024-09-04T17:37:39.199894190Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 4 17:37:39.199991 containerd[1369]: time="2024-09-04T17:37:39.199975847Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:37:39.200208 containerd[1369]: time="2024-09-04T17:37:39.200180447Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:37:39.200306 containerd[1369]: time="2024-09-04T17:37:39.200289171Z" 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 Sep 4 17:37:39.200351 containerd[1369]: time="2024-09-04T17:37:39.200307963Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 4 17:37:39.200429 containerd[1369]: time="2024-09-04T17:37:39.200411781Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 4 17:37:39.200475 containerd[1369]: time="2024-09-04T17:37:39.200462505Z" level=info msg="metadata content store policy set" policy=shared Sep 4 17:37:39.205417 containerd[1369]: time="2024-09-04T17:37:39.205379562Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 4 17:37:39.205460 containerd[1369]: time="2024-09-04T17:37:39.205446418Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 4 17:37:39.205492 containerd[1369]: time="2024-09-04T17:37:39.205469826Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 4 17:37:39.205586 containerd[1369]: time="2024-09-04T17:37:39.205493566Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 4 17:37:39.205586 containerd[1369]: time="2024-09-04T17:37:39.205511486Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 4 17:37:39.205715 containerd[1369]: time="2024-09-04T17:37:39.205668813Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 4 17:37:39.205994 containerd[1369]: time="2024-09-04T17:37:39.205967585Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 4 17:37:39.206106 containerd[1369]: time="2024-09-04T17:37:39.206081381Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 4 17:37:39.206129 containerd[1369]: time="2024-09-04T17:37:39.206107492Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 4 17:37:39.206129 containerd[1369]: time="2024-09-04T17:37:39.206121171Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 4 17:37:39.206172 containerd[1369]: time="2024-09-04T17:37:39.206134434Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 4 17:37:39.206172 containerd[1369]: time="2024-09-04T17:37:39.206147447Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 4 17:37:39.206172 containerd[1369]: time="2024-09-04T17:37:39.206160835Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 4 17:37:39.206223 containerd[1369]: time="2024-09-04T17:37:39.206175595Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 4 17:37:39.206223 containerd[1369]: time="2024-09-04T17:37:39.206191103Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 4 17:37:39.206223 containerd[1369]: time="2024-09-04T17:37:39.206204699Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 4 17:37:39.206223 containerd[1369]: time="2024-09-04T17:37:39.206219542Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 4 17:37:39.206292 containerd[1369]: time="2024-09-04T17:37:39.206235881Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 4 17:37:39.206292 containerd[1369]: time="2024-09-04T17:37:39.206257501Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206292 containerd[1369]: time="2024-09-04T17:37:39.206271305Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206292 containerd[1369]: time="2024-09-04T17:37:39.206285358Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206388 containerd[1369]: time="2024-09-04T17:37:39.206300825Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206388 containerd[1369]: time="2024-09-04T17:37:39.206314212Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206388 containerd[1369]: time="2024-09-04T17:37:39.206331051Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206388 containerd[1369]: time="2024-09-04T17:37:39.206362067Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206388 containerd[1369]: time="2024-09-04T17:37:39.206374998Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206474 containerd[1369]: time="2024-09-04T17:37:39.206388178Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206474 containerd[1369]: time="2024-09-04T17:37:39.206403852Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206474 containerd[1369]: time="2024-09-04T17:37:39.206416949Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206474 containerd[1369]: time="2024-09-04T17:37:39.206428632Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206474 containerd[1369]: time="2024-09-04T17:37:39.206441064Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206474 containerd[1369]: time="2024-09-04T17:37:39.206461104Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 4 17:37:39.206581 containerd[1369]: time="2024-09-04T17:37:39.206481892Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206581 containerd[1369]: time="2024-09-04T17:37:39.206494698Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206581 containerd[1369]: time="2024-09-04T17:37:39.206508834Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 4 17:37:39.206632 containerd[1369]: time="2024-09-04T17:37:39.206624584Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 4 17:37:39.206654 containerd[1369]: time="2024-09-04T17:37:39.206643336Z" 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 Sep 4 17:37:39.206676 containerd[1369]: time="2024-09-04T17:37:39.206655642Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 4 17:37:39.206676 containerd[1369]: time="2024-09-04T17:37:39.206669363Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 4 17:37:39.206712 containerd[1369]: time="2024-09-04T17:37:39.206679300Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.206712 containerd[1369]: time="2024-09-04T17:37:39.206692937Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 4 17:37:39.206712 containerd[1369]: time="2024-09-04T17:37:39.206703373Z" level=info msg="NRI interface is disabled by configuration." Sep 4 17:37:39.206764 containerd[1369]: time="2024-09-04T17:37:39.206714183Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 4 17:37:39.207220 containerd[1369]: time="2024-09-04T17:37:39.207148038Z" 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}" Sep 4 17:37:39.207220 containerd[1369]: time="2024-09-04T17:37:39.207216391Z" level=info msg="Connect containerd service" Sep 4 17:37:39.210527 containerd[1369]: time="2024-09-04T17:37:39.210491283Z" level=info msg="using legacy CRI server" Sep 4 17:37:39.210527 containerd[1369]: time="2024-09-04T17:37:39.210517061Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 17:37:39.210646 containerd[1369]: time="2024-09-04T17:37:39.210616430Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 4 17:37:39.211344 containerd[1369]: time="2024-09-04T17:37:39.211298915Z" 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" Sep 4 17:37:39.211793 containerd[1369]: time="2024-09-04T17:37:39.211744953Z" level=info msg="Start subscribing containerd event" Sep 4 17:37:39.211843 containerd[1369]: time="2024-09-04T17:37:39.211808399Z" level=info msg="Start recovering state" Sep 4 17:37:39.212226 containerd[1369]: time="2024-09-04T17:37:39.211871929Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 17:37:39.212226 containerd[1369]: time="2024-09-04T17:37:39.211896543Z" level=info msg="Start event monitor" Sep 4 17:37:39.212226 containerd[1369]: time="2024-09-04T17:37:39.211910429Z" level=info msg="Start snapshots syncer" Sep 4 17:37:39.212226 containerd[1369]: time="2024-09-04T17:37:39.211920824Z" level=info msg="Start cni network conf syncer for default" Sep 4 17:37:39.212226 containerd[1369]: time="2024-09-04T17:37:39.211929513Z" level=info msg="Start streaming server" Sep 4 17:37:39.212226 containerd[1369]: time="2024-09-04T17:37:39.211922445Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 17:37:39.212226 containerd[1369]: time="2024-09-04T17:37:39.212204877Z" level=info msg="containerd successfully booted in 0.043257s" Sep 4 17:37:39.212476 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 17:37:40.465084 systemd-networkd[1305]: eth0: Gained IPv6LL Sep 4 17:37:40.468418 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 4 17:37:40.470144 systemd[1]: Reached target network-online.target - Network is Online. Sep 4 17:37:40.480592 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 4 17:37:40.482800 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 4 17:37:40.500503 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 4 17:37:40.500674 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 4 17:37:40.503103 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 4 17:37:40.508024 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 4 17:37:40.937829 sshd_keygen[1367]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 4 17:37:40.960708 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 4 17:37:40.968606 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 4 17:37:40.974699 systemd[1]: issuegen.service: Deactivated successfully. Sep 4 17:37:40.974896 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 4 17:37:40.978615 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 4 17:37:40.994452 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 4 17:37:41.011690 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 4 17:37:41.014086 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 4 17:37:41.015503 systemd[1]: Reached target getty.target - Login Prompts. Sep 4 17:37:41.016544 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 4 17:37:41.024446 systemd[1]: Startup finished in 604ms (kernel) + 3.647s (initrd) + 3.703s (userspace) = 7.956s. Sep 4 17:37:47.180922 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 4 17:37:47.182059 systemd[1]: Started sshd@0-10.0.0.117:22-10.0.0.1:39682.service - OpenSSH per-connection server daemon (10.0.0.1:39682). Sep 4 17:37:47.240987 sshd[1446]: Accepted publickey for core from 10.0.0.1 port 39682 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:37:47.242739 sshd[1446]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:37:47.257151 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 4 17:37:47.267621 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 4 17:37:47.269741 systemd-logind[1357]: New session 1 of user core. Sep 4 17:37:47.280401 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 4 17:37:47.283199 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 4 17:37:47.290060 (systemd)[1450]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:37:47.369225 systemd[1450]: Queued start job for default target default.target. Sep 4 17:37:47.385222 systemd[1450]: Created slice app.slice - User Application Slice. Sep 4 17:37:47.385251 systemd[1450]: Reached target paths.target - Paths. Sep 4 17:37:47.385263 systemd[1450]: Reached target timers.target - Timers. Sep 4 17:37:47.386454 systemd[1450]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 4 17:37:47.396791 systemd[1450]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 4 17:37:47.396869 systemd[1450]: Reached target sockets.target - Sockets. Sep 4 17:37:47.396881 systemd[1450]: Reached target basic.target - Basic System. Sep 4 17:37:47.396915 systemd[1450]: Reached target default.target - Main User Target. Sep 4 17:37:47.396949 systemd[1450]: Startup finished in 101ms. Sep 4 17:37:47.397278 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 4 17:37:47.398719 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 4 17:37:47.460761 systemd[1]: Started sshd@1-10.0.0.117:22-10.0.0.1:39688.service - OpenSSH per-connection server daemon (10.0.0.1:39688). Sep 4 17:37:47.490674 sshd[1461]: Accepted publickey for core from 10.0.0.1 port 39688 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:37:47.492184 sshd[1461]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:37:47.496839 systemd-logind[1357]: New session 2 of user core. Sep 4 17:37:47.503506 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 4 17:37:47.556762 sshd[1461]: pam_unix(sshd:session): session closed for user core Sep 4 17:37:47.566587 systemd[1]: sshd@1-10.0.0.117:22-10.0.0.1:39688.service: Deactivated successfully. Sep 4 17:37:47.567818 systemd[1]: session-2.scope: Deactivated successfully. Sep 4 17:37:47.570792 systemd-logind[1357]: Session 2 logged out. Waiting for processes to exit. Sep 4 17:37:47.571182 systemd[1]: Started sshd@2-10.0.0.117:22-10.0.0.1:39704.service - OpenSSH per-connection server daemon (10.0.0.1:39704). Sep 4 17:37:47.575266 systemd-logind[1357]: Removed session 2. Sep 4 17:37:47.607977 sshd[1468]: Accepted publickey for core from 10.0.0.1 port 39704 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:37:47.609442 sshd[1468]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:37:47.613813 systemd-logind[1357]: New session 3 of user core. Sep 4 17:37:47.621471 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 4 17:37:47.670709 sshd[1468]: pam_unix(sshd:session): session closed for user core Sep 4 17:37:47.679545 systemd[1]: sshd@2-10.0.0.117:22-10.0.0.1:39704.service: Deactivated successfully. Sep 4 17:37:47.682544 systemd[1]: session-3.scope: Deactivated successfully. Sep 4 17:37:47.684268 systemd-logind[1357]: Session 3 logged out. Waiting for processes to exit. Sep 4 17:37:47.695609 systemd[1]: Started sshd@3-10.0.0.117:22-10.0.0.1:39708.service - OpenSSH per-connection server daemon (10.0.0.1:39708). Sep 4 17:37:47.696497 systemd-logind[1357]: Removed session 3. Sep 4 17:37:47.748227 sshd[1475]: Accepted publickey for core from 10.0.0.1 port 39708 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:37:47.749933 sshd[1475]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:37:47.753991 systemd-logind[1357]: New session 4 of user core. Sep 4 17:37:47.763467 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 4 17:37:47.817537 sshd[1475]: pam_unix(sshd:session): session closed for user core Sep 4 17:37:47.827777 systemd[1]: sshd@3-10.0.0.117:22-10.0.0.1:39708.service: Deactivated successfully. Sep 4 17:37:47.829162 systemd[1]: session-4.scope: Deactivated successfully. Sep 4 17:37:47.838307 systemd-logind[1357]: Session 4 logged out. Waiting for processes to exit. Sep 4 17:37:47.848584 systemd[1]: Started sshd@4-10.0.0.117:22-10.0.0.1:39710.service - OpenSSH per-connection server daemon (10.0.0.1:39710). Sep 4 17:37:47.851415 systemd-logind[1357]: Removed session 4. Sep 4 17:37:47.877593 sshd[1482]: Accepted publickey for core from 10.0.0.1 port 39710 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:37:47.878989 sshd[1482]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:37:47.883696 systemd-logind[1357]: New session 5 of user core. Sep 4 17:37:47.894460 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 4 17:37:47.957741 sudo[1485]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 4 17:37:47.958026 sudo[1485]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:47.972215 sudo[1485]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:47.974256 sshd[1482]: pam_unix(sshd:session): session closed for user core Sep 4 17:37:47.984488 systemd[1]: sshd@4-10.0.0.117:22-10.0.0.1:39710.service: Deactivated successfully. Sep 4 17:37:47.985852 systemd[1]: session-5.scope: Deactivated successfully. Sep 4 17:37:47.988427 systemd-logind[1357]: Session 5 logged out. Waiting for processes to exit. Sep 4 17:37:47.999668 systemd[1]: Started sshd@5-10.0.0.117:22-10.0.0.1:39718.service - OpenSSH per-connection server daemon (10.0.0.1:39718). Sep 4 17:37:48.005827 systemd-logind[1357]: Removed session 5. Sep 4 17:37:48.034146 sshd[1490]: Accepted publickey for core from 10.0.0.1 port 39718 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:37:48.035632 sshd[1490]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:37:48.039369 systemd-logind[1357]: New session 6 of user core. Sep 4 17:37:48.053473 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 4 17:37:48.104909 sudo[1495]: 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 Sep 4 17:37:48.105182 sudo[1495]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.108126 sudo[1495]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.112490 sudo[1494]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Sep 4 17:37:48.112751 sudo[1494]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.129696 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Sep 4 17:37:48.130889 auditctl[1498]: No rules Sep 4 17:37:48.131168 systemd[1]: audit-rules.service: Deactivated successfully. Sep 4 17:37:48.131340 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Sep 4 17:37:48.133508 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Sep 4 17:37:48.159065 augenrules[1516]: No rules Sep 4 17:37:48.161383 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Sep 4 17:37:48.163323 sudo[1494]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.165076 sshd[1490]: pam_unix(sshd:session): session closed for user core Sep 4 17:37:48.177715 systemd[1]: sshd@5-10.0.0.117:22-10.0.0.1:39718.service: Deactivated successfully. Sep 4 17:37:48.180116 systemd[1]: session-6.scope: Deactivated successfully. Sep 4 17:37:48.184201 systemd-logind[1357]: Session 6 logged out. Waiting for processes to exit. Sep 4 17:37:48.198629 systemd[1]: Started sshd@6-10.0.0.117:22-10.0.0.1:39734.service - OpenSSH per-connection server daemon (10.0.0.1:39734). Sep 4 17:37:48.200242 systemd-logind[1357]: Removed session 6. Sep 4 17:37:48.226795 sshd[1524]: Accepted publickey for core from 10.0.0.1 port 39734 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:37:48.228040 sshd[1524]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:37:48.232304 systemd-logind[1357]: New session 7 of user core. Sep 4 17:37:48.249065 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 4 17:37:48.310638 sudo[1527]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/unshare -m bash -c 'umount /etc || { echo "Could not unmount /etc"; exit 1; }; if test -e "/etc/hosts" || test -e "/etc/security" || test -e "/etc/profile.d" || test -e "/etc/shells" || test -e "/etc/os-release" ; then echo "Unexpected overlay copy in /etc on initial boot: $_" ; exit 1; fi' Sep 4 17:37:48.310916 sudo[1527]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.318257 sudo[1527]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.319652 sshd[1524]: pam_unix(sshd:session): session closed for user core Sep 4 17:37:48.336624 systemd[1]: sshd@6-10.0.0.117:22-10.0.0.1:39734.service: Deactivated successfully. Sep 4 17:37:48.338133 systemd[1]: session-7.scope: Deactivated successfully. Sep 4 17:37:48.339348 systemd-logind[1357]: Session 7 logged out. Waiting for processes to exit. Sep 4 17:37:48.340466 systemd[1]: Started sshd@7-10.0.0.117:22-10.0.0.1:39742.service - OpenSSH per-connection server daemon (10.0.0.1:39742). Sep 4 17:37:48.341700 systemd-logind[1357]: Removed session 7. Sep 4 17:37:48.373739 sshd[1533]: Accepted publickey for core from 10.0.0.1 port 39742 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:37:48.375122 sshd[1533]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:37:48.379573 systemd-logind[1357]: New session 8 of user core. Sep 4 17:37:48.390472 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 4 17:37:48.446454 sudo[1537]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -r /etc/sssd Sep 4 17:37:48.447038 sudo[1537]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.450555 sudo[1537]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.455749 sudo[1539]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mkdir /etc/sssd Sep 4 17:37:48.456015 sudo[1539]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.459982 sudo[1539]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.465057 sudo[1541]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/chmod 700 /etc/sssd Sep 4 17:37:48.465611 sudo[1541]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.469029 sudo[1541]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.473918 sudo[1543]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm /etc/kexec.conf Sep 4 17:37:48.474181 sudo[1543]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.478138 sudo[1543]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.483128 sudo[1545]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/samba Sep 4 17:37:48.483455 sudo[1545]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.486989 sudo[1545]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.492504 sudo[1547]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -r /etc/bash Sep 4 17:37:48.493145 sudo[1547]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.497636 sudo[1547]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.503001 sudo[1549]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/cp -a /usr/share/flatcar/etc/bash /etc/bash Sep 4 17:37:48.503283 sudo[1549]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.508211 sudo[1549]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.514518 sudo[1536]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/touch /etc/bash/hello Sep 4 17:37:48.514914 sudo[1536]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.523013 sudo[1536]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.529561 sshd[1533]: pam_unix(sshd:session): session closed for user core Sep 4 17:37:48.538762 systemd[1]: sshd@7-10.0.0.117:22-10.0.0.1:39742.service: Deactivated successfully. Sep 4 17:37:48.540422 systemd[1]: session-8.scope: Deactivated successfully. Sep 4 17:37:48.541912 systemd-logind[1357]: Session 8 logged out. Waiting for processes to exit. Sep 4 17:37:48.543232 systemd[1]: Started sshd@8-10.0.0.117:22-10.0.0.1:39748.service - OpenSSH per-connection server daemon (10.0.0.1:39748). Sep 4 17:37:48.547807 systemd-logind[1357]: Removed session 8. Sep 4 17:37:48.582170 sshd[1555]: Accepted publickey for core from 10.0.0.1 port 39748 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:37:48.583599 sshd[1555]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:37:48.588126 systemd-logind[1357]: New session 9 of user core. Sep 4 17:37:48.597508 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 4 17:37:48.649622 sudo[1558]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm /etc/resolv.conf Sep 4 17:37:48.649902 sudo[1558]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 17:37:48.653114 sudo[1558]: pam_unix(sudo:session): session closed for user root Sep 4 17:37:48.655038 sshd[1555]: pam_unix(sshd:session): session closed for user core Sep 4 17:37:48.664952 systemd[1]: sshd@8-10.0.0.117:22-10.0.0.1:39748.service: Deactivated successfully. Sep 4 17:37:48.666831 systemd[1]: session-9.scope: Deactivated successfully. Sep 4 17:37:48.671483 systemd-logind[1357]: Session 9 logged out. Waiting for processes to exit. Sep 4 17:37:48.679387 systemd[1]: Started sshd@9-10.0.0.117:22-10.0.0.1:39752.service - OpenSSH per-connection server daemon (10.0.0.1:39752). Sep 4 17:37:48.680567 systemd-logind[1357]: Removed session 9. Sep 4 17:37:48.727628 sshd[1563]: Accepted publickey for core from 10.0.0.1 port 39752 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:37:48.729066 sshd[1563]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:37:48.733286 systemd-logind[1357]: New session 10 of user core. Sep 4 17:37:48.741605 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 4 17:37:48.795940 sudo[1566]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/unshare -m bash -c 'umount /etc && cp -a /usr/share/flatcar/etc/{hosts,shells,os-release} /etc/ && mkdir /etc/security /etc/profile.d' Sep 4 17:37:48.796221 sudo[1566]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) -- Reboot -- Sep 4 17:37:56.934650 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Sep 4 17:37:56.934674 kernel: Linux version 6.6.48-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Wed Sep 4 15:58:01 -00 2024 Sep 4 17:37:56.934691 kernel: KASLR enabled Sep 4 17:37:56.934697 kernel: efi: EFI v2.7 by EDK II Sep 4 17:37:56.934705 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb8fd018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 Sep 4 17:37:56.934711 kernel: random: crng init done Sep 4 17:37:56.934718 kernel: ACPI: Early table checksum verification disabled Sep 4 17:37:56.934725 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Sep 4 17:37:56.934731 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Sep 4 17:37:56.934739 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:56.934745 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:56.934752 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:56.934758 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:56.934764 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:56.934771 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:56.934779 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:56.934786 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:56.934793 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:37:56.934799 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Sep 4 17:37:56.934806 kernel: NUMA: Failed to initialise from firmware Sep 4 17:37:56.934812 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Sep 4 17:37:56.934819 kernel: NUMA: NODE_DATA [mem 0xdc957800-0xdc95cfff] Sep 4 17:37:56.934826 kernel: Zone ranges: Sep 4 17:37:56.934832 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Sep 4 17:37:56.934838 kernel: DMA32 empty Sep 4 17:37:56.934846 kernel: Normal empty Sep 4 17:37:56.934852 kernel: Movable zone start for each node Sep 4 17:37:56.934859 kernel: Early memory node ranges Sep 4 17:37:56.934865 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Sep 4 17:37:56.934872 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Sep 4 17:37:56.934878 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Sep 4 17:37:56.934884 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Sep 4 17:37:56.934891 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Sep 4 17:37:56.934897 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Sep 4 17:37:56.934903 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Sep 4 17:37:56.934910 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Sep 4 17:37:56.934916 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Sep 4 17:37:56.934924 kernel: psci: probing for conduit method from ACPI. Sep 4 17:37:56.934930 kernel: psci: PSCIv1.1 detected in firmware. Sep 4 17:37:56.934937 kernel: psci: Using standard PSCI v0.2 function IDs Sep 4 17:37:56.934946 kernel: psci: Trusted OS migration not required Sep 4 17:37:56.934952 kernel: psci: SMC Calling Convention v1.1 Sep 4 17:37:56.934959 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Sep 4 17:37:56.934967 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Sep 4 17:37:56.934974 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Sep 4 17:37:56.934981 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 4 17:37:56.934988 kernel: Detected PIPT I-cache on CPU0 Sep 4 17:37:56.934995 kernel: CPU features: detected: GIC system register CPU interface Sep 4 17:37:56.935002 kernel: CPU features: detected: Hardware dirty bit management Sep 4 17:37:56.935009 kernel: CPU features: detected: Spectre-v4 Sep 4 17:37:56.935015 kernel: CPU features: detected: Spectre-BHB Sep 4 17:37:56.935022 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 4 17:37:56.935029 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 4 17:37:56.935038 kernel: CPU features: detected: ARM erratum 1418040 Sep 4 17:37:56.935052 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 4 17:37:56.935059 kernel: alternatives: applying boot alternatives Sep 4 17:37:56.935067 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 acpi=force verity.usrhash=28a986328b36e7de6a755f88bb335afbeb3e3932bc9a20c5f8e57b952c2d23a9 Sep 4 17:37:56.935074 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 4 17:37:56.935081 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 4 17:37:56.935088 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 4 17:37:56.935095 kernel: Fallback order for Node 0: 0 Sep 4 17:37:56.935102 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Sep 4 17:37:56.935108 kernel: Policy zone: DMA Sep 4 17:37:56.935115 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 4 17:37:56.935123 kernel: software IO TLB: area num 4. Sep 4 17:37:56.935130 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Sep 4 17:37:56.935138 kernel: Memory: 2386592K/2572288K available (10240K kernel code, 2184K rwdata, 8084K rodata, 39296K init, 897K bss, 185696K reserved, 0K cma-reserved) Sep 4 17:37:56.935145 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 4 17:37:56.935151 kernel: trace event string verifier disabled Sep 4 17:37:56.935158 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 4 17:37:56.935166 kernel: rcu: RCU event tracing is enabled. Sep 4 17:37:56.935173 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 4 17:37:56.935180 kernel: Trampoline variant of Tasks RCU enabled. Sep 4 17:37:56.935186 kernel: Tracing variant of Tasks RCU enabled. Sep 4 17:37:56.935193 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 4 17:37:56.935200 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 4 17:37:56.935209 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 4 17:37:56.935216 kernel: GICv3: 256 SPIs implemented Sep 4 17:37:56.935223 kernel: GICv3: 0 Extended SPIs implemented Sep 4 17:37:56.935230 kernel: Root IRQ handler: gic_handle_irq Sep 4 17:37:56.935237 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Sep 4 17:37:56.935243 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Sep 4 17:37:56.935250 kernel: ITS [mem 0x08080000-0x0809ffff] Sep 4 17:37:56.935257 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Sep 4 17:37:56.935278 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Sep 4 17:37:56.935286 kernel: GICv3: using LPI property table @0x00000000400f0000 Sep 4 17:37:56.935292 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Sep 4 17:37:56.935302 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 4 17:37:56.935309 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 4 17:37:56.935316 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Sep 4 17:37:56.935323 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Sep 4 17:37:56.935330 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Sep 4 17:37:56.935336 kernel: arm-pv: using stolen time PV Sep 4 17:37:56.935344 kernel: Console: colour dummy device 80x25 Sep 4 17:37:56.935351 kernel: ACPI: Core revision 20230628 Sep 4 17:37:56.935358 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Sep 4 17:37:56.935365 kernel: pid_max: default: 32768 minimum: 301 Sep 4 17:37:56.935373 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Sep 4 17:37:56.935380 kernel: landlock: Up and running. Sep 4 17:37:56.935387 kernel: SELinux: Initializing. Sep 4 17:37:56.935394 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 17:37:56.935401 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 17:37:56.935408 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Sep 4 17:37:56.935415 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Sep 4 17:37:56.935422 kernel: rcu: Hierarchical SRCU implementation. Sep 4 17:37:56.935429 kernel: rcu: Max phase no-delay instances is 400. Sep 4 17:37:56.935436 kernel: Platform MSI: ITS@0x8080000 domain created Sep 4 17:37:56.935444 kernel: PCI/MSI: ITS@0x8080000 domain created Sep 4 17:37:56.935451 kernel: Remapping and enabling EFI services. Sep 4 17:37:56.935458 kernel: smp: Bringing up secondary CPUs ... Sep 4 17:37:56.935465 kernel: Detected PIPT I-cache on CPU1 Sep 4 17:37:56.935472 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Sep 4 17:37:56.935479 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Sep 4 17:37:56.935486 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 4 17:37:56.935493 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Sep 4 17:37:56.935500 kernel: Detected PIPT I-cache on CPU2 Sep 4 17:37:56.935509 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Sep 4 17:37:56.935523 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Sep 4 17:37:56.935536 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 4 17:37:56.935545 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Sep 4 17:37:56.935553 kernel: Detected PIPT I-cache on CPU3 Sep 4 17:37:56.935560 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Sep 4 17:37:56.935569 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Sep 4 17:37:56.935576 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 4 17:37:56.935595 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Sep 4 17:37:56.935603 kernel: smp: Brought up 1 node, 4 CPUs Sep 4 17:37:56.935611 kernel: SMP: Total of 4 processors activated. Sep 4 17:37:56.935618 kernel: CPU features: detected: 32-bit EL0 Support Sep 4 17:37:56.935626 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 4 17:37:56.935634 kernel: CPU features: detected: Common not Private translations Sep 4 17:37:56.935641 kernel: CPU features: detected: CRC32 instructions Sep 4 17:37:56.935649 kernel: CPU features: detected: Enhanced Virtualization Traps Sep 4 17:37:56.935656 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 4 17:37:56.935665 kernel: CPU features: detected: LSE atomic instructions Sep 4 17:37:56.935673 kernel: CPU features: detected: Privileged Access Never Sep 4 17:37:56.935680 kernel: CPU features: detected: RAS Extension Support Sep 4 17:37:56.935687 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 4 17:37:56.935695 kernel: CPU: All CPU(s) started at EL1 Sep 4 17:37:56.935705 kernel: alternatives: applying system-wide alternatives Sep 4 17:37:56.935714 kernel: devtmpfs: initialized Sep 4 17:37:56.935722 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 4 17:37:56.935729 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 4 17:37:56.935739 kernel: pinctrl core: initialized pinctrl subsystem Sep 4 17:37:56.935746 kernel: SMBIOS 3.0.0 present. Sep 4 17:37:56.935754 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Sep 4 17:37:56.935762 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 4 17:37:56.935771 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 4 17:37:56.935779 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 4 17:37:56.935786 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 4 17:37:56.935794 kernel: audit: initializing netlink subsys (disabled) Sep 4 17:37:56.935801 kernel: audit: type=2000 audit(0.023:1): state=initialized audit_enabled=0 res=1 Sep 4 17:37:56.935811 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 4 17:37:56.935822 kernel: cpuidle: using governor menu Sep 4 17:37:56.935829 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 4 17:37:56.935842 kernel: ASID allocator initialised with 32768 entries Sep 4 17:37:56.935849 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 4 17:37:56.935856 kernel: Serial: AMBA PL011 UART driver Sep 4 17:37:56.935864 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 4 17:37:56.935872 kernel: Modules: 0 pages in range for non-PLT usage Sep 4 17:37:56.935879 kernel: Modules: 509056 pages in range for PLT usage Sep 4 17:37:56.935888 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 4 17:37:56.935896 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 4 17:37:56.935903 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 4 17:37:56.935911 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 4 17:37:56.935918 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 4 17:37:56.935925 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 4 17:37:56.935933 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 4 17:37:56.935940 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 4 17:37:56.935947 kernel: ACPI: Added _OSI(Module Device) Sep 4 17:37:56.935957 kernel: ACPI: Added _OSI(Processor Device) Sep 4 17:37:56.935964 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Sep 4 17:37:56.935972 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 4 17:37:56.935979 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 4 17:37:56.935986 kernel: ACPI: Interpreter enabled Sep 4 17:37:56.935994 kernel: ACPI: Using GIC for interrupt routing Sep 4 17:37:56.936001 kernel: ACPI: MCFG table detected, 1 entries Sep 4 17:37:56.936009 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Sep 4 17:37:56.936016 kernel: printk: console [ttyAMA0] enabled Sep 4 17:37:56.936023 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 4 17:37:56.936194 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 4 17:37:56.936278 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 4 17:37:56.936346 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 4 17:37:56.936415 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Sep 4 17:37:56.936481 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Sep 4 17:37:56.936491 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Sep 4 17:37:56.936502 kernel: PCI host bridge to bus 0000:00 Sep 4 17:37:56.936606 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Sep 4 17:37:56.936672 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 4 17:37:56.936735 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Sep 4 17:37:56.936798 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 4 17:37:56.936882 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Sep 4 17:37:56.936961 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Sep 4 17:37:56.937036 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Sep 4 17:37:56.937128 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Sep 4 17:37:56.937197 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Sep 4 17:37:56.937267 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Sep 4 17:37:56.937339 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Sep 4 17:37:56.937409 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Sep 4 17:37:56.937473 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Sep 4 17:37:56.937550 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 4 17:37:56.937613 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Sep 4 17:37:56.937623 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 4 17:37:56.937631 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 4 17:37:56.937639 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 4 17:37:56.937647 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 4 17:37:56.937655 kernel: iommu: Default domain type: Translated Sep 4 17:37:56.937662 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 4 17:37:56.937672 kernel: efivars: Registered efivars operations Sep 4 17:37:56.937680 kernel: vgaarb: loaded Sep 4 17:37:56.937688 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 4 17:37:56.937695 kernel: VFS: Disk quotas dquot_6.6.0 Sep 4 17:37:56.937703 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 4 17:37:56.937710 kernel: pnp: PnP ACPI init Sep 4 17:37:56.937808 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Sep 4 17:37:56.937820 kernel: pnp: PnP ACPI: found 1 devices Sep 4 17:37:56.937831 kernel: NET: Registered PF_INET protocol family Sep 4 17:37:56.937839 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 4 17:37:56.937847 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 4 17:37:56.937854 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 4 17:37:56.937862 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 4 17:37:56.937871 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 4 17:37:56.937878 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 4 17:37:56.937885 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 17:37:56.937893 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 17:37:56.937902 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 4 17:37:56.937910 kernel: PCI: CLS 0 bytes, default 64 Sep 4 17:37:56.937917 kernel: kvm [1]: HYP mode not available Sep 4 17:37:56.937925 kernel: Initialise system trusted keyrings Sep 4 17:37:56.937932 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 4 17:37:56.937940 kernel: Key type asymmetric registered Sep 4 17:37:56.937948 kernel: Asymmetric key parser 'x509' registered Sep 4 17:37:56.937955 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 4 17:37:56.937963 kernel: io scheduler mq-deadline registered Sep 4 17:37:56.937972 kernel: io scheduler kyber registered Sep 4 17:37:56.937980 kernel: io scheduler bfq registered Sep 4 17:37:56.937988 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 4 17:37:56.937996 kernel: ACPI: button: Power Button [PWRB] Sep 4 17:37:56.938004 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 4 17:37:56.938089 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Sep 4 17:37:56.938100 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 4 17:37:56.938107 kernel: thunder_xcv, ver 1.0 Sep 4 17:37:56.938115 kernel: thunder_bgx, ver 1.0 Sep 4 17:37:56.938124 kernel: nicpf, ver 1.0 Sep 4 17:37:56.938132 kernel: nicvf, ver 1.0 Sep 4 17:37:56.938214 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 4 17:37:56.938281 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-09-04T17:37:56 UTC (1725471476) Sep 4 17:37:56.938292 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 4 17:37:56.938300 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Sep 4 17:37:56.938307 kernel: watchdog: Delayed init of the lockup detector failed: -19 Sep 4 17:37:56.938315 kernel: watchdog: Hard watchdog permanently disabled Sep 4 17:37:56.938324 kernel: NET: Registered PF_INET6 protocol family Sep 4 17:37:56.938336 kernel: Segment Routing with IPv6 Sep 4 17:37:56.938344 kernel: In-situ OAM (IOAM) with IPv6 Sep 4 17:37:56.938351 kernel: NET: Registered PF_PACKET protocol family Sep 4 17:37:56.938358 kernel: Key type dns_resolver registered Sep 4 17:37:56.938366 kernel: registered taskstats version 1 Sep 4 17:37:56.938377 kernel: Loading compiled-in X.509 certificates Sep 4 17:37:56.938384 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.48-flatcar: 6782952639b29daf968f5d0c3e73fb25e5af1d5e' Sep 4 17:37:56.938392 kernel: Key type .fscrypt registered Sep 4 17:37:56.938399 kernel: Key type fscrypt-provisioning registered Sep 4 17:37:56.938408 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 4 17:37:56.938416 kernel: ima: Allocated hash algorithm: sha1 Sep 4 17:37:56.938423 kernel: ima: No architecture policies found Sep 4 17:37:56.938430 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 4 17:37:56.938438 kernel: clk: Disabling unused clocks Sep 4 17:37:56.938445 kernel: Freeing unused kernel memory: 39296K Sep 4 17:37:56.938452 kernel: Run /init as init process Sep 4 17:37:56.938460 kernel: with arguments: Sep 4 17:37:56.938469 kernel: /init Sep 4 17:37:56.938476 kernel: with environment: Sep 4 17:37:56.938484 kernel: HOME=/ Sep 4 17:37:56.938491 kernel: TERM=linux Sep 4 17:37:56.938498 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 4 17:37:56.938508 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) Sep 4 17:37:56.938526 systemd[1]: Detected virtualization kvm. Sep 4 17:37:56.938534 systemd[1]: Detected architecture arm64. Sep 4 17:37:56.938544 systemd[1]: Running in initrd. Sep 4 17:37:56.938552 systemd[1]: No hostname configured, using default hostname. Sep 4 17:37:56.938560 systemd[1]: Hostname set to . Sep 4 17:37:56.938568 systemd[1]: Initializing machine ID from VM UUID. Sep 4 17:37:56.938576 systemd[1]: Queued start job for default target initrd.target. Sep 4 17:37:56.938583 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 17:37:56.938591 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 17:37:56.938600 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 17:37:56.938610 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 4 17:37:56.938618 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-ROOT.device - /dev/disk/by-partlabel/ROOT... Sep 4 17:37:56.938626 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 4 17:37:56.938636 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 4 17:37:56.938644 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 4 17:37:56.938652 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 17:37:56.938660 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 17:37:56.938670 systemd[1]: Reached target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Sep 4 17:37:56.938679 systemd[1]: Reached target paths.target - Path Units. Sep 4 17:37:56.938687 systemd[1]: Reached target slices.target - Slice Units. Sep 4 17:37:56.938696 systemd[1]: Reached target swap.target - Swaps. Sep 4 17:37:56.938704 systemd[1]: Reached target timers.target - Timer Units. Sep 4 17:37:56.938712 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 17:37:56.938720 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 17:37:56.938728 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 4 17:37:56.938739 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Sep 4 17:37:56.938747 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 17:37:56.938755 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 17:37:56.938763 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 17:37:56.938772 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 4 17:37:56.938780 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 17:37:56.938788 systemd[1]: Starting systemd-fsck-usr.service... Sep 4 17:37:56.938796 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 17:37:56.938805 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 17:37:56.938814 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:37:56.938822 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 4 17:37:56.938830 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 17:37:56.938838 systemd[1]: Finished systemd-fsck-usr.service. Sep 4 17:37:56.938866 systemd-journald[231]: Collecting audit messages is disabled. Sep 4 17:37:56.938888 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 17:37:56.938897 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 4 17:37:56.938906 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:37:56.938916 systemd-journald[231]: Journal started Sep 4 17:37:56.938935 systemd-journald[231]: Runtime Journal (/run/log/journal/4e44dc513c7b44eaba76d4349dfdc730) is 5.9M, max 47.3M, 41.4M free. Sep 4 17:37:56.924492 systemd-modules-load[233]: Inserted module 'overlay' Sep 4 17:37:56.940602 systemd-modules-load[233]: Inserted module 'br_netfilter' Sep 4 17:37:56.943391 kernel: Bridge firewalling registered Sep 4 17:37:56.943415 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 17:37:56.944731 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 17:37:56.946153 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 17:37:56.951221 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 17:37:56.953148 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 17:37:56.955899 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 17:37:56.959261 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 17:37:56.969040 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 17:37:56.972087 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 17:37:56.973561 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 17:37:56.979208 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:37:56.988248 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 4 17:37:57.000039 dracut-cmdline[267]: dracut-dracut-053 Sep 4 17:37:57.002811 dracut-cmdline[267]: 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 acpi=force verity.usrhash=28a986328b36e7de6a755f88bb335afbeb3e3932bc9a20c5f8e57b952c2d23a9 Sep 4 17:37:57.075103 kernel: SCSI subsystem initialized Sep 4 17:37:57.080072 kernel: Loading iSCSI transport class v2.0-870. Sep 4 17:37:57.090090 kernel: iscsi: registered transport (tcp) Sep 4 17:37:57.103143 kernel: iscsi: registered transport (qla4xxx) Sep 4 17:37:57.103225 kernel: QLogic iSCSI HBA Driver Sep 4 17:37:57.148751 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 4 17:37:57.165204 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 4 17:37:57.185824 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 4 17:37:57.185888 kernel: device-mapper: uevent: version 1.0.3 Sep 4 17:37:57.186992 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Sep 4 17:37:57.234088 kernel: raid6: neonx8 gen() 15752 MB/s Sep 4 17:37:57.251081 kernel: raid6: neonx4 gen() 15610 MB/s Sep 4 17:37:57.268076 kernel: raid6: neonx2 gen() 13209 MB/s Sep 4 17:37:57.285065 kernel: raid6: neonx1 gen() 10439 MB/s Sep 4 17:37:57.302075 kernel: raid6: int64x8 gen() 6953 MB/s Sep 4 17:37:57.319071 kernel: raid6: int64x4 gen() 7340 MB/s Sep 4 17:37:57.336076 kernel: raid6: int64x2 gen() 6120 MB/s Sep 4 17:37:57.353228 kernel: raid6: int64x1 gen() 5031 MB/s Sep 4 17:37:57.353289 kernel: raid6: using algorithm neonx8 gen() 15752 MB/s Sep 4 17:37:57.371257 kernel: raid6: .... xor() 11919 MB/s, rmw enabled Sep 4 17:37:57.371324 kernel: raid6: using neon recovery algorithm Sep 4 17:37:57.377244 kernel: xor: measuring software checksum speed Sep 4 17:37:57.377293 kernel: 8regs : 19864 MB/sec Sep 4 17:37:57.378256 kernel: 32regs : 19673 MB/sec Sep 4 17:37:57.379283 kernel: arm64_neon : 27234 MB/sec Sep 4 17:37:57.379324 kernel: xor: using function: arm64_neon (27234 MB/sec) Sep 4 17:37:57.432086 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 4 17:37:57.444990 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 4 17:37:57.453232 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 17:37:57.466775 systemd-udevd[450]: Using default interface naming scheme 'v255'. Sep 4 17:37:57.470057 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 17:37:57.482618 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 4 17:37:57.494730 dracut-pre-trigger[459]: rd.md=0: removing MD RAID activation Sep 4 17:37:57.525434 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 17:37:57.535343 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 17:37:57.578268 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 17:37:57.612080 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Sep 4 17:37:57.618631 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 4 17:37:57.620873 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 17:37:57.627031 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 17:37:57.621000 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:37:57.627084 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 17:37:57.629778 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 17:37:57.629953 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:37:57.633278 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:37:57.642643 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:37:57.649066 kernel: BTRFS: device fsid 3e706a0f-a579-4862-bc52-e66e95e66d87 devid 1 transid 42 /dev/vda3 scanned by (udev-worker) (507) Sep 4 17:37:57.652081 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by (udev-worker) (499) Sep 4 17:37:57.660085 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:37:57.668218 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 4 17:37:57.669469 systemd[1]: Found device dev-disk-by\x2dpartlabel-ROOT.device - /dev/disk/by-partlabel/ROOT. Sep 4 17:37:57.674437 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 4 17:37:57.675627 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 4 17:37:57.682017 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 4 17:37:57.683426 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 4 17:37:57.697257 systemd[1]: Starting decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition... Sep 4 17:37:57.700166 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 4 17:37:57.703297 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 17:37:57.706604 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 4 17:37:57.706720 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 4 17:37:57.709159 systemd[1]: Finished decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Sep 4 17:37:57.710871 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 4 17:37:57.712765 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 17:37:57.715141 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 17:37:57.717096 systemd[1]: Reached target basic.target - Basic System. Sep 4 17:37:57.719732 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 4 17:37:57.723612 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 4 17:37:57.731671 sh[544]: Success Sep 4 17:37:57.735744 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 4 17:37:57.737201 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 17:37:57.739201 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 17:37:57.742503 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 17:37:57.751095 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Sep 4 17:37:57.753233 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 4 17:37:57.754660 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:37:57.764029 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 4 17:37:57.777257 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 4 17:37:57.788141 systemd-fsck[574]: ROOT: clean, 204/553520 files, 58016/553472 blocks Sep 4 17:37:57.790754 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 4 17:37:57.801309 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 4 17:37:57.805091 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 4 17:37:57.813888 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 4 17:37:57.815028 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 4 17:37:57.827783 kernel: BTRFS info (device dm-0): first mount of filesystem 3e706a0f-a579-4862-bc52-e66e95e66d87 Sep 4 17:37:57.827826 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 4 17:37:57.829115 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Sep 4 17:37:57.830842 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 4 17:37:57.830859 kernel: BTRFS info (device dm-0): using free space tree Sep 4 17:37:57.839383 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 4 17:37:57.853067 kernel: EXT4-fs (vda9): mounted filesystem 901d46b0-2319-4536-8a6d-46889db73e8c r/w with ordered data mode. Quota mode: none. Sep 4 17:37:57.854133 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 4 17:37:57.855189 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 4 17:37:57.926183 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 17:37:57.928069 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 4 17:37:57.934697 kernel: BTRFS info (device vda6): first mount of filesystem e85e5091-8620-4def-b250-7009f4048f6e Sep 4 17:37:57.934730 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 4 17:37:57.934741 kernel: BTRFS info (device vda6): using free space tree Sep 4 17:37:57.934676 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 4 17:37:57.938404 kernel: BTRFS info (device vda6): auto enabling async discard Sep 4 17:37:57.952228 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 4 17:37:57.954403 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 17:37:58.462447 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 4 17:37:58.474223 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 4 17:37:58.478715 initrd-setup-root-after-ignition[1061]: grep: /sysroot/oem/oem-release: No such file or directory Sep 4 17:37:58.482516 initrd-setup-root-after-ignition[1063]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 17:37:58.482516 initrd-setup-root-after-ignition[1063]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 4 17:37:58.485690 initrd-setup-root-after-ignition[1067]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 17:37:58.484760 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 17:37:58.489012 systemd[1]: Reached target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Sep 4 17:37:58.501223 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 4 17:37:58.525035 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 4 17:37:58.525176 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 4 17:37:58.527435 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 4 17:37:58.529346 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 4 17:37:58.531161 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 4 17:37:58.535220 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 4 17:37:58.551329 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 17:37:58.561259 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 4 17:37:58.569118 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 17:37:58.570413 systemd[1]: Stopped target timers.target - Timer Units. Sep 4 17:37:58.572167 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 4 17:37:58.572299 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 17:37:58.574836 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 4 17:37:58.577380 systemd[1]: Stopped target basic.target - Basic System. Sep 4 17:37:58.578987 systemd[1]: Stopped target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Sep 4 17:37:58.580780 systemd[1]: Stopped target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Sep 4 17:37:58.583035 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 4 17:37:58.585146 systemd[1]: Stopped target paths.target - Path Units. Sep 4 17:37:58.586869 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 4 17:37:58.588526 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 17:37:58.590796 systemd[1]: Stopped target slices.target - Slice Units. Sep 4 17:37:58.592626 systemd[1]: Stopped target sockets.target - Socket Units. Sep 4 17:37:58.594141 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 4 17:37:58.595806 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 4 17:37:58.597461 systemd[1]: Stopped target swap.target - Swaps. Sep 4 17:37:58.598953 systemd[1]: iscsid.socket: Deactivated successfully. Sep 4 17:37:58.599065 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 17:37:58.600435 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 4 17:37:58.600537 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 17:37:58.602314 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 4 17:37:58.602432 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 4 17:37:58.604698 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 4 17:37:58.605814 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 4 17:37:58.610104 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 17:37:58.612061 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 17:37:58.614872 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 4 17:37:58.618117 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 17:37:58.619379 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 4 17:37:58.619523 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 4 17:37:58.622283 systemd[1]: decrypt-root.service: Deactivated successfully. Sep 4 17:37:58.622408 systemd[1]: Stopped decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Sep 4 17:37:58.624452 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 4 17:37:58.624573 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 4 17:37:58.626542 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 4 17:37:58.626655 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 17:37:58.629012 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 4 17:37:58.629133 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 4 17:37:58.630808 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 4 17:37:58.630911 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 4 17:37:58.632488 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 4 17:37:58.632605 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 4 17:37:58.634520 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 4 17:37:58.634631 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 17:37:58.636797 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 4 17:37:58.636902 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 17:37:58.638687 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 4 17:37:58.638791 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 17:37:58.641564 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 17:37:58.649555 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 4 17:37:58.649651 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 4 17:37:58.657854 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 4 17:37:58.657985 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 17:37:58.659874 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 4 17:37:58.659913 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 4 17:37:58.661521 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 4 17:37:58.661554 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 17:37:58.663823 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 4 17:37:58.663874 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 4 17:37:58.666819 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 4 17:37:58.666868 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 4 17:37:58.669749 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 17:37:58.669797 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:37:58.684268 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 4 17:37:58.685393 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 4 17:37:58.685458 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 17:37:58.687729 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 4 17:37:58.687776 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 17:37:58.689927 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 4 17:37:58.689975 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 17:37:58.692240 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 17:37:58.692288 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:37:58.694683 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 4 17:37:58.694768 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 4 17:37:58.697222 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 4 17:37:58.699447 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 4 17:37:58.709923 systemd[1]: Switching root. Sep 4 17:37:58.741190 systemd-journald[231]: Journal stopped Sep 4 17:37:59.297835 systemd-journald[231]: Received SIGTERM from PID 1 (systemd). Sep 4 17:37:59.297891 kernel: SELinux: policy capability network_peer_controls=1 Sep 4 17:37:59.297904 kernel: SELinux: policy capability open_perms=1 Sep 4 17:37:59.297914 kernel: SELinux: policy capability extended_socket_class=1 Sep 4 17:37:59.297924 kernel: SELinux: policy capability always_check_network=0 Sep 4 17:37:59.297933 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 4 17:37:59.297944 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 4 17:37:59.297957 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 4 17:37:59.297967 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 4 17:37:59.297977 kernel: audit: type=1403 audit(1725471478.825:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 4 17:37:59.297988 systemd[1]: Successfully loaded SELinux policy in 34.942ms. Sep 4 17:37:59.298005 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.639ms. Sep 4 17:37:59.298017 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) Sep 4 17:37:59.298029 systemd[1]: Detected virtualization kvm. Sep 4 17:37:59.298040 systemd[1]: Detected architecture arm64. Sep 4 17:37:59.298062 zram_generator::config[1112]: No configuration found. Sep 4 17:37:59.298077 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 4 17:37:59.298087 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 4 17:37:59.298100 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 4 17:37:59.298112 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 4 17:37:59.298123 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 4 17:37:59.298134 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 4 17:37:59.298145 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 4 17:37:59.298156 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 4 17:37:59.298169 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 4 17:37:59.298180 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 4 17:37:59.298191 systemd[1]: Created slice user.slice - User and Session Slice. Sep 4 17:37:59.298202 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 17:37:59.298214 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 17:37:59.298225 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 4 17:37:59.298236 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 4 17:37:59.298246 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 4 17:37:59.298259 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 17:37:59.298270 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 4 17:37:59.298281 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 17:37:59.298292 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 4 17:37:59.298303 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 4 17:37:59.298314 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 4 17:37:59.298325 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 4 17:37:59.298337 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 17:37:59.298348 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 17:37:59.298360 systemd[1]: Reached target slices.target - Slice Units. Sep 4 17:37:59.298371 systemd[1]: Reached target swap.target - Swaps. Sep 4 17:37:59.298382 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 4 17:37:59.298393 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 4 17:37:59.298404 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 17:37:59.298414 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 17:37:59.298426 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 17:37:59.298437 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 4 17:37:59.298449 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 4 17:37:59.298460 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 4 17:37:59.298471 systemd[1]: Mounting media.mount - External Media Directory... Sep 4 17:37:59.298481 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 4 17:37:59.298498 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 4 17:37:59.298512 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 4 17:37:59.298523 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). Sep 4 17:37:59.298534 systemd[1]: Reached target machines.target - Containers. Sep 4 17:37:59.298545 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 4 17:37:59.298558 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Sep 4 17:37:59.298569 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 17:37:59.298581 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 4 17:37:59.298592 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:37:59.298602 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 17:37:59.298613 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:37:59.298624 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 4 17:37:59.298635 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 17:37:59.298649 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 4 17:37:59.298660 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 4 17:37:59.298671 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 4 17:37:59.298681 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 4 17:37:59.298691 systemd[1]: Stopped systemd-fsck-usr.service. Sep 4 17:37:59.298702 kernel: fuse: init (API version 7.39) Sep 4 17:37:59.298712 kernel: loop: module loaded Sep 4 17:37:59.298722 kernel: ACPI: bus type drm_connector registered Sep 4 17:37:59.298732 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 17:37:59.298744 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 17:37:59.298755 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 4 17:37:59.298766 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 4 17:37:59.298777 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 17:37:59.298788 systemd[1]: verity-setup.service: Deactivated successfully. Sep 4 17:37:59.298799 systemd[1]: Stopped verity-setup.service. Sep 4 17:37:59.298830 systemd-journald[1179]: Collecting audit messages is disabled. Sep 4 17:37:59.298851 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 4 17:37:59.298869 systemd-journald[1179]: Journal started Sep 4 17:37:59.298891 systemd-journald[1179]: Runtime Journal (/run/log/journal/4e44dc513c7b44eaba76d4349dfdc730) is 5.9M, max 47.3M, 41.4M free. Sep 4 17:37:59.086960 systemd[1]: Queued start job for default target multi-user.target. Sep 4 17:37:59.106875 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 4 17:37:59.107291 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 4 17:37:59.302256 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 17:37:59.302959 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 4 17:37:59.304273 systemd[1]: Mounted media.mount - External Media Directory. Sep 4 17:37:59.305440 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 4 17:37:59.306769 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 4 17:37:59.308019 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 4 17:37:59.309305 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 4 17:37:59.310779 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 17:37:59.312287 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 4 17:37:59.312432 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 4 17:37:59.313864 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:37:59.314016 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:37:59.315491 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 17:37:59.315669 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 17:37:59.317079 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:37:59.317227 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:37:59.318997 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 4 17:37:59.319166 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 4 17:37:59.321384 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 17:37:59.321657 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 17:37:59.325107 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 17:37:59.326848 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 4 17:37:59.328548 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 4 17:37:59.342794 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 17:37:59.352160 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 4 17:37:59.354550 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 4 17:37:59.355793 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 4 17:37:59.355848 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 17:37:59.358308 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Sep 4 17:37:59.360704 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 4 17:37:59.363009 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 4 17:37:59.364435 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:37:59.365561 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 4 17:37:59.368700 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 4 17:37:59.372145 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 17:37:59.373204 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 4 17:37:59.374375 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 17:37:59.377475 systemd-journald[1179]: Time spent on flushing to /var/log/journal/4e44dc513c7b44eaba76d4349dfdc730 is 35.859ms for 657 entries. Sep 4 17:37:59.377475 systemd-journald[1179]: System Journal (/var/log/journal/4e44dc513c7b44eaba76d4349dfdc730) is 10.2M, max 195.6M, 185.3M free. Sep 4 17:37:59.434354 systemd-journald[1179]: Received client request to flush runtime journal. Sep 4 17:37:59.434389 systemd-journald[1179]: /var/log/journal/4e44dc513c7b44eaba76d4349dfdc730/system.journal: Journal file uses a different sequence number ID, rotating. Sep 4 17:37:59.434408 systemd-journald[1179]: Rotating system journal. Sep 4 17:37:59.434435 kernel: loop0: detected capacity change from 0 to 114288 Sep 4 17:37:59.434448 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 4 17:37:59.378234 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 17:37:59.385620 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 4 17:37:59.392340 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 17:37:59.397800 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 17:37:59.399653 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 4 17:37:59.401112 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 4 17:37:59.402785 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 4 17:37:59.405468 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 4 17:37:59.407199 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 17:37:59.410743 systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Sep 4 17:37:59.410837 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Sep 4 17:37:59.420244 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Sep 4 17:37:59.430272 udevadm[1231]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Sep 4 17:37:59.436644 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 4 17:37:59.443623 systemd-tmpfiles[1222]: ACLs are not supported, ignoring. Sep 4 17:37:59.443642 systemd-tmpfiles[1222]: ACLs are not supported, ignoring. Sep 4 17:37:59.449014 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 17:37:59.457227 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 4 17:37:59.464172 kernel: loop1: detected capacity change from 0 to 65520 Sep 4 17:37:59.482810 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 4 17:37:59.496234 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 17:37:59.508655 kernel: loop2: detected capacity change from 0 to 114288 Sep 4 17:37:59.509448 systemd-tmpfiles[1246]: ACLs are not supported, ignoring. Sep 4 17:37:59.509466 systemd-tmpfiles[1246]: ACLs are not supported, ignoring. Sep 4 17:37:59.513094 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 17:37:59.516097 kernel: loop3: detected capacity change from 0 to 65520 Sep 4 17:37:59.519741 (sd-merge)[1248]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 4 17:37:59.520232 (sd-merge)[1248]: Merged extensions into '/usr'. Sep 4 17:37:59.523446 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 4 17:37:59.543592 systemd[1]: Starting ensure-sysext.service... Sep 4 17:37:59.545759 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 17:37:59.558408 systemd[1]: Created slice system-systemd\x2dcoredump.slice - Slice /system/systemd-coredump. Sep 4 17:37:59.559942 systemd[1]: Reloading requested from client PID 1252 ('systemctl') (unit ensure-sysext.service)... Sep 4 17:37:59.559956 systemd[1]: Reloading... Sep 4 17:37:59.565785 systemd-tmpfiles[1253]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 4 17:37:59.566083 systemd-tmpfiles[1253]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 4 17:37:59.566741 systemd-tmpfiles[1253]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 4 17:37:59.566967 systemd-tmpfiles[1253]: ACLs are not supported, ignoring. Sep 4 17:37:59.567017 systemd-tmpfiles[1253]: ACLs are not supported, ignoring. Sep 4 17:37:59.570530 systemd-tmpfiles[1253]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 17:37:59.570543 systemd-tmpfiles[1253]: Skipping /boot Sep 4 17:37:59.582456 systemd-tmpfiles[1253]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 17:37:59.582476 systemd-tmpfiles[1253]: Skipping /boot Sep 4 17:37:59.618139 zram_generator::config[1280]: No configuration found. Sep 4 17:37:59.707754 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. Sep 4 17:37:59.751518 systemd[1]: Reloading finished in 191 ms. Sep 4 17:37:59.800530 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 17:37:59.809561 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Sep 4 17:37:59.812528 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 4 17:37:59.815433 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 4 17:37:59.821952 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 17:37:59.827374 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 4 17:37:59.832464 systemd[1]: Started systemd-coredump@0-1250-0.service - Process Core Dump. Sep 4 17:37:59.838597 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Sep 4 17:37:59.840961 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:37:59.848311 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:37:59.852304 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 17:37:59.856947 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:37:59.857126 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Sep 4 17:37:59.857960 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:37:59.858188 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:37:59.860419 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:37:59.860580 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:37:59.862557 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 17:37:59.862697 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 17:37:59.871211 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Sep 4 17:37:59.878416 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:37:59.881717 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:37:59.887775 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 17:37:59.889060 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:37:59.889221 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Sep 4 17:37:59.893026 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 4 17:37:59.896965 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 4 17:37:59.899121 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 4 17:37:59.901008 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:37:59.902358 augenrules[1313]: /sbin/augenrules: No change Sep 4 17:37:59.903303 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:37:59.909593 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:37:59.909729 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:37:59.911636 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 17:37:59.911770 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 17:37:59.921562 augenrules[1338]: No rules Sep 4 17:37:59.921820 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Sep 4 17:37:59.931310 systemd-coredump[1319]: Process 1215 (ldconfig) of user 0 dumped core. Stack trace of thread 1215: #0 0x0000ffff966a130c n/a (n/a + 0x0) #1 0x0000ffff966a12f8 n/a (n/a + 0x0) #2 0x0000ffff96693610 n/a (n/a + 0x0) #3 0x0000ffff96685f18 n/a (n/a + 0x0) #4 0x0000ffff96688c08 n/a (n/a + 0x0) #5 0x0000ffff96689f9c n/a (n/a + 0x0) #6 0x0000ffff96686b40 n/a (n/a + 0x0) #7 0x0000ffff9668bfc0 n/a (n/a + 0x0) #8 0x0000ffff9668c2e4 n/a (n/a + 0x0) #9 0x0000ffff966871b0 n/a (n/a + 0x0) ELF object binary architecture: AARCH64 Sep 4 17:37:59.934414 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:37:59.937369 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 17:37:59.940376 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:37:59.945274 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 17:37:59.946444 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:37:59.946616 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Sep 4 17:37:59.947635 systemd[1]: ldconfig.service: Main process exited, code=dumped, status=6/ABRT Sep 4 17:37:59.947775 systemd[1]: ldconfig.service: Failed with result 'core-dump'. Sep 4 17:37:59.947985 systemd[1]: Failed to start ldconfig.service - Rebuild Dynamic Linker Cache. Sep 4 17:37:59.950715 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 4 17:37:59.954479 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 4 17:37:59.956359 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Sep 4 17:37:59.958030 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 4 17:37:59.959901 systemd[1]: systemd-coredump@0-1250-0.service: Deactivated successfully. Sep 4 17:37:59.962175 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:37:59.962330 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:37:59.964270 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 17:37:59.964405 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 17:37:59.966140 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:37:59.966284 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:37:59.968323 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 17:37:59.968480 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 17:37:59.973202 systemd[1]: Finished ensure-sysext.service. Sep 4 17:37:59.980960 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 17:37:59.981035 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 17:37:59.992294 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 4 17:37:59.994929 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 17:37:59.997414 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 4 17:37:59.998650 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). Sep 4 17:38:00.011348 systemd-resolved[1317]: Positive Trust Anchors: Sep 4 17:38:00.011366 systemd-resolved[1317]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 17:38:00.011398 systemd-resolved[1317]: 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 resolver.arpa corp home internal intranet lan local private test Sep 4 17:38:00.021709 systemd-resolved[1317]: Defaulting to hostname 'linux'. Sep 4 17:38:00.023041 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 4 17:38:00.026333 systemd-udevd[1372]: Using default interface naming scheme 'v255'. Sep 4 17:38:00.028701 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 17:38:00.030923 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 17:38:00.049691 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 4 17:38:00.051105 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 17:38:00.052433 systemd[1]: Reached target time-set.target - System Time Set. Sep 4 17:38:00.069369 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 17:38:00.094828 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 4 17:38:00.097248 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1377) Sep 4 17:38:00.097289 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1377) Sep 4 17:38:00.126076 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1391) Sep 4 17:38:00.142913 systemd-networkd[1379]: lo: Link UP Sep 4 17:38:00.142928 systemd-networkd[1379]: lo: Gained carrier Sep 4 17:38:00.143868 systemd-networkd[1379]: Enumeration completed Sep 4 17:38:00.143969 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 17:38:00.145389 systemd[1]: Reached target network.target - Network. Sep 4 17:38:00.150450 systemd-networkd[1379]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:38:00.150461 systemd-networkd[1379]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 17:38:00.153691 systemd-networkd[1379]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:38:00.153728 systemd-networkd[1379]: eth0: Link UP Sep 4 17:38:00.153731 systemd-networkd[1379]: eth0: Gained carrier Sep 4 17:38:00.153740 systemd-networkd[1379]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:38:00.159271 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 4 17:38:00.164704 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 4 17:38:00.168948 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 4 17:38:00.170709 systemd-networkd[1379]: eth0: DHCPv4 address 10.0.0.117/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 4 17:38:00.171317 systemd-timesyncd[1371]: Network configuration changed, trying to establish connection. Sep 4 17:38:00.171499 systemd-timesyncd[1371]: Network configuration changed, trying to establish connection. Sep 4 17:38:00.191440 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 4 17:38:00.213391 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:38:00.223222 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Sep 4 17:38:00.226109 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Sep 4 17:38:00.253299 lvm[1412]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 17:38:00.255909 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:38:00.288723 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Sep 4 17:38:00.290448 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 17:38:00.291675 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 17:38:00.292992 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 4 17:38:00.294359 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 4 17:38:00.295979 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 4 17:38:00.297232 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 4 17:38:00.298560 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 4 17:38:00.299883 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 4 17:38:00.299930 systemd[1]: Reached target paths.target - Path Units. Sep 4 17:38:00.300913 systemd[1]: Reached target timers.target - Timer Units. Sep 4 17:38:00.303297 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 4 17:38:00.305908 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 17:38:00.317157 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 4 17:38:00.319815 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Sep 4 17:38:00.321765 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 17:38:00.323134 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 17:38:00.324129 systemd[1]: Reached target basic.target - Basic System. Sep 4 17:38:00.325160 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 4 17:38:00.325196 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 4 17:38:00.326369 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 17:38:00.328628 lvm[1420]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 17:38:00.328948 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 4 17:38:00.332172 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 4 17:38:00.335382 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 4 17:38:00.336657 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). Sep 4 17:38:00.338238 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 4 17:38:00.342275 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 4 17:38:00.344656 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 4 17:38:00.346552 jq[1423]: false Sep 4 17:38:00.349693 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 4 17:38:00.356002 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 4 17:38:00.356543 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 4 17:38:00.361509 systemd[1]: Starting update-engine.service - Update Engine... Sep 4 17:38:00.365282 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 4 17:38:00.367213 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Sep 4 17:38:00.372525 dbus-daemon[1422]: [system] SELinux support is enabled Sep 4 17:38:00.372943 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 4 17:38:00.377070 extend-filesystems[1424]: Found loop2 Sep 4 17:38:00.377070 extend-filesystems[1424]: Found loop3 Sep 4 17:38:00.377070 extend-filesystems[1424]: Found vda Sep 4 17:38:00.377070 extend-filesystems[1424]: Found vda1 Sep 4 17:38:00.377070 extend-filesystems[1424]: Found vda2 Sep 4 17:38:00.377070 extend-filesystems[1424]: Found vda3 Sep 4 17:38:00.377070 extend-filesystems[1424]: Found usr Sep 4 17:38:00.377070 extend-filesystems[1424]: Found vda4 Sep 4 17:38:00.377070 extend-filesystems[1424]: Found vda6 Sep 4 17:38:00.377070 extend-filesystems[1424]: Found vda7 Sep 4 17:38:00.377070 extend-filesystems[1424]: Found vda9 Sep 4 17:38:00.377070 extend-filesystems[1424]: Checking size of /dev/vda9 Sep 4 17:38:00.376611 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 4 17:38:00.378092 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 4 17:38:00.401612 jq[1436]: true Sep 4 17:38:00.378369 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 4 17:38:00.378521 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 4 17:38:00.401901 jq[1449]: false Sep 4 17:38:00.386839 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). Sep 4 17:38:00.386881 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 4 17:38:00.392805 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). Sep 4 17:38:00.392833 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 4 17:38:00.396452 systemd[1]: motdgen.service: Deactivated successfully. Sep 4 17:38:00.398462 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 4 17:38:00.408109 extend-filesystems[1424]: Old size kept for /dev/vda9 Sep 4 17:38:00.410840 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 4 17:38:00.411008 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 4 17:38:00.412609 (ntainerd)[1457]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 4 17:38:00.416163 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 4 17:38:00.418505 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Sep 4 17:38:00.418680 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition being skipped. Sep 4 17:38:00.420091 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1381) Sep 4 17:38:00.433165 systemd-logind[1430]: Watching system buttons on /dev/input/event0 (Power Button) Sep 4 17:38:00.433752 systemd-logind[1430]: New seat seat0. Sep 4 17:38:00.440871 systemd[1]: Started systemd-logind.service - User Login Management. Sep 4 17:38:00.456687 update_engine[1434]: I0904 17:38:00.456421 1434 main.cc:92] Flatcar Update Engine starting Sep 4 17:38:00.461593 update_engine[1434]: I0904 17:38:00.458947 1434 update_check_scheduler.cc:74] Next update check in 5m14s Sep 4 17:38:00.459447 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 4 17:38:00.460794 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 4 17:38:00.463040 systemd[1]: Started update-engine.service - Update Engine. Sep 4 17:38:00.466549 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 4 17:38:00.468594 systemd[1]: issuegen.service: Deactivated successfully. Sep 4 17:38:00.468771 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 4 17:38:00.472498 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 4 17:38:00.490099 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 4 17:38:00.504474 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 4 17:38:00.506923 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 4 17:38:00.507551 locksmithd[1467]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 4 17:38:00.508332 systemd[1]: Reached target getty.target - Login Prompts. Sep 4 17:38:00.608087 containerd[1457]: time="2024-09-04T17:38:00.607672280Z" level=info msg="starting containerd" revision=8ccfc03e4e2b73c22899202ae09d0caf906d3863 version=v1.7.20 Sep 4 17:38:00.632731 containerd[1457]: time="2024-09-04T17:38:00.632676240Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:38:00.634152 containerd[1457]: time="2024-09-04T17:38:00.634102760Z" 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.48-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:38:00.634152 containerd[1457]: time="2024-09-04T17:38:00.634144360Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 4 17:38:00.634203 containerd[1457]: time="2024-09-04T17:38:00.634160200Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 4 17:38:00.634426 containerd[1457]: time="2024-09-04T17:38:00.634396080Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 4 17:38:00.634479 containerd[1457]: time="2024-09-04T17:38:00.634425800Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 4 17:38:00.634679 containerd[1457]: time="2024-09-04T17:38:00.634646800Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:38:00.634679 containerd[1457]: time="2024-09-04T17:38:00.634671120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:38:00.634862 containerd[1457]: time="2024-09-04T17:38:00.634837120Z" 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 Sep 4 17:38:00.634862 containerd[1457]: time="2024-09-04T17:38:00.634857520Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 4 17:38:00.634915 containerd[1457]: time="2024-09-04T17:38:00.634871120Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:38:00.634915 containerd[1457]: time="2024-09-04T17:38:00.634882080Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 4 17:38:00.635091 containerd[1457]: time="2024-09-04T17:38:00.635063640Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:38:00.635353 containerd[1457]: time="2024-09-04T17:38:00.635325680Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:38:00.635463 containerd[1457]: time="2024-09-04T17:38:00.635447240Z" 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 Sep 4 17:38:00.635490 containerd[1457]: time="2024-09-04T17:38:00.635463760Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 4 17:38:00.635637 containerd[1457]: time="2024-09-04T17:38:00.635618560Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 4 17:38:00.635666 containerd[1457]: time="2024-09-04T17:38:00.635655840Z" level=info msg="metadata content store policy set" policy=shared Sep 4 17:38:00.636095 containerd[1457]: time="2024-09-04T17:38:00.636064240Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 4 17:38:00.636118 containerd[1457]: time="2024-09-04T17:38:00.636111040Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 4 17:38:00.636136 containerd[1457]: time="2024-09-04T17:38:00.636127560Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 4 17:38:00.636154 containerd[1457]: time="2024-09-04T17:38:00.636143520Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 4 17:38:00.636172 containerd[1457]: time="2024-09-04T17:38:00.636158880Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 4 17:38:00.636280 containerd[1457]: time="2024-09-04T17:38:00.636256800Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 4 17:38:00.636530 containerd[1457]: time="2024-09-04T17:38:00.636505760Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 4 17:38:00.636601 containerd[1457]: time="2024-09-04T17:38:00.636586120Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 4 17:38:00.636622 containerd[1457]: time="2024-09-04T17:38:00.636605440Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 4 17:38:00.636622 containerd[1457]: time="2024-09-04T17:38:00.636620360Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 4 17:38:00.636659 containerd[1457]: time="2024-09-04T17:38:00.636636120Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 4 17:38:00.636659 containerd[1457]: time="2024-09-04T17:38:00.636649280Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 4 17:38:00.636691 containerd[1457]: time="2024-09-04T17:38:00.636660760Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 4 17:38:00.636691 containerd[1457]: time="2024-09-04T17:38:00.636674840Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 4 17:38:00.636728 containerd[1457]: time="2024-09-04T17:38:00.636688920Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 4 17:38:00.636728 containerd[1457]: time="2024-09-04T17:38:00.636702360Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 4 17:38:00.636728 containerd[1457]: time="2024-09-04T17:38:00.636714960Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 4 17:38:00.636728 containerd[1457]: time="2024-09-04T17:38:00.636726560Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 4 17:38:00.636790 containerd[1457]: time="2024-09-04T17:38:00.636750640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636790 containerd[1457]: time="2024-09-04T17:38:00.636770440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636790 containerd[1457]: time="2024-09-04T17:38:00.636782760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636845 containerd[1457]: time="2024-09-04T17:38:00.636794880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636845 containerd[1457]: time="2024-09-04T17:38:00.636807360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636845 containerd[1457]: time="2024-09-04T17:38:00.636821360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636845 containerd[1457]: time="2024-09-04T17:38:00.636833200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636911 containerd[1457]: time="2024-09-04T17:38:00.636847160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636911 containerd[1457]: time="2024-09-04T17:38:00.636859320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636911 containerd[1457]: time="2024-09-04T17:38:00.636874920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636911 containerd[1457]: time="2024-09-04T17:38:00.636886000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636911 containerd[1457]: time="2024-09-04T17:38:00.636899000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.636911 containerd[1457]: time="2024-09-04T17:38:00.636911000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.637007 containerd[1457]: time="2024-09-04T17:38:00.636927320Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 4 17:38:00.637007 containerd[1457]: time="2024-09-04T17:38:00.636966000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.637007 containerd[1457]: time="2024-09-04T17:38:00.636977520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.637007 containerd[1457]: time="2024-09-04T17:38:00.636987520Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 4 17:38:00.637131 containerd[1457]: time="2024-09-04T17:38:00.637117600Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 4 17:38:00.637151 containerd[1457]: time="2024-09-04T17:38:00.637136640Z" 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 Sep 4 17:38:00.637151 containerd[1457]: time="2024-09-04T17:38:00.637146960Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 4 17:38:00.637186 containerd[1457]: time="2024-09-04T17:38:00.637158640Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 4 17:38:00.637186 containerd[1457]: time="2024-09-04T17:38:00.637169280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.637186 containerd[1457]: time="2024-09-04T17:38:00.637183920Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 4 17:38:00.637240 containerd[1457]: time="2024-09-04T17:38:00.637194080Z" level=info msg="NRI interface is disabled by configuration." Sep 4 17:38:00.637240 containerd[1457]: time="2024-09-04T17:38:00.637205720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 4 17:38:00.637648 containerd[1457]: time="2024-09-04T17:38:00.637584400Z" 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}" Sep 4 17:38:00.637752 containerd[1457]: time="2024-09-04T17:38:00.637648240Z" level=info msg="Connect containerd service" Sep 4 17:38:00.637752 containerd[1457]: time="2024-09-04T17:38:00.637676960Z" level=info msg="using legacy CRI server" Sep 4 17:38:00.637752 containerd[1457]: time="2024-09-04T17:38:00.637683400Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 17:38:00.637810 containerd[1457]: time="2024-09-04T17:38:00.637782960Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 4 17:38:00.639056 containerd[1457]: time="2024-09-04T17:38:00.639012080Z" 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" Sep 4 17:38:00.639272 containerd[1457]: time="2024-09-04T17:38:00.639139400Z" level=info msg="Start subscribing containerd event" Sep 4 17:38:00.639298 containerd[1457]: time="2024-09-04T17:38:00.639289880Z" level=info msg="Start recovering state" Sep 4 17:38:00.639377 containerd[1457]: time="2024-09-04T17:38:00.639364120Z" level=info msg="Start event monitor" Sep 4 17:38:00.639415 containerd[1457]: time="2024-09-04T17:38:00.639384280Z" level=info msg="Start snapshots syncer" Sep 4 17:38:00.639415 containerd[1457]: time="2024-09-04T17:38:00.639394720Z" level=info msg="Start cni network conf syncer for default" Sep 4 17:38:00.639415 containerd[1457]: time="2024-09-04T17:38:00.639401720Z" level=info msg="Start streaming server" Sep 4 17:38:00.639567 containerd[1457]: time="2024-09-04T17:38:00.639547920Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 17:38:00.639615 containerd[1457]: time="2024-09-04T17:38:00.639604360Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 17:38:00.640905 containerd[1457]: time="2024-09-04T17:38:00.639658520Z" level=info msg="containerd successfully booted in 0.033384s" Sep 4 17:38:00.639760 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 17:38:00.706176 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 4 17:38:00.708895 systemd[1]: Started sshd@0-10.0.0.117:22-10.0.0.1:44314.service - OpenSSH per-connection server daemon (10.0.0.1:44314). Sep 4 17:38:00.760537 sshd[1488]: Accepted publickey for core from 10.0.0.1 port 44314 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:38:00.762331 sshd[1488]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:38:00.770410 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 4 17:38:00.785393 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 4 17:38:00.788400 systemd-logind[1430]: New session 1 of user core. Sep 4 17:38:00.798093 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 4 17:38:00.809395 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 4 17:38:00.815509 (systemd)[1492]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:38:00.893014 systemd[1492]: Queued start job for default target default.target. Sep 4 17:38:00.907097 systemd[1492]: Created slice app.slice - User Application Slice. Sep 4 17:38:00.907126 systemd[1492]: Reached target paths.target - Paths. Sep 4 17:38:00.907140 systemd[1492]: Reached target timers.target - Timers. Sep 4 17:38:00.908555 systemd[1492]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 4 17:38:00.919368 systemd[1492]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 4 17:38:00.919520 systemd[1492]: Reached target sockets.target - Sockets. Sep 4 17:38:00.919540 systemd[1492]: Reached target basic.target - Basic System. Sep 4 17:38:00.919580 systemd[1492]: Reached target default.target - Main User Target. Sep 4 17:38:00.919607 systemd[1492]: Startup finished in 98ms. Sep 4 17:38:00.919756 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 4 17:38:00.922335 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 4 17:38:00.981839 systemd[1]: Started sshd@1-10.0.0.117:22-10.0.0.1:44316.service - OpenSSH per-connection server daemon (10.0.0.1:44316). Sep 4 17:38:01.030592 sshd[1503]: Accepted publickey for core from 10.0.0.1 port 44316 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:38:01.031901 sshd[1503]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:38:01.036517 systemd-logind[1430]: New session 2 of user core. Sep 4 17:38:01.043247 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 4 17:38:01.097893 sshd[1503]: pam_unix(sshd:session): session closed for user core Sep 4 17:38:01.107593 systemd[1]: sshd@1-10.0.0.117:22-10.0.0.1:44316.service: Deactivated successfully. Sep 4 17:38:01.111289 systemd[1]: session-2.scope: Deactivated successfully. Sep 4 17:38:01.112594 systemd-logind[1430]: Session 2 logged out. Waiting for processes to exit. Sep 4 17:38:01.124353 systemd[1]: Started sshd@2-10.0.0.117:22-10.0.0.1:44320.service - OpenSSH per-connection server daemon (10.0.0.1:44320). Sep 4 17:38:01.126831 systemd-logind[1430]: Removed session 2. Sep 4 17:38:01.157307 sshd[1510]: Accepted publickey for core from 10.0.0.1 port 44320 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:38:01.158697 sshd[1510]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:38:01.163135 systemd-logind[1430]: New session 3 of user core. Sep 4 17:38:01.176235 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 4 17:38:01.231833 sshd[1510]: pam_unix(sshd:session): session closed for user core Sep 4 17:38:01.235114 systemd[1]: sshd@2-10.0.0.117:22-10.0.0.1:44320.service: Deactivated successfully. Sep 4 17:38:01.236832 systemd[1]: session-3.scope: Deactivated successfully. Sep 4 17:38:01.237522 systemd-logind[1430]: Session 3 logged out. Waiting for processes to exit. Sep 4 17:38:01.238357 systemd-logind[1430]: Removed session 3. Sep 4 17:38:01.794173 systemd-networkd[1379]: eth0: Gained IPv6LL Sep 4 17:38:01.794750 systemd-timesyncd[1371]: Network configuration changed, trying to establish connection. Sep 4 17:38:01.796656 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 4 17:38:01.798547 systemd[1]: Reached target network-online.target - Network is Online. Sep 4 17:38:01.814361 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 4 17:38:01.816627 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 4 17:38:01.845219 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 4 17:38:01.845411 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 4 17:38:01.847366 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 4 17:38:01.851236 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Sep 4 17:38:01.851503 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 4 17:38:01.856152 systemd[1]: Startup finished in 607ms (kernel) + 2.115s (initrd) + 3.066s (userspace) = 5.789s. Sep 4 17:38:03.297077 systemd-timesyncd[1371]: Network configuration changed, trying to establish connection. Sep 4 17:38:04.419793 systemd-timesyncd[1371]: Network configuration changed, trying to establish connection. Sep 4 17:38:11.243170 systemd[1]: Started sshd@3-10.0.0.117:22-10.0.0.1:52712.service - OpenSSH per-connection server daemon (10.0.0.1:52712). Sep 4 17:38:11.280664 sshd[1536]: Accepted publickey for core from 10.0.0.1 port 52712 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:38:11.282145 sshd[1536]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:38:11.288433 systemd-logind[1430]: New session 4 of user core. Sep 4 17:38:11.296208 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 4 17:38:11.349712 sshd[1536]: pam_unix(sshd:session): session closed for user core Sep 4 17:38:11.364724 systemd[1]: sshd@3-10.0.0.117:22-10.0.0.1:52712.service: Deactivated successfully. Sep 4 17:38:11.366271 systemd[1]: session-4.scope: Deactivated successfully. Sep 4 17:38:11.367574 systemd-logind[1430]: Session 4 logged out. Waiting for processes to exit. Sep 4 17:38:11.378435 systemd[1]: Started sshd@4-10.0.0.117:22-10.0.0.1:52720.service - OpenSSH per-connection server daemon (10.0.0.1:52720). Sep 4 17:38:11.381199 systemd-logind[1430]: Removed session 4. Sep 4 17:38:11.417251 sshd[1543]: Accepted publickey for core from 10.0.0.1 port 52720 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:38:11.418819 sshd[1543]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:38:11.425822 systemd-logind[1430]: New session 5 of user core. Sep 4 17:38:11.434261 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 4 17:38:11.485540 sshd[1543]: pam_unix(sshd:session): session closed for user core Sep 4 17:38:11.497732 systemd[1]: sshd@4-10.0.0.117:22-10.0.0.1:52720.service: Deactivated successfully. Sep 4 17:38:11.499131 systemd[1]: session-5.scope: Deactivated successfully. Sep 4 17:38:11.501029 systemd-logind[1430]: Session 5 logged out. Waiting for processes to exit. Sep 4 17:38:11.502467 systemd-logind[1430]: Removed session 5. Sep 4 17:38:11.522109 systemd[1]: Started sshd@5-10.0.0.117:22-10.0.0.1:52736.service - OpenSSH per-connection server daemon (10.0.0.1:52736). Sep 4 17:38:11.554322 sshd[1550]: Accepted publickey for core from 10.0.0.1 port 52736 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:38:11.555662 sshd[1550]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:38:11.560016 systemd-logind[1430]: New session 6 of user core. Sep 4 17:38:11.569225 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 4 17:38:11.622250 sshd[1550]: pam_unix(sshd:session): session closed for user core Sep 4 17:38:11.638670 systemd[1]: sshd@5-10.0.0.117:22-10.0.0.1:52736.service: Deactivated successfully. Sep 4 17:38:11.640181 systemd[1]: session-6.scope: Deactivated successfully. Sep 4 17:38:11.642055 systemd-logind[1430]: Session 6 logged out. Waiting for processes to exit. Sep 4 17:38:11.642780 systemd[1]: Started sshd@6-10.0.0.117:22-10.0.0.1:52742.service - OpenSSH per-connection server daemon (10.0.0.1:52742). Sep 4 17:38:11.646532 systemd-logind[1430]: Removed session 6. Sep 4 17:38:11.679883 sshd[1557]: Accepted publickey for core from 10.0.0.1 port 52742 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:38:11.681204 sshd[1557]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:38:11.687150 systemd-logind[1430]: New session 7 of user core. Sep 4 17:38:11.698280 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 4 17:38:11.753986 sshd[1557]: pam_unix(sshd:session): session closed for user core Sep 4 17:38:11.768924 systemd[1]: sshd@6-10.0.0.117:22-10.0.0.1:52742.service: Deactivated successfully. Sep 4 17:38:11.770904 systemd[1]: session-7.scope: Deactivated successfully. Sep 4 17:38:11.773396 systemd-logind[1430]: Session 7 logged out. Waiting for processes to exit. Sep 4 17:38:11.783831 systemd[1]: Started sshd@7-10.0.0.117:22-10.0.0.1:52748.service - OpenSSH per-connection server daemon (10.0.0.1:52748). Sep 4 17:38:11.785859 systemd-logind[1430]: Removed session 7. Sep 4 17:38:11.816370 sshd[1564]: Accepted publickey for core from 10.0.0.1 port 52748 ssh2: RSA SHA256:bZG4GDjjdFyRf+7zZQ8+tZsxmoYB2474ukIYHB/jTWk Sep 4 17:38:11.817926 sshd[1564]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 17:38:11.823391 systemd-logind[1430]: New session 8 of user core. Sep 4 17:38:11.833280 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 4 17:38:11.888228 sshd[1564]: pam_unix(sshd:session): session closed for user core Sep 4 17:38:11.890744 systemd[1]: sshd@7-10.0.0.117:22-10.0.0.1:52748.service: Deactivated successfully. Sep 4 17:38:11.892273 systemd[1]: session-8.scope: Deactivated successfully. Sep 4 17:38:11.894254 systemd-logind[1430]: Session 8 logged out. Waiting for processes to exit. Sep 4 17:38:11.895354 systemd-logind[1430]: Removed session 8.