Dec 12 22:57:32.673461 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Dec 12 22:57:32.673478 kernel: Linux version 5.10.107-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo 9.3.0-r1 p3) 9.3.0, GNU ld (Gentoo 2.36.1 p5) 2.36.1) #1 SMP PREEMPT Tue Mar 22 19:39:09 -00 2022 Dec 12 22:57:32.673590 kernel: efi: EFI v2.70 by EDK II Dec 12 22:57:32.673596 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82d018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Dec 12 22:57:32.673601 kernel: efi: seeding entropy pool Dec 12 22:57:32.673606 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Dec 12 22:57:32.673612 kernel: ACPI: Early table checksum verification disabled Dec 12 22:57:32.673617 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Dec 12 22:57:32.673622 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Dec 12 22:57:32.673627 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:57:32.673633 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:57:32.673638 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:57:32.673643 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:57:32.673649 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:57:32.673655 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:57:32.673660 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:57:32.673667 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:57:32.673672 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:57:32.673677 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Dec 12 22:57:32.673683 kernel: ACPI: NUMA: Failed to initialise from firmware Dec 12 22:57:32.673688 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 22:57:32.673693 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Dec 12 22:57:32.673698 kernel: Zone ranges: Dec 12 22:57:32.673703 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 22:57:32.673708 kernel: DMA32 empty Dec 12 22:57:32.673713 kernel: Normal empty Dec 12 22:57:32.673718 kernel: Movable zone start for each node Dec 12 22:57:32.673724 kernel: Early memory node ranges Dec 12 22:57:32.673729 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Dec 12 22:57:32.673735 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Dec 12 22:57:32.673740 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Dec 12 22:57:32.673745 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Dec 12 22:57:32.673750 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Dec 12 22:57:32.673755 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Dec 12 22:57:32.673760 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Dec 12 22:57:32.673765 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Dec 12 22:57:32.673771 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Dec 12 22:57:32.673776 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Dec 12 22:57:32.673781 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Dec 12 22:57:32.673786 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 22:57:32.673826 kernel: On node 0 totalpages: 643072 Dec 12 22:57:32.673834 kernel: DMA zone: 10048 pages used for memmap Dec 12 22:57:32.673840 kernel: DMA zone: 0 pages reserved Dec 12 22:57:32.673845 kernel: DMA zone: 643072 pages, LIFO batch:63 Dec 12 22:57:32.673851 kernel: psci: probing for conduit method from ACPI. Dec 12 22:57:32.673856 kernel: psci: PSCIv1.1 detected in firmware. Dec 12 22:57:32.673861 kernel: psci: Using standard PSCI v0.2 function IDs Dec 12 22:57:32.673867 kernel: psci: Trusted OS migration not required Dec 12 22:57:32.673875 kernel: psci: SMC Calling Convention v1.1 Dec 12 22:57:32.673880 kernel: ACPI: SRAT not present Dec 12 22:57:32.673886 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Dec 12 22:57:32.673891 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Dec 12 22:57:32.673897 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 12 22:57:32.673902 kernel: Detected PIPT I-cache on CPU0 Dec 12 22:57:32.673908 kernel: CPU features: detected: GIC system register CPU interface Dec 12 22:57:32.673914 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 12 22:57:32.673919 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 12 22:57:32.673925 kernel: CPU features: detected: Hardware dirty bit management Dec 12 22:57:32.673930 kernel: CPU features: detected: Spectre-v4 Dec 12 22:57:32.673937 kernel: CPU features: detected: ARM erratum 1418040 Dec 12 22:57:32.673943 kernel: CPU features: detected: Spectre-BHB Dec 12 22:57:32.673948 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Dec 12 22:57:32.673954 kernel: Policy zone: DMA Dec 12 22:57:32.673961 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=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Dec 12 22:57:32.673967 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 12 22:57:32.673973 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 12 22:57:32.673978 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 12 22:57:32.673984 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Dec 12 22:57:32.673990 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Dec 12 22:57:32.673996 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 12 22:57:32.674002 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 12 22:57:32.674008 kernel: rcu: RCU event tracing is enabled. Dec 12 22:57:32.674014 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Dec 12 22:57:32.674020 kernel: Trampoline variant of Tasks RCU enabled. Dec 12 22:57:32.674025 kernel: Tracing variant of Tasks RCU enabled. Dec 12 22:57:32.674031 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 12 22:57:32.674037 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 12 22:57:32.674050 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 12 22:57:32.674055 kernel: GICv3: 256 SPIs implemented Dec 12 22:57:32.674061 kernel: GICv3: 0 Extended SPIs implemented Dec 12 22:57:32.674066 kernel: GICv3: Distributor has no Range Selector support Dec 12 22:57:32.674072 kernel: GICv3: 16 PPIs implemented Dec 12 22:57:32.674080 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Dec 12 22:57:32.674086 kernel: ACPI: SRAT not present Dec 12 22:57:32.674091 kernel: ITS [mem 0x08080000-0x0809ffff] Dec 12 22:57:32.674097 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Dec 12 22:57:32.674102 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Dec 12 22:57:32.674108 kernel: GICv3: using LPI property table @0x00000000400d0000 Dec 12 22:57:32.674114 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Dec 12 22:57:32.674119 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 22:57:32.674125 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Dec 12 22:57:32.674131 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Dec 12 22:57:32.674138 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Dec 12 22:57:32.674143 kernel: arm-pv: using stolen time PV Dec 12 22:57:32.674150 kernel: Console: colour dummy device 80x25 Dec 12 22:57:32.674156 kernel: ACPI: Core revision 20200925 Dec 12 22:57:32.674162 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Dec 12 22:57:32.674167 kernel: pid_max: default: 32768 minimum: 301 Dec 12 22:57:32.674173 kernel: LSM: Security Framework initializing Dec 12 22:57:32.674179 kernel: SELinux: Initializing. Dec 12 22:57:32.674185 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 12 22:57:32.674190 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 12 22:57:32.674196 kernel: rcu: Hierarchical SRCU implementation. Dec 12 22:57:32.674203 kernel: Platform MSI: ITS@0x8080000 domain created Dec 12 22:57:32.674208 kernel: PCI/MSI: ITS@0x8080000 domain created Dec 12 22:57:32.674214 kernel: Remapping and enabling EFI services. Dec 12 22:57:32.674219 kernel: smp: Bringing up secondary CPUs ... Dec 12 22:57:32.674225 kernel: Detected PIPT I-cache on CPU1 Dec 12 22:57:32.674231 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Dec 12 22:57:32.674237 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Dec 12 22:57:32.674242 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 22:57:32.674248 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Dec 12 22:57:32.674254 kernel: Detected PIPT I-cache on CPU2 Dec 12 22:57:32.674261 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Dec 12 22:57:32.674267 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Dec 12 22:57:32.674272 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 22:57:32.674278 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Dec 12 22:57:32.674284 kernel: Detected PIPT I-cache on CPU3 Dec 12 22:57:32.674293 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Dec 12 22:57:32.674299 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Dec 12 22:57:32.674307 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 22:57:32.674312 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Dec 12 22:57:32.674319 kernel: smp: Brought up 1 node, 4 CPUs Dec 12 22:57:32.674325 kernel: SMP: Total of 4 processors activated. Dec 12 22:57:32.674331 kernel: CPU features: detected: Privileged Access Never Dec 12 22:57:32.674336 kernel: CPU features: detected: LSE atomic instructions Dec 12 22:57:32.674342 kernel: CPU features: detected: User Access Override Dec 12 22:57:32.674348 kernel: CPU features: detected: 32-bit EL0 Support Dec 12 22:57:32.674355 kernel: CPU features: detected: Common not Private translations Dec 12 22:57:32.674360 kernel: CPU features: detected: RAS Extension Support Dec 12 22:57:32.674368 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 12 22:57:32.674374 kernel: CPU features: detected: CRC32 instructions Dec 12 22:57:32.674380 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 12 22:57:32.674386 kernel: CPU: All CPU(s) started at EL1 Dec 12 22:57:32.674392 kernel: alternatives: patching kernel code Dec 12 22:57:32.674399 kernel: devtmpfs: initialized Dec 12 22:57:32.674404 kernel: KASLR enabled Dec 12 22:57:32.674411 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 12 22:57:32.674420 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 12 22:57:32.674426 kernel: pinctrl core: initialized pinctrl subsystem Dec 12 22:57:32.674432 kernel: SMBIOS 3.0.0 present. Dec 12 22:57:32.674438 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Dec 12 22:57:32.674444 kernel: NET: Registered protocol family 16 Dec 12 22:57:32.674450 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 12 22:57:32.674456 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 12 22:57:32.674464 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 12 22:57:32.674470 kernel: audit: initializing netlink subsys (disabled) Dec 12 22:57:32.674477 kernel: audit: type=2000 audit(0.035:1): state=initialized audit_enabled=0 res=1 Dec 12 22:57:32.674494 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 12 22:57:32.674501 kernel: cpuidle: using governor menu Dec 12 22:57:32.674507 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 12 22:57:32.674513 kernel: ASID allocator initialised with 32768 entries Dec 12 22:57:32.674519 kernel: ACPI: bus type PCI registered Dec 12 22:57:32.674524 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 12 22:57:32.674532 kernel: Serial: AMBA PL011 UART driver Dec 12 22:57:32.674538 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Dec 12 22:57:32.674544 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Dec 12 22:57:32.674550 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Dec 12 22:57:32.674556 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Dec 12 22:57:32.674562 kernel: cryptd: max_cpu_qlen set to 1000 Dec 12 22:57:32.674568 kernel: ACPI: Added _OSI(Module Device) Dec 12 22:57:32.674574 kernel: ACPI: Added _OSI(Processor Device) Dec 12 22:57:32.674580 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Dec 12 22:57:32.674587 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 12 22:57:32.674593 kernel: ACPI: Added _OSI(Linux-Dell-Video) Dec 12 22:57:32.674599 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Dec 12 22:57:32.674605 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Dec 12 22:57:32.674611 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 12 22:57:32.674616 kernel: ACPI: Interpreter enabled Dec 12 22:57:32.674622 kernel: ACPI: Using GIC for interrupt routing Dec 12 22:57:32.674628 kernel: ACPI: MCFG table detected, 1 entries Dec 12 22:57:32.674634 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Dec 12 22:57:32.674640 kernel: printk: console [ttyAMA0] enabled Dec 12 22:57:32.674647 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Dec 12 22:57:32.674757 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 12 22:57:32.674814 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 12 22:57:32.674866 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 12 22:57:32.674918 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Dec 12 22:57:32.674969 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Dec 12 22:57:32.674977 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Dec 12 22:57:32.674985 kernel: PCI host bridge to bus 0000:00 Dec 12 22:57:32.675053 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Dec 12 22:57:32.675107 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 12 22:57:32.675157 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Dec 12 22:57:32.675206 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 12 22:57:32.675274 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Dec 12 22:57:32.675341 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Dec 12 22:57:32.675405 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Dec 12 22:57:32.675464 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Dec 12 22:57:32.675535 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Dec 12 22:57:32.675593 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Dec 12 22:57:32.675649 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Dec 12 22:57:32.675707 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Dec 12 22:57:32.675759 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Dec 12 22:57:32.675813 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 12 22:57:32.675864 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Dec 12 22:57:32.675872 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Dec 12 22:57:32.675878 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Dec 12 22:57:32.675885 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Dec 12 22:57:32.675891 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Dec 12 22:57:32.675897 kernel: vgaarb: loaded Dec 12 22:57:32.675903 kernel: Registered efivars operations Dec 12 22:57:32.675909 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 12 22:57:32.675917 kernel: VFS: Disk quotas dquot_6.6.0 Dec 12 22:57:32.675923 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 12 22:57:32.675930 kernel: pnp: PnP ACPI init Dec 12 22:57:32.675996 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Dec 12 22:57:32.676055 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Dec 12 22:57:32.676064 kernel: pnp: PnP ACPI: found 1 devices Dec 12 22:57:32.676070 kernel: NET: Registered protocol family 2 Dec 12 22:57:32.676076 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 12 22:57:32.676085 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 12 22:57:32.676091 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 12 22:57:32.676097 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Dec 12 22:57:32.676103 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 12 22:57:32.676126 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 12 22:57:32.676133 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 12 22:57:32.676139 kernel: NET: Registered protocol family 1 Dec 12 22:57:32.676145 kernel: PCI: CLS 0 bytes, default 64 Dec 12 22:57:32.676152 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Dec 12 22:57:32.676159 kernel: kvm [1]: HYP mode not available Dec 12 22:57:32.676166 kernel: Initialise system trusted keyrings Dec 12 22:57:32.676172 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 12 22:57:32.676178 kernel: Key type asymmetric registered Dec 12 22:57:32.676184 kernel: Asymmetric key parser 'x509' registered Dec 12 22:57:32.676190 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Dec 12 22:57:32.676196 kernel: io scheduler mq-deadline registered Dec 12 22:57:32.676202 kernel: io scheduler kyber registered Dec 12 22:57:32.676209 kernel: io scheduler bfq registered Dec 12 22:57:32.676216 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 12 22:57:32.676222 kernel: ACPI: Power Button [PWRB] Dec 12 22:57:32.676228 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Dec 12 22:57:32.676286 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Dec 12 22:57:32.676295 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 12 22:57:32.676301 kernel: msm_serial: driver initialized Dec 12 22:57:32.676307 kernel: random: fast init done Dec 12 22:57:32.676314 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Dec 12 22:57:32.676320 kernel: random: crng init done Dec 12 22:57:32.676326 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Dec 12 22:57:32.676334 kernel: thunder_xcv, ver 1.0 Dec 12 22:57:32.676340 kernel: thunder_bgx, ver 1.0 Dec 12 22:57:32.676347 kernel: nicpf, ver 1.0 Dec 12 22:57:32.676353 kernel: nicvf, ver 1.0 Dec 12 22:57:32.676420 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 12 22:57:32.676472 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-12-12T22:57:32 UTC (1765580252) Dec 12 22:57:32.676494 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 12 22:57:32.676501 kernel: NET: Registered protocol family 10 Dec 12 22:57:32.676510 kernel: Segment Routing with IPv6 Dec 12 22:57:32.676516 kernel: NET: Registered protocol family 17 Dec 12 22:57:32.676522 kernel: Key type dns_resolver registered Dec 12 22:57:32.676527 kernel: registered taskstats version 1 Dec 12 22:57:32.676533 kernel: Loading compiled-in X.509 certificates Dec 12 22:57:32.676540 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Dec 12 22:57:32.676546 kernel: Key type ._fscrypt registered Dec 12 22:57:32.676552 kernel: Key type .fscrypt registered Dec 12 22:57:32.676558 kernel: Key type fscrypt-provisioning registered Dec 12 22:57:32.676565 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 12 22:57:32.676571 kernel: ima: Allocated hash algorithm: sha1 Dec 12 22:57:32.676577 kernel: ima: No architecture policies found Dec 12 22:57:32.676583 kernel: Freeing unused kernel memory: 34240K Dec 12 22:57:32.676589 kernel: Run /init as init process Dec 12 22:57:32.676595 kernel: with arguments: Dec 12 22:57:32.676601 kernel: /init Dec 12 22:57:32.676607 kernel: with environment: Dec 12 22:57:32.676613 kernel: HOME=/ Dec 12 22:57:32.676619 kernel: TERM=linux Dec 12 22:57:32.676626 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Dec 12 22:57:32.676633 systemd[1]: systemd 249 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 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Dec 12 22:57:32.676642 systemd[1]: Detected virtualization kvm. Dec 12 22:57:32.676649 systemd[1]: Detected architecture arm64. Dec 12 22:57:32.676655 systemd[1]: Running in initial RAM disk. Dec 12 22:57:32.676661 systemd[1]: No hostname configured, using default hostname. Dec 12 22:57:32.676667 systemd[1]: Hostname set to . Dec 12 22:57:32.676675 systemd[1]: Initializing machine ID from VM UUID. Dec 12 22:57:32.676682 systemd[1]: Queued start job for default target Initrd Default Target. Dec 12 22:57:32.676689 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Dec 12 22:57:32.676695 systemd[1]: Reached target Local Encrypted Volumes. Dec 12 22:57:32.676702 systemd[1]: Reached target Path Units. Dec 12 22:57:32.676708 systemd[1]: Reached target Slice Units. Dec 12 22:57:32.676714 systemd[1]: Reached target Swaps. Dec 12 22:57:32.676721 systemd[1]: Reached target Timer Units. Dec 12 22:57:32.676729 systemd[1]: Listening on Open-iSCSI iscsid Socket. Dec 12 22:57:32.676735 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Dec 12 22:57:32.676742 systemd[1]: Listening on Journal Audit Socket. Dec 12 22:57:32.676748 systemd[1]: Listening on Journal Socket (/dev/log). Dec 12 22:57:32.676755 systemd[1]: Listening on Journal Socket. Dec 12 22:57:32.676761 systemd[1]: Listening on Network Service Netlink Socket. Dec 12 22:57:32.676768 systemd[1]: Listening on udev Control Socket. Dec 12 22:57:32.676774 systemd[1]: Listening on udev Kernel Socket. Dec 12 22:57:32.676781 systemd[1]: Reached target Socket Units. Dec 12 22:57:32.676788 systemd[1]: Starting Create List of Static Device Nodes... Dec 12 22:57:32.676795 systemd[1]: Finished Network Cleanup. Dec 12 22:57:32.676801 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Dec 12 22:57:32.676808 systemd[1]: Starting Journal Service... Dec 12 22:57:32.676814 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Dec 12 22:57:32.676821 systemd[1]: Starting Apply Kernel Variables... Dec 12 22:57:32.676828 systemd[1]: Starting Setup Virtual Console... Dec 12 22:57:32.676834 systemd[1]: Finished Create List of Static Device Nodes. Dec 12 22:57:32.676840 systemd[1]: Finished Apply Kernel Variables. Dec 12 22:57:32.676848 systemd[1]: Finished Setup Virtual Console. Dec 12 22:57:32.676855 systemd[1]: Starting dracut ask for additional cmdline parameters... Dec 12 22:57:32.676861 systemd[1]: Starting Create Static Device Nodes in /dev... Dec 12 22:57:32.676870 systemd-journald[279]: Journal started Dec 12 22:57:32.676910 systemd-journald[279]: Runtime Journal (/run/log/journal/3e1e88a1781049e89741dc5a5e75921b) is 6.0M, max 48.5M, 42.4M free. Dec 12 22:57:32.678500 systemd[1]: Started Journal Service. Dec 12 22:57:32.679179 systemd[1]: Finished Create Static Device Nodes in /dev. Dec 12 22:57:32.689446 systemd[1]: Finished dracut ask for additional cmdline parameters. Dec 12 22:57:32.690989 systemd[1]: Starting dracut cmdline hook... Dec 12 22:57:32.699893 dracut-cmdline[297]: dracut-dracut-053 Dec 12 22:57:32.702348 dracut-cmdline[297]: 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=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Dec 12 22:57:32.761512 kernel: SCSI subsystem initialized Dec 12 22:57:32.765495 kernel: Loading iSCSI transport class v2.0-870. Dec 12 22:57:32.770497 kernel: iscsi: registered transport (tcp) Dec 12 22:57:32.782537 kernel: iscsi: registered transport (qla4xxx) Dec 12 22:57:32.782600 kernel: QLogic iSCSI HBA Driver Dec 12 22:57:32.793262 systemd[1]: Finished dracut cmdline hook. Dec 12 22:57:32.794755 systemd[1]: Starting dracut pre-udev hook... Dec 12 22:57:32.808091 kernel: device-mapper: uevent: version 1.0.3 Dec 12 22:57:32.808134 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Dec 12 22:57:32.843535 kernel: raid6: neonx8 gen() 13360 MB/s Dec 12 22:57:32.860521 kernel: raid6: neonx8 xor() 10749 MB/s Dec 12 22:57:32.877511 kernel: raid6: neonx4 gen() 13606 MB/s Dec 12 22:57:32.895077 kernel: raid6: neonx4 xor() 11560 MB/s Dec 12 22:57:32.911518 kernel: raid6: neonx2 gen() 13031 MB/s Dec 12 22:57:32.928509 kernel: raid6: neonx2 xor() 9867 MB/s Dec 12 22:57:32.945516 kernel: raid6: neonx1 gen() 10914 MB/s Dec 12 22:57:32.962527 kernel: raid6: neonx1 xor() 8828 MB/s Dec 12 22:57:32.979521 kernel: raid6: int64x8 gen() 6821 MB/s Dec 12 22:57:32.996530 kernel: raid6: int64x8 xor() 3790 MB/s Dec 12 22:57:33.013527 kernel: raid6: int64x4 gen() 6896 MB/s Dec 12 22:57:33.030513 kernel: raid6: int64x4 xor() 3821 MB/s Dec 12 22:57:33.047524 kernel: raid6: int64x2 gen() 6159 MB/s Dec 12 22:57:33.064522 kernel: raid6: int64x2 xor() 3310 MB/s Dec 12 22:57:33.081508 kernel: raid6: int64x1 gen() 4996 MB/s Dec 12 22:57:33.098942 kernel: raid6: int64x1 xor() 2589 MB/s Dec 12 22:57:33.098976 kernel: raid6: using algorithm neonx4 gen() 13606 MB/s Dec 12 22:57:33.098985 kernel: raid6: .... xor() 11560 MB/s, rmw enabled Dec 12 22:57:33.098993 kernel: raid6: using neon recovery algorithm Dec 12 22:57:33.109671 kernel: xor: measuring software checksum speed Dec 12 22:57:33.109703 kernel: 8regs : 17145 MB/sec Dec 12 22:57:33.110569 kernel: 32regs : 20765 MB/sec Dec 12 22:57:33.111859 kernel: arm64_neon : 28875 MB/sec Dec 12 22:57:33.111876 kernel: xor: using function: arm64_neon (28875 MB/sec) Dec 12 22:57:33.157516 kernel: Btrfs loaded, crc32c=crc32c-generic Dec 12 22:57:33.167761 systemd[1]: Finished dracut pre-udev hook. Dec 12 22:57:33.168000 audit: BPF prog-id=6 op=LOAD Dec 12 22:57:33.169000 audit: BPF prog-id=7 op=LOAD Dec 12 22:57:33.169000 audit: BPF prog-id=8 op=LOAD Dec 12 22:57:33.170667 systemd[1]: Starting Rule-based Manager for Device Events and Files... Dec 12 22:57:33.172598 kernel: audit: type=1334 audit(1765580253.168:2): prog-id=6 op=LOAD Dec 12 22:57:33.172621 kernel: audit: type=1334 audit(1765580253.169:3): prog-id=7 op=LOAD Dec 12 22:57:33.172630 kernel: audit: type=1334 audit(1765580253.169:4): prog-id=8 op=LOAD Dec 12 22:57:33.182360 systemd-udevd[416]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Dec 12 22:57:33.185347 systemd[1]: Started Rule-based Manager for Device Events and Files. Dec 12 22:57:33.186889 systemd[1]: Starting dracut pre-trigger hook... Dec 12 22:57:33.187000 audit: BPF prog-id=9 op=LOAD Dec 12 22:57:33.188933 systemd[1]: Starting Network Configuration... Dec 12 22:57:33.190152 kernel: audit: type=1334 audit(1765580253.187:5): prog-id=9 op=LOAD Dec 12 22:57:33.202618 dracut-pre-trigger[423]: rd.md=0: removing MD RAID activation Dec 12 22:57:33.209806 systemd-networkd[429]: lo: Link UP Dec 12 22:57:33.209812 systemd-networkd[429]: lo: Gained carrier Dec 12 22:57:33.211000 audit: BPF prog-id=10 op=LOAD Dec 12 22:57:33.210088 systemd-networkd[429]: Enumeration completed Dec 12 22:57:33.213582 kernel: audit: type=1334 audit(1765580253.211:6): prog-id=10 op=LOAD Dec 12 22:57:33.210174 systemd[1]: Started Network Configuration. Dec 12 22:57:33.212110 systemd[1]: Starting Network Name Resolution... Dec 12 22:57:33.228191 systemd[1]: Finished dracut pre-trigger hook. Dec 12 22:57:33.229554 systemd[1]: Starting Coldplug All udev Devices... Dec 12 22:57:33.239205 systemd-udevd[416]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Dec 12 22:57:33.242714 systemd-resolved[447]: Positive Trust Anchors: Dec 12 22:57:33.242729 systemd-resolved[447]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 12 22:57:33.242759 systemd-resolved[447]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Dec 12 22:57:33.243053 systemd-resolved[447]: Defaulting to hostname 'linux'. Dec 12 22:57:33.252755 systemd[1]: Started Network Name Resolution. Dec 12 22:57:33.259830 systemd[1]: Reached target Network. Dec 12 22:57:33.262780 systemd[1]: Reached target Host and Network Name Lookups. Dec 12 22:57:33.264738 systemd[1]: Starting iSCSI UserSpace I/O driver... Dec 12 22:57:33.270985 systemd[1]: Started iSCSI UserSpace I/O driver. Dec 12 22:57:33.272399 systemd[1]: Starting Open-iSCSI... Dec 12 22:57:33.275048 iscsid[485]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Dec 12 22:57:33.275048 iscsid[485]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Dec 12 22:57:33.275048 iscsid[485]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Dec 12 22:57:33.275048 iscsid[485]: If using hardware iscsi like qla4xxx this message can be ignored. Dec 12 22:57:33.275048 iscsid[485]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Dec 12 22:57:33.275048 iscsid[485]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Dec 12 22:57:33.278796 systemd[1]: Started Open-iSCSI. Dec 12 22:57:33.289919 systemd[1]: Finished Coldplug All udev Devices. Dec 12 22:57:33.291350 systemd[1]: Starting dracut initqueue hook... Dec 12 22:57:33.312959 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Dec 12 22:57:33.313124 kernel: vda: detected capacity change from 0 to 4756340736 Dec 12 22:57:33.319815 systemd-udevd[476]: Using default interface naming scheme 'v249'. Dec 12 22:57:33.325047 systemd-networkd[429]: eth0: Link UP Dec 12 22:57:33.327579 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 12 22:57:33.351684 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Dec 12 22:57:33.354378 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (464) Dec 12 22:57:33.356324 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Dec 12 22:57:33.357179 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Dec 12 22:57:33.364363 systemd[1]: Found device /dev/disk/by-label/OEM. Dec 12 22:57:33.367331 systemd[1]: Found device /dev/disk/by-label/ROOT. Dec 12 22:57:33.369166 systemd[1]: Finished dracut initqueue hook. Dec 12 22:57:33.370080 systemd[1]: Reached target Initrd Root Device. Dec 12 22:57:33.371198 systemd[1]: Reached target Preparation for Remote File Systems. Dec 12 22:57:33.372514 systemd[1]: Reached target Remote Encrypted Volumes. Dec 12 22:57:33.373973 systemd[1]: Reached target Remote File Systems. Dec 12 22:57:33.376032 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Dec 12 22:57:33.377570 systemd[1]: Starting dracut pre-mount hook... Dec 12 22:57:33.385532 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 12 22:57:33.386540 systemd[1]: Finished dracut pre-mount hook. Dec 12 22:57:33.389509 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 12 22:57:34.314519 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Dec 12 22:57:34.314502 systemd-networkd[429]: eth0: Gained carrier Dec 12 22:57:34.323542 systemd-networkd[429]: eth0: DHCPv4 address 10.0.0.8/16 via 10.0.0.1 Dec 12 22:57:34.429091 disk-uuid[506]: The operation has completed successfully. Dec 12 22:57:34.430076 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 12 22:57:34.447559 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 12 22:57:34.447681 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Dec 12 22:57:34.451861 systemd[1]: Starting Ignition (setup)... Dec 12 22:57:34.460025 kernel: BTRFS info (device vda6): disk space caching is enabled Dec 12 22:57:34.460069 kernel: BTRFS info (device vda6): has skinny extents Dec 12 22:57:34.466039 systemd[1]: mnt-oem.mount: Deactivated successfully. Dec 12 22:57:34.471093 systemd[1]: ignition-setup.service: Deactivated successfully. Dec 12 22:57:34.471201 systemd[1]: Finished Ignition (setup). Dec 12 22:57:34.473151 systemd[1]: Starting Ignition (disks)... Dec 12 22:57:34.482396 ignition[543]: Ignition v0.36.1-15-gde4e6cc9 Dec 12 22:57:34.482413 ignition[543]: Stage: disks Dec 12 22:57:34.482422 ignition[543]: reading system config file "/usr/lib/ignition/base.ign" Dec 12 22:57:34.482432 ignition[543]: no config at "/usr/lib/ignition/base.ign" Dec 12 22:57:34.482474 ignition[543]: parsed url from cmdline: "" Dec 12 22:57:34.482477 ignition[543]: no config URL provided Dec 12 22:57:34.482502 ignition[543]: reading system config file "/usr/lib/ignition/user.ign" Dec 12 22:57:34.482509 ignition[543]: no config at "/usr/lib/ignition/user.ign" Dec 12 22:57:34.482528 ignition[543]: op(1): [started] loading QEMU firmware config module Dec 12 22:57:34.482533 ignition[543]: op(1): executing: "modprobe" "qemu_fw_cfg" Dec 12 22:57:34.483553 ignition[543]: op(1): [finished] loading QEMU firmware config module Dec 12 22:57:34.495297 ignition[543]: parsing config with SHA512: 309c5dbbff71eb82360e2a53b5683d428b348b192ed2165736b698fd95419e89c4b601fa2c2077c2fb0a8f2abc5c128b44e2203c90808bb417e2636b05a37b58 Dec 12 22:57:34.497505 ignition[543]: disks: disks passed Dec 12 22:57:34.497514 ignition[543]: Ignition finished successfully Dec 12 22:57:34.498264 systemd[1]: ignition-disks.service: Deactivated successfully. Dec 12 22:57:34.498379 systemd[1]: Finished Ignition (disks). Dec 12 22:57:34.499307 systemd[1]: Reached target Preparation for Local File Systems. Dec 12 22:57:34.501227 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Dec 12 22:57:34.503088 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Dec 12 22:57:34.511189 systemd-fsck[556]: ROOT: clean, 528/553792 files, 37752/553472 blocks Dec 12 22:57:34.514494 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Dec 12 22:57:34.516349 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Dec 12 22:57:34.518506 systemd[1]: Mounting /sysroot... Dec 12 22:57:34.532922 systemd[1]: Found device /dev/mapper/usr. Dec 12 22:57:34.534221 systemd[1]: Starting File System Check on /dev/mapper/usr... Dec 12 22:57:34.538470 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Dec 12 22:57:34.544599 systemd-fsck[572]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Dec 12 22:57:34.544599 systemd-fsck[572]: You must have r/w access to the filesystem or be root Dec 12 22:57:34.547639 systemd-fsck[568]: fsck failed with exit status 8. Dec 12 22:57:34.547650 systemd-fsck[568]: Ignoring error. Dec 12 22:57:34.548579 systemd[1]: Finished File System Check on /dev/mapper/usr. Dec 12 22:57:34.551908 systemd[1]: Mounting /sysusr/usr... Dec 12 22:57:34.558976 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Dec 12 22:57:34.559016 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Dec 12 22:57:34.559039 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Dec 12 22:57:34.559575 systemd[1]: Mounted /sysroot. Dec 12 22:57:34.560674 systemd[1]: Mounted /sysusr/usr. Dec 12 22:57:34.561418 systemd[1]: Reached target Initrd Root File System. Dec 12 22:57:34.562178 systemd[1]: Reached target Local File Systems. Dec 12 22:57:34.563154 systemd[1]: Reached target System Initialization. Dec 12 22:57:34.564175 systemd[1]: Reached target Basic System. Dec 12 22:57:34.566725 systemd[1]: Mounting /sysroot/usr... Dec 12 22:57:34.568735 systemd[1]: Mounted /sysroot/usr. Dec 12 22:57:34.569947 systemd[1]: Starting Root filesystem setup... Dec 12 22:57:34.592139 systemd[1]: initrd-setup-root.service: Deactivated successfully. Dec 12 22:57:34.592259 systemd[1]: Finished Root filesystem setup. Dec 12 22:57:34.594174 systemd[1]: Starting Ignition (files)... Dec 12 22:57:34.595279 systemd[1]: Starting /sysroot/boot... Dec 12 22:57:34.596913 ignition[587]: Ignition v0.36.1-15-gde4e6cc9 Dec 12 22:57:34.596930 ignition[587]: Stage: files Dec 12 22:57:34.596939 ignition[587]: reading system config file "/usr/lib/ignition/base.ign" Dec 12 22:57:34.596949 ignition[587]: no config at "/usr/lib/ignition/base.ign" Dec 12 22:57:34.597433 ignition[587]: files: compiled without relabeling support, skipping Dec 12 22:57:34.611568 systemd[1]: Finished /sysroot/boot. Dec 12 22:57:34.613918 ignition[587]: files: createUsers: op(1): [started] creating or modifying user "core" Dec 12 22:57:34.613930 ignition[587]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Dec 12 22:57:34.615647 ignition[587]: files: createUsers: op(1): [finished] creating or modifying user "core" Dec 12 22:57:34.615657 ignition[587]: files: createUsers: op(2): [started] adding ssh keys to user "core" Dec 12 22:57:34.618082 ignition[587]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Dec 12 22:57:34.618106 ignition[587]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Dec 12 22:57:34.619214 ignition[587]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Dec 12 22:57:34.619221 ignition[587]: files: op(4): [started] processing unit "coreos-metadata.service" Dec 12 22:57:34.621304 systemd[1]: ignition-files.service: Deactivated successfully. Dec 12 22:57:34.619307 ignition[587]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Dec 12 22:57:34.621412 systemd[1]: Finished Ignition (files). Dec 12 22:57:34.620701 ignition[587]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Dec 12 22:57:34.622363 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Dec 12 22:57:34.620706 ignition[587]: files: op(4): [finished] processing unit "coreos-metadata.service" Dec 12 22:57:34.632496 kernel: audit: type=1334 audit(1765580254.630:7): prog-id=6 op=UNLOAD Dec 12 22:57:34.632517 kernel: audit: type=1334 audit(1765580254.631:8): prog-id=3 op=UNLOAD Dec 12 22:57:34.630000 audit: BPF prog-id=6 op=UNLOAD Dec 12 22:57:34.631000 audit: BPF prog-id=3 op=UNLOAD Dec 12 22:57:34.623005 systemd[1]: Starting Ignition (record completion)... Dec 12 22:57:34.620711 ignition[587]: files: files passed Dec 12 22:57:34.624285 systemd[1]: Starting Reload Configuration from the Real Root... Dec 12 22:57:34.620714 ignition[587]: Ignition finished successfully Dec 12 22:57:34.625518 systemd[1]: ignition-quench.service: Deactivated successfully. Dec 12 22:57:34.635000 audit: BPF prog-id=9 op=UNLOAD Dec 12 22:57:34.625620 systemd[1]: Finished Ignition (record completion). Dec 12 22:57:34.638602 kernel: audit: type=1334 audit(1765580254.635:9): prog-id=9 op=UNLOAD Dec 12 22:57:34.638629 kernel: audit: type=1334 audit(1765580254.637:10): prog-id=10 op=UNLOAD Dec 12 22:57:34.637000 audit: BPF prog-id=10 op=UNLOAD Dec 12 22:57:34.628492 systemd[1]: Reloading. Dec 12 22:57:34.715000 audit: BPF prog-id=11 op=LOAD Dec 12 22:57:34.715000 audit: BPF prog-id=12 op=LOAD Dec 12 22:57:34.715000 audit: BPF prog-id=13 op=LOAD Dec 12 22:57:34.715000 audit: BPF prog-id=7 op=UNLOAD Dec 12 22:57:34.715000 audit: BPF prog-id=8 op=UNLOAD Dec 12 22:57:34.716000 audit: BPF prog-id=14 op=LOAD Dec 12 22:57:34.716000 audit: BPF prog-id=15 op=LOAD Dec 12 22:57:34.716000 audit: BPF prog-id=16 op=LOAD Dec 12 22:57:34.716000 audit: BPF prog-id=4 op=UNLOAD Dec 12 22:57:34.716000 audit: BPF prog-id=5 op=UNLOAD Dec 12 22:57:34.716000 audit: BPF prog-id=17 op=LOAD Dec 12 22:57:34.717000 audit: BPF prog-id=18 op=LOAD Dec 12 22:57:34.731146 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 12 22:57:34.731272 systemd[1]: Finished Reload Configuration from the Real Root. Dec 12 22:57:34.732811 systemd[1]: Reached target Initrd File Systems. Dec 12 22:57:34.734136 systemd[1]: Reached target Initrd Default Target. Dec 12 22:57:34.735330 systemd[1]: Condition check resulted in dracut mount hook being skipped. Dec 12 22:57:34.735986 systemd[1]: Starting dracut pre-pivot and cleanup hook... Dec 12 22:57:34.746610 systemd[1]: Finished dracut pre-pivot and cleanup hook. Dec 12 22:57:34.748088 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Dec 12 22:57:34.754086 systemd[1]: Stopped target Host and Network Name Lookups. Dec 12 22:57:34.755012 systemd[1]: Stopped target Remote Encrypted Volumes. Dec 12 22:57:34.756311 systemd[1]: Stopped target Timer Units. Dec 12 22:57:34.757420 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 12 22:57:34.757544 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Dec 12 22:57:34.758618 systemd[1]: Stopped target Initrd Default Target. Dec 12 22:57:34.759883 systemd[1]: Stopped target Basic System. Dec 12 22:57:34.761021 systemd[1]: Stopped target Initrd Root Device. Dec 12 22:57:34.762193 systemd[1]: Stopped target Path Units. Dec 12 22:57:34.763173 systemd[1]: Stopped target Remote File Systems. Dec 12 22:57:34.764297 systemd[1]: Stopped target Preparation for Remote File Systems. Dec 12 22:57:34.765458 systemd[1]: Stopped target Slice Units. Dec 12 22:57:34.766541 systemd[1]: Stopped target Socket Units. Dec 12 22:57:34.767790 systemd[1]: Stopped target System Initialization. Dec 12 22:57:34.768892 systemd[1]: Stopped target Local File Systems. Dec 12 22:57:34.770096 systemd[1]: Stopped target Preparation for Local File Systems. Dec 12 22:57:34.771372 systemd[1]: Stopped target Swaps. Dec 12 22:57:34.772417 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 12 22:57:34.772546 systemd[1]: Stopped dracut pre-mount hook. Dec 12 22:57:34.773750 systemd[1]: Stopped target Local Encrypted Volumes. Dec 12 22:57:34.774739 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 12 22:57:34.778534 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Dec 12 22:57:34.779430 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 12 22:57:34.779554 systemd[1]: Stopped dracut initqueue hook. Dec 12 22:57:34.782410 iscsid[485]: iscsid shutting down. Dec 12 22:57:34.780940 systemd[1]: Stopping Open-iSCSI... Dec 12 22:57:34.782630 systemd[1]: Stopping /sysroot/boot... Dec 12 22:57:34.783531 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 12 22:57:34.783647 systemd[1]: Stopped Coldplug All udev Devices. Dec 12 22:57:34.784701 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 12 22:57:34.784781 systemd[1]: Stopped dracut pre-trigger hook. Dec 12 22:57:34.786653 systemd[1]: iscsid.service: Deactivated successfully. Dec 12 22:57:34.786782 systemd[1]: Stopped Open-iSCSI. Dec 12 22:57:34.788177 systemd[1]: iscsid.socket: Deactivated successfully. Dec 12 22:57:34.788240 systemd[1]: Closed Open-iSCSI iscsid Socket. Dec 12 22:57:34.790256 systemd[1]: Stopping iSCSI UserSpace I/O driver... Dec 12 22:57:34.791724 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 12 22:57:34.791845 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Dec 12 22:57:34.793379 systemd[1]: iscsiuio.service: Deactivated successfully. Dec 12 22:57:34.793507 systemd[1]: Stopped iSCSI UserSpace I/O driver. Dec 12 22:57:34.794958 systemd[1]: Stopped target Network. Dec 12 22:57:34.796098 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 12 22:57:34.796161 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Dec 12 22:57:34.797291 systemd[1]: Stopping Network Name Resolution... Dec 12 22:57:34.798656 systemd[1]: sysroot-boot.service: Deactivated successfully. Dec 12 22:57:34.798766 systemd[1]: Stopped /sysroot/boot. Dec 12 22:57:34.800577 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 12 22:57:34.800685 systemd[1]: Stopped Network Name Resolution. Dec 12 22:57:34.802039 systemd[1]: Stopping Network Configuration... Dec 12 22:57:34.804590 systemd-networkd[429]: eth0: DHCP lease lost Dec 12 22:57:34.811000 audit: BPF prog-id=18 op=UNLOAD Dec 12 22:57:34.815556 systemd-networkd[429]: eth0: DHCPv6 lease lost Dec 12 22:57:34.816542 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 12 22:57:34.816669 systemd[1]: Stopped Network Configuration. Dec 12 22:57:34.818109 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 12 22:57:34.818141 systemd[1]: Closed Network Service Netlink Socket. Dec 12 22:57:34.819830 systemd[1]: Stopping Network Cleanup... Dec 12 22:57:34.820719 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 12 22:57:34.820782 systemd[1]: Stopped Apply Kernel Variables. Dec 12 22:57:34.827000 audit: BPF prog-id=17 op=UNLOAD Dec 12 22:57:34.822021 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Dec 12 22:57:34.830121 systemd[1]: network-cleanup.service: Deactivated successfully. Dec 12 22:57:34.830236 systemd[1]: Stopped Network Cleanup. Dec 12 22:57:34.832546 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 12 22:57:34.832670 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Dec 12 22:57:34.834253 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 12 22:57:34.834289 systemd[1]: Closed udev Control Socket. Dec 12 22:57:34.835381 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 12 22:57:34.835411 systemd[1]: Closed udev Kernel Socket. Dec 12 22:57:34.836635 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 12 22:57:34.836673 systemd[1]: Stopped dracut pre-udev hook. Dec 12 22:57:34.841000 audit: BPF prog-id=11 op=UNLOAD Dec 12 22:57:34.837682 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 12 22:57:34.837721 systemd[1]: Stopped dracut cmdline hook. Dec 12 22:57:34.838902 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 12 22:57:34.838937 systemd[1]: Stopped dracut ask for additional cmdline parameters. Dec 12 22:57:34.840738 systemd[1]: Starting Cleanup udev Database... Dec 12 22:57:34.841373 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Dec 12 22:57:34.842544 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 12 22:57:34.842596 systemd[1]: Stopped Create Static Device Nodes in /dev. Dec 12 22:57:34.843923 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 12 22:57:34.843962 systemd[1]: Stopped Create List of Static Device Nodes. Dec 12 22:57:34.845091 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 12 22:57:34.845129 systemd[1]: Stopped Setup Virtual Console. Dec 12 22:57:34.846550 systemd[1]: rngd.service: Deactivated successfully. Dec 12 22:57:34.846662 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Dec 12 22:57:34.847876 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 12 22:57:34.847978 systemd[1]: Finished Cleanup udev Database. Dec 12 22:57:34.856000 audit: BPF prog-id=14 op=UNLOAD Dec 12 22:57:34.848960 systemd[1]: Reached target Switch Root. Dec 12 22:57:34.850697 systemd[1]: Starting Switch Root... Dec 12 22:57:34.855500 systemd[1]: Switching root. Dec 12 22:57:34.871833 systemd-journald[279]: Journal stopped Dec 12 22:57:37.016868 systemd-journald[279]: Received SIGTERM from PID 1 (systemd). Dec 12 22:57:37.016920 kernel: SELinux: policy capability network_peer_controls=1 Dec 12 22:57:37.016937 kernel: SELinux: policy capability open_perms=1 Dec 12 22:57:37.016947 kernel: SELinux: policy capability extended_socket_class=1 Dec 12 22:57:37.016956 kernel: SELinux: policy capability always_check_network=0 Dec 12 22:57:37.016969 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 12 22:57:37.016978 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 12 22:57:37.016988 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 12 22:57:37.017000 systemd[1]: Successfully loaded SELinux policy in 31.406ms. Dec 12 22:57:37.017013 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.402ms. Dec 12 22:57:37.017033 systemd[1]: systemd 249 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 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Dec 12 22:57:37.017044 systemd[1]: Detected virtualization kvm. Dec 12 22:57:37.017055 systemd[1]: Detected architecture arm64. Dec 12 22:57:37.017064 systemd[1]: Detected first boot. Dec 12 22:57:37.017073 systemd[1]: Initializing machine ID from VM UUID. Dec 12 22:57:37.017083 systemd[1]: Populated /etc with preset unit settings. Dec 12 22:57:37.017097 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Dec 12 22:57:37.017107 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Dec 12 22:57:37.017118 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 12 22:57:37.017128 kernel: kauditd_printk_skb: 24 callbacks suppressed Dec 12 22:57:37.017137 kernel: audit: type=1334 audit(1765580256.910:35): prog-id=21 op=LOAD Dec 12 22:57:37.017146 kernel: audit: type=1334 audit(1765580256.910:36): prog-id=22 op=LOAD Dec 12 22:57:37.017155 kernel: audit: type=1334 audit(1765580256.910:37): prog-id=23 op=LOAD Dec 12 22:57:37.017164 systemd[1]: Stopped Switch Root. Dec 12 22:57:37.017173 kernel: audit: type=1334 audit(1765580256.910:38): prog-id=15 op=UNLOAD Dec 12 22:57:37.017184 kernel: audit: type=1334 audit(1765580256.910:39): prog-id=16 op=UNLOAD Dec 12 22:57:37.017193 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 12 22:57:37.017204 systemd[1]: Created slice Slice /system/addon-config. Dec 12 22:57:37.017213 systemd[1]: Created slice Slice /system/addon-run. Dec 12 22:57:37.017223 systemd[1]: Created slice Slice /system/getty. Dec 12 22:57:37.017232 systemd[1]: Created slice Slice /system/modprobe. Dec 12 22:57:37.017242 systemd[1]: Created slice Slice /system/serial-getty. Dec 12 22:57:37.017251 kernel: audit: type=1334 audit(1765580256.926:40): prog-id=21 op=UNLOAD Dec 12 22:57:37.017260 systemd[1]: Created slice Slice /system/system-cloudinit. Dec 12 22:57:37.017271 systemd[1]: Created slice Slice /system/systemd-fsck. Dec 12 22:57:37.017281 systemd[1]: Created slice User and Session Slice. Dec 12 22:57:37.017291 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Dec 12 22:57:37.017301 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Dec 12 22:57:37.017311 systemd[1]: Set up automount Boot partition Automount Point. Dec 12 22:57:37.017320 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Dec 12 22:57:37.017330 systemd[1]: Stopped target Switch Root. Dec 12 22:57:37.017339 systemd[1]: Stopped target Initrd File Systems. Dec 12 22:57:37.017349 systemd[1]: Stopped target Initrd Root File System. Dec 12 22:57:37.017360 systemd[1]: Reached target Remote Encrypted Volumes. Dec 12 22:57:37.017370 systemd[1]: Reached target Remote File Systems. Dec 12 22:57:37.017379 systemd[1]: Reached target Slice Units. Dec 12 22:57:37.017389 systemd[1]: Reached target Swaps. Dec 12 22:57:37.017398 systemd[1]: Reached target Verify torcx succeeded. Dec 12 22:57:37.017408 systemd[1]: Reached target Local Verity Protected Volumes. Dec 12 22:57:37.017418 systemd[1]: Listening on Process Core Dump Socket. Dec 12 22:57:37.017428 systemd[1]: Listening on initctl Compatibility Named Pipe. Dec 12 22:57:37.017437 systemd[1]: Listening on Network Service Netlink Socket. Dec 12 22:57:37.017447 systemd[1]: Listening on udev Control Socket. Dec 12 22:57:37.017458 systemd[1]: Listening on udev Kernel Socket. Dec 12 22:57:37.017467 systemd[1]: Mounting Huge Pages File System... Dec 12 22:57:37.017477 systemd[1]: Mounting POSIX Message Queue File System... Dec 12 22:57:37.017494 systemd[1]: Mounting External Media Directory... Dec 12 22:57:37.017504 systemd[1]: Mounting Kernel Debug File System... Dec 12 22:57:37.017514 systemd[1]: Mounting Kernel Trace File System... Dec 12 22:57:37.017524 systemd[1]: Mounting Temporary Directory /tmp... Dec 12 22:57:37.017533 systemd[1]: Starting Create missing system files... Dec 12 22:57:37.017543 systemd[1]: Starting Create List of Static Device Nodes... Dec 12 22:57:37.017552 systemd[1]: Starting Load Kernel Module configfs... Dec 12 22:57:37.017564 systemd[1]: Starting Load Kernel Module drm... Dec 12 22:57:37.017574 systemd[1]: Starting Load Kernel Module fuse... Dec 12 22:57:37.017583 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Dec 12 22:57:37.017593 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 12 22:57:37.017602 systemd[1]: Stopped File System Check on Root Device. Dec 12 22:57:37.017612 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 12 22:57:37.017622 systemd[1]: Stopped systemd-fsck-usr.service. Dec 12 22:57:37.017631 systemd[1]: Stopped Journal Service. Dec 12 22:57:37.017641 kernel: fuse: init (API version 7.32) Dec 12 22:57:37.017651 kernel: audit: type=1334 audit(1765580256.999:41): prog-id=24 op=LOAD Dec 12 22:57:37.017660 kernel: audit: type=1334 audit(1765580257.000:42): prog-id=25 op=LOAD Dec 12 22:57:37.017669 kernel: audit: type=1334 audit(1765580257.000:43): prog-id=26 op=LOAD Dec 12 22:57:37.017678 systemd[1]: Starting Journal Service... Dec 12 22:57:37.017688 kernel: audit: type=1334 audit(1765580257.000:44): prog-id=22 op=UNLOAD Dec 12 22:57:37.017698 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Dec 12 22:57:37.017708 systemd[1]: Starting Remount Root and Kernel File Systems... Dec 12 22:57:37.017718 systemd[1]: Starting Apply Kernel Variables... Dec 12 22:57:37.017729 systemd[1]: Starting Coldplug All udev Devices... Dec 12 22:57:37.017739 systemd[1]: verity-setup.service: Deactivated successfully. Dec 12 22:57:37.017749 systemd[1]: Stopped verity-setup.service. Dec 12 22:57:37.017759 systemd[1]: Mounted Huge Pages File System. Dec 12 22:57:37.017770 systemd-journald[801]: Journal started Dec 12 22:57:37.017803 systemd-journald[801]: Runtime Journal (/run/log/journal/3e1e88a1781049e89741dc5a5e75921b) is 6.0M, max 48.5M, 42.4M free. Dec 12 22:57:34.940000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 12 22:57:34.970000 audit[1]: AVC avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Dec 12 22:57:34.970000 audit[1]: AVC avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Dec 12 22:57:34.970000 audit: BPF prog-id=19 op=LOAD Dec 12 22:57:34.970000 audit: BPF prog-id=19 op=UNLOAD Dec 12 22:57:34.970000 audit: BPF prog-id=20 op=LOAD Dec 12 22:57:34.970000 audit: BPF prog-id=20 op=UNLOAD Dec 12 22:57:35.009000 audit[751]: AVC avc: denied { associate } for pid=751 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Dec 12 22:57:36.910000 audit: BPF prog-id=21 op=LOAD Dec 12 22:57:36.910000 audit: BPF prog-id=22 op=LOAD Dec 12 22:57:36.910000 audit: BPF prog-id=23 op=LOAD Dec 12 22:57:36.910000 audit: BPF prog-id=15 op=UNLOAD Dec 12 22:57:36.910000 audit: BPF prog-id=16 op=UNLOAD Dec 12 22:57:36.926000 audit: BPF prog-id=21 op=UNLOAD Dec 12 22:57:36.999000 audit: BPF prog-id=24 op=LOAD Dec 12 22:57:37.000000 audit: BPF prog-id=25 op=LOAD Dec 12 22:57:37.000000 audit: BPF prog-id=26 op=LOAD Dec 12 22:57:37.000000 audit: BPF prog-id=22 op=UNLOAD Dec 12 22:57:37.000000 audit: BPF prog-id=23 op=UNLOAD Dec 12 22:57:37.015000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Dec 12 22:57:36.897978 systemd[1]: Queued start job for default target Multi-User System. Dec 12 22:57:35.007729 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3033.2.4 /usr/share/oem/torcx/store /var/lib/torcx/store/3033.2.4 /var/lib/torcx/store]" Dec 12 22:57:36.911572 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 12 22:57:35.008096 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 12 22:57:35.008130 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 12 22:57:35.008332 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Dec 12 22:57:35.008345 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=debug msg="skipped missing lower profile" missing profile=oem Dec 12 22:57:35.008379 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Dec 12 22:57:35.008393 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Dec 12 22:57:35.008616 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Dec 12 22:57:35.008653 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 12 22:57:35.008668 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 12 22:57:35.009092 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Dec 12 22:57:35.009124 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Dec 12 22:57:35.009147 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3033.2.4: no such file or directory" path=/usr/share/oem/torcx/store/3033.2.4 Dec 12 22:57:35.009163 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Dec 12 22:57:35.009183 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3033.2.4: no such file or directory" path=/var/lib/torcx/store/3033.2.4 Dec 12 22:57:37.019504 systemd[1]: Started Journal Service. Dec 12 22:57:35.009197 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:35Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Dec 12 22:57:36.728106 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:36Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 12 22:57:37.019535 systemd[1]: Mounted POSIX Message Queue File System. Dec 12 22:57:36.728384 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:36Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 12 22:57:36.728502 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:36Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 12 22:57:36.728632 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:36Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 12 22:57:36.728687 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:36Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Dec 12 22:57:36.728744 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-12-12T22:57:36Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Dec 12 22:57:37.020426 systemd[1]: Mounted External Media Directory. Dec 12 22:57:37.021300 systemd[1]: Mounted Kernel Debug File System. Dec 12 22:57:37.022178 systemd[1]: Mounted Kernel Trace File System. Dec 12 22:57:37.023008 systemd[1]: Mounted Temporary Directory /tmp. Dec 12 22:57:37.024081 systemd[1]: Finished Create missing system files. Dec 12 22:57:37.025194 systemd[1]: Finished Create List of Static Device Nodes. Dec 12 22:57:37.026273 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 12 22:57:37.026455 systemd[1]: Finished Load Kernel Module configfs. Dec 12 22:57:37.027516 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 12 22:57:37.027692 systemd[1]: Finished Load Kernel Module drm. Dec 12 22:57:37.028600 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 12 22:57:37.028774 systemd[1]: Finished Load Kernel Module fuse. Dec 12 22:57:37.045909 systemd[1]: Finished Remount Root and Kernel File Systems. Dec 12 22:57:37.047123 systemd[1]: Finished Apply Kernel Variables. Dec 12 22:57:37.050004 systemd[1]: Mounting FUSE Control File System... Dec 12 22:57:37.051674 systemd[1]: Mounting Kernel Configuration File System... Dec 12 22:57:37.052414 systemd[1]: Condition check resulted in Remount Root File System being skipped. Dec 12 22:57:37.053999 systemd[1]: Starting Rebuild Hardware Database... Dec 12 22:57:37.055991 systemd[1]: Starting Flush Journal to Persistent Storage... Dec 12 22:57:37.056991 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Dec 12 22:57:37.059911 systemd-journald[801]: Time spent on flushing to /var/log/journal/3e1e88a1781049e89741dc5a5e75921b is 8.112ms for 771 entries. Dec 12 22:57:37.059911 systemd-journald[801]: System Journal (/var/log/journal/3e1e88a1781049e89741dc5a5e75921b) is 8.0M, max 203.0M, 195.0M free. Dec 12 22:57:37.058105 systemd[1]: Starting Load/Save Random Seed... Dec 12 22:57:37.059868 systemd[1]: Starting Create System Users... Dec 12 22:57:37.063455 systemd[1]: Mounted FUSE Control File System. Dec 12 22:57:37.065397 systemd[1]: Mounted Kernel Configuration File System. Dec 12 22:57:37.068993 systemd[1]: Finished Load/Save Random Seed. Dec 12 22:57:37.070052 systemd[1]: Finished Coldplug All udev Devices. Dec 12 22:57:37.070946 systemd[1]: Reached target First Boot Complete. Dec 12 22:57:37.079529 systemd[1]: Starting Wait for udev To Complete Device Initialization... Dec 12 22:57:37.081128 systemd-sysusers[813]: Creating group sgx with gid 999. Dec 12 22:57:37.082930 systemd-sysusers[813]: Creating group systemd-oom with gid 998. Dec 12 22:57:37.083539 systemd-sysusers[813]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Dec 12 22:57:37.084247 systemd[1]: Finished Flush Journal to Persistent Storage. Dec 12 22:57:37.085538 systemd-sysusers[813]: Creating group systemd-timesync with gid 997. Dec 12 22:57:37.086075 systemd-sysusers[813]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Dec 12 22:57:37.086785 systemd-sysusers[813]: Creating group systemd-coredump with gid 996. Dec 12 22:57:37.087319 systemd-sysusers[813]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Dec 12 22:57:37.097887 systemd[1]: Finished Create System Users. Dec 12 22:57:37.099694 systemd[1]: Starting Create Static Device Nodes in /dev... Dec 12 22:57:37.113378 systemd[1]: Finished Create Static Device Nodes in /dev. Dec 12 22:57:37.319568 systemd[1]: Finished Rebuild Hardware Database. Dec 12 22:57:37.335000 audit: BPF prog-id=27 op=LOAD Dec 12 22:57:37.335000 audit: BPF prog-id=28 op=LOAD Dec 12 22:57:37.335000 audit: BPF prog-id=29 op=LOAD Dec 12 22:57:37.335000 audit: BPF prog-id=12 op=UNLOAD Dec 12 22:57:37.335000 audit: BPF prog-id=13 op=UNLOAD Dec 12 22:57:37.336858 systemd[1]: Starting Rule-based Manager for Device Events and Files... Dec 12 22:57:37.359810 systemd[1]: Started Rule-based Manager for Device Events and Files. Dec 12 22:57:37.367000 audit: BPF prog-id=30 op=LOAD Dec 12 22:57:37.368760 systemd[1]: Starting Network Configuration... Dec 12 22:57:37.394735 systemd-networkd[838]: lo: Link UP Dec 12 22:57:37.394743 systemd-networkd[838]: lo: Gained carrier Dec 12 22:57:37.395037 systemd-networkd[838]: Enumeration completed Dec 12 22:57:37.395122 systemd[1]: Started Network Configuration. Dec 12 22:57:37.398411 systemd-udevd[820]: Using default interface naming scheme 'v249'. Dec 12 22:57:37.412611 udevadm[816]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Dec 12 22:57:37.432522 systemd-networkd[838]: eth0: Link UP Dec 12 22:57:37.437666 systemd[1]: Finished Wait for udev To Complete Device Initialization. Dec 12 22:57:37.442549 systemd-networkd[838]: eth0: Gained carrier Dec 12 22:57:37.446453 systemd[1]: Starting Activation of LVM2 logical volumes... Dec 12 22:57:37.450621 systemd-networkd[838]: eth0: DHCPv4 address 10.0.0.8/16 via 10.0.0.1 Dec 12 22:57:37.455294 lvm[846]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 12 22:57:37.484569 systemd[1]: Finished Activation of LVM2 logical volumes. Dec 12 22:57:37.485461 systemd[1]: Reached target Local Encrypted Volumes. Dec 12 22:57:37.493547 systemd[1]: Starting Activation of LVM2 logical volumes... Dec 12 22:57:37.497087 lvm[847]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 12 22:57:37.526424 systemd[1]: Finished Activation of LVM2 logical volumes. Dec 12 22:57:37.527362 systemd[1]: Reached target Preparation for Local File Systems. Dec 12 22:57:37.528265 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Dec 12 22:57:37.528292 systemd[1]: Reached target Containers. Dec 12 22:57:37.539712 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Dec 12 22:57:37.551592 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Dec 12 22:57:37.553515 systemd[1]: Mounting /usr/share/oem... Dec 12 22:57:37.559501 kernel: BTRFS info (device vda6): disk space caching is enabled Dec 12 22:57:37.559550 kernel: BTRFS info (device vda6): has skinny extents Dec 12 22:57:37.562952 systemd[1]: Mounted /usr/share/oem. Dec 12 22:57:37.563671 systemd[1]: Reached target Local File Systems. Dec 12 22:57:37.565308 systemd[1]: Starting Rebuild Dynamic Linker Cache... Dec 12 22:57:37.566401 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Dec 12 22:57:37.566441 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Dec 12 22:57:37.567382 systemd[1]: Starting Commit a transient machine-id on disk... Dec 12 22:57:37.569172 systemd[1]: Starting Create Volatile Files and Directories... Dec 12 22:57:37.575580 systemd-tmpfiles[872]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Dec 12 22:57:37.576788 systemd-tmpfiles[872]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Dec 12 22:57:37.583496 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Dec 12 22:57:37.584036 systemd[1]: Finished Commit a transient machine-id on disk. Dec 12 22:57:37.604227 systemd-tmpfiles[872]: Detected autofs mount point /boot during canonicalization of /boot. Dec 12 22:57:37.604244 systemd-tmpfiles[872]: Skipping /boot Dec 12 22:57:37.608992 systemd-tmpfiles[872]: Detected autofs mount point /boot during canonicalization of /boot. Dec 12 22:57:37.609011 systemd-tmpfiles[872]: Skipping /boot Dec 12 22:57:37.640923 systemd[1]: Finished Rebuild Dynamic Linker Cache. Dec 12 22:57:37.641993 systemd[1]: Finished Create Volatile Files and Directories. Dec 12 22:57:37.651449 systemd[1]: Starting Load Security Auditing Rules... Dec 12 22:57:37.653256 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Dec 12 22:57:37.655121 systemd[1]: Starting Rebuild Journal Catalog... Dec 12 22:57:37.656000 audit: BPF prog-id=31 op=LOAD Dec 12 22:57:37.657221 systemd[1]: Starting Network Name Resolution... Dec 12 22:57:37.658000 audit: BPF prog-id=32 op=LOAD Dec 12 22:57:37.659187 systemd[1]: Starting Network Time Synchronization... Dec 12 22:57:37.660803 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Dec 12 22:57:37.662124 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Dec 12 22:57:37.663284 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Dec 12 22:57:37.666759 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Dec 12 22:57:37.667868 systemd[1]: Finished Rebuild Journal Catalog. Dec 12 22:57:37.669579 systemd[1]: Starting Update is Completed... Dec 12 22:57:37.673956 systemd[1]: Finished Update is Completed. Dec 12 22:57:37.683000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Dec 12 22:57:37.684536 augenrules[896]: No rules Dec 12 22:57:37.685428 systemd[1]: Finished Load Security Auditing Rules. Dec 12 22:57:37.697705 systemd[1]: Started Network Time Synchronization. Dec 12 22:57:37.698374 systemd-timesyncd[884]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Dec 12 22:57:37.698756 systemd[1]: Reached target System Initialization. Dec 12 22:57:37.699619 systemd[1]: Started Watch for update engine configuration changes. Dec 12 22:57:37.700504 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 12 22:57:37.701375 systemd[1]: Started Daily Cleanup of Temporary Directories. Dec 12 22:57:37.702321 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Dec 12 22:57:37.702354 systemd[1]: Reached target Path Units. Dec 12 22:57:37.702980 systemd[1]: Reached target System Time Set. Dec 12 22:57:37.703765 systemd[1]: Started Daily Log Rotation. Dec 12 22:57:37.703955 systemd-resolved[881]: Positive Trust Anchors: Dec 12 22:57:37.703964 systemd-resolved[881]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 12 22:57:37.703991 systemd-resolved[881]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Dec 12 22:57:37.704442 systemd[1]: Started Weekly check for MD array's redundancy information.. Dec 12 22:57:37.705081 systemd-resolved[881]: Defaulting to hostname 'linux'. Dec 12 22:57:37.705555 systemd[1]: Reached target Timer Units. Dec 12 22:57:37.706460 systemd[1]: Listening on D-Bus System Message Bus Socket. Dec 12 22:57:37.721034 systemd[1]: Starting Docker Socket for the API... Dec 12 22:57:37.723846 systemd[1]: Listening on OpenSSH Server Socket. Dec 12 22:57:37.724913 systemd[1]: Started Network Name Resolution. Dec 12 22:57:37.725684 systemd[1]: Listening on Docker Socket for the API. Dec 12 22:57:37.726420 systemd[1]: Reached target Network. Dec 12 22:57:37.727052 systemd[1]: Reached target Host and Network Name Lookups. Dec 12 22:57:37.727804 systemd[1]: Reached target Socket Units. Dec 12 22:57:37.728417 systemd[1]: Reached target Basic System. Dec 12 22:57:37.729118 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Dec 12 22:57:37.729144 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Dec 12 22:57:37.730142 systemd[1]: Started D-Bus System Message Bus. Dec 12 22:57:37.733131 systemd[1]: Starting Extend Filesystems... Dec 12 22:57:37.733897 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Dec 12 22:57:37.734815 systemd[1]: Starting Generate /run/flatcar/motd... Dec 12 22:57:37.736397 systemd[1]: Starting Install an ssh key from /proc/cmdline... Dec 12 22:57:37.738216 systemd[1]: Starting Generate sshd host keys... Dec 12 22:57:37.739349 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Dec 12 22:57:37.739384 systemd[1]: Reached target Load system-provided cloud configs. Dec 12 22:57:37.742111 systemd[1]: Starting User Login Management... Dec 12 22:57:37.743101 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 12 22:57:37.744637 systemd[1]: Starting Update Engine... Dec 12 22:57:37.745193 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Dec 12 22:57:37.745223 systemd[1]: Reached target Load user-provided cloud configs. Dec 12 22:57:37.746565 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 12 22:57:37.746786 systemd[1]: Finished Install an ssh key from /proc/cmdline. Dec 12 22:57:37.747959 systemd[1]: motdgen.service: Deactivated successfully. Dec 12 22:57:37.748194 systemd[1]: Finished Generate /run/flatcar/motd. Dec 12 22:57:37.750076 extend-filesystems[906]: Found vda Dec 12 22:57:37.750076 extend-filesystems[906]: Found vda1 Dec 12 22:57:37.752023 extend-filesystems[906]: Found vda2 Dec 12 22:57:37.752023 extend-filesystems[906]: Found vda3 Dec 12 22:57:37.752023 extend-filesystems[906]: Found usr Dec 12 22:57:37.752023 extend-filesystems[906]: Found vda4 Dec 12 22:57:37.752023 extend-filesystems[906]: Found vda6 Dec 12 22:57:37.752023 extend-filesystems[906]: Found vda7 Dec 12 22:57:37.752023 extend-filesystems[906]: Found vda9 Dec 12 22:57:37.752023 extend-filesystems[906]: Checking size of /dev/vda9 Dec 12 22:57:37.764156 extend-filesystems[906]: Old size kept for /dev/vda9 Dec 12 22:57:37.764415 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 12 22:57:37.764686 systemd[1]: Finished Extend Filesystems. Dec 12 22:57:37.773657 update_engine[920]: I1212 22:57:37.773366 920 main.cc:89] Flatcar Update Engine starting Dec 12 22:57:37.782729 systemd[1]: Started Update Engine. Dec 12 22:57:37.783475 update_engine[920]: I1212 22:57:37.783442 920 update_check_scheduler.cc:74] Next update check in 3m24s Dec 12 22:57:37.784813 systemd-logind[915]: Watching system buttons on /dev/input/event0 (Power Button) Dec 12 22:57:37.784971 systemd-logind[915]: New seat seat0. Dec 12 22:57:37.791663 systemd[1]: Started Cluster reboot manager. Dec 12 22:57:37.792795 systemd[1]: Started User Login Management. Dec 12 22:57:37.817198 locksmithd[930]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Dec 12 22:57:38.921858 systemd-networkd[838]: eth0: Gained IPv6LL Dec 12 22:57:39.185654 sshd_keygen[922]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Dec 12 22:57:39.207697 systemd[1]: Finished Generate sshd host keys. Dec 12 22:57:39.218586 systemd[1]: Starting Generate /run/issue... Dec 12 22:57:39.224509 systemd[1]: issuegen.service: Deactivated successfully. Dec 12 22:57:39.224739 systemd[1]: Finished Generate /run/issue. Dec 12 22:57:39.226826 systemd[1]: Starting Permit User Sessions... Dec 12 22:57:39.231771 systemd[1]: Finished Permit User Sessions. Dec 12 22:57:39.233791 systemd[1]: Started Getty on tty1. Dec 12 22:57:39.235570 systemd[1]: Started Serial Getty on ttyAMA0. Dec 12 22:57:39.236400 systemd[1]: Reached target Login Prompts. Dec 12 22:57:39.237379 systemd[1]: Reached target Multi-User System. Dec 12 22:57:39.239283 systemd[1]: Starting Record Runlevel Change in UTMP... Dec 12 22:57:39.244609 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Dec 12 22:57:39.244831 systemd[1]: Finished Record Runlevel Change in UTMP. Dec 12 22:57:39.245865 systemd[1]: Startup finished in 708ms (kernel) + 2.347s (initrd) + 4.338s (userspace) = 7.395s. Dec 12 22:57:44.451846 systemd[1]: Created slice Slice /system/sshd. Dec 12 22:57:44.453899 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37398). Dec 12 22:57:44.499741 sshd[951]: Accepted publickey for core from 10.0.0.1 port 37398 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:44.501513 sshd[951]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:44.516104 systemd[1]: Created slice User Slice of UID 500. Dec 12 22:57:44.517828 systemd[1]: Starting User Runtime Directory /run/user/500... Dec 12 22:57:44.519733 systemd-logind[915]: New session 1 of user core. Dec 12 22:57:44.523925 systemd[1]: Finished User Runtime Directory /run/user/500. Dec 12 22:57:44.525994 systemd[1]: Starting User Manager for UID 500... Dec 12 22:57:44.528153 systemd[954]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:44.575040 systemd[954]: Queued start job for default target Main User Target. Dec 12 22:57:44.575201 systemd[954]: Reached target Paths. Dec 12 22:57:44.575216 systemd[954]: Reached target Sockets. Dec 12 22:57:44.575226 systemd[954]: Reached target Timers. Dec 12 22:57:44.575236 systemd[954]: Reached target Basic System. Dec 12 22:57:44.575335 systemd[1]: Started User Manager for UID 500. Dec 12 22:57:44.576131 systemd[954]: Reached target Main User Target. Dec 12 22:57:44.576157 systemd[954]: Startup finished in 44ms. Dec 12 22:57:44.585701 systemd[1]: Started Session 1 of User core. Dec 12 22:57:44.644872 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37408). Dec 12 22:57:44.687432 sshd[963]: Accepted publickey for core from 10.0.0.1 port 37408 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:44.688683 sshd[963]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:44.692101 systemd-logind[915]: New session 2 of user core. Dec 12 22:57:44.706716 systemd[1]: Started Session 2 of User core. Dec 12 22:57:44.760273 sshd[963]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:44.773172 systemd[1]: sshd@1-10.0.0.8:22-10.0.0.1:37408.service: Deactivated successfully. Dec 12 22:57:44.773780 systemd[1]: session-2.scope: Deactivated successfully. Dec 12 22:57:44.774431 systemd-logind[915]: Session 2 logged out. Waiting for processes to exit. Dec 12 22:57:44.775387 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37420). Dec 12 22:57:44.775939 systemd-logind[915]: Removed session 2. Dec 12 22:57:44.815835 sshd[969]: Accepted publickey for core from 10.0.0.1 port 37420 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:44.817145 sshd[969]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:44.820114 systemd-logind[915]: New session 3 of user core. Dec 12 22:57:44.834706 systemd[1]: Started Session 3 of User core. Dec 12 22:57:44.882863 sshd[969]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:44.893393 systemd[1]: sshd@2-10.0.0.8:22-10.0.0.1:37420.service: Deactivated successfully. Dec 12 22:57:44.894089 systemd[1]: session-3.scope: Deactivated successfully. Dec 12 22:57:44.894723 systemd-logind[915]: Session 3 logged out. Waiting for processes to exit. Dec 12 22:57:44.895724 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37434). Dec 12 22:57:44.896581 systemd-logind[915]: Removed session 3. Dec 12 22:57:44.935579 sshd[975]: Accepted publickey for core from 10.0.0.1 port 37434 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:44.936482 sshd[975]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:44.939323 systemd-logind[915]: New session 4 of user core. Dec 12 22:57:44.946665 systemd[1]: Started Session 4 of User core. Dec 12 22:57:44.998897 sshd[975]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:45.007468 systemd[1]: sshd@3-10.0.0.8:22-10.0.0.1:37434.service: Deactivated successfully. Dec 12 22:57:45.008187 systemd[1]: session-4.scope: Deactivated successfully. Dec 12 22:57:45.008935 systemd-logind[915]: Session 4 logged out. Waiting for processes to exit. Dec 12 22:57:45.010217 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37450). Dec 12 22:57:45.010947 systemd-logind[915]: Removed session 4. Dec 12 22:57:45.050060 sshd[981]: Accepted publickey for core from 10.0.0.1 port 37450 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:45.051031 sshd[981]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:45.053775 systemd-logind[915]: New session 5 of user core. Dec 12 22:57:45.061674 systemd[1]: Started Session 5 of User core. Dec 12 22:57:45.117557 sudo[984]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Dec 12 22:57:45.117778 sudo[984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 22:57:45.130051 sudo[984]: pam_unix(sudo:session): session closed for user root Dec 12 22:57:45.132950 sshd[981]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:45.150617 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37464). Dec 12 22:57:45.152025 dbus-daemon[905]: [system] Reloaded configuration Dec 12 22:57:45.154751 systemd[1]: sshd@4-10.0.0.8:22-10.0.0.1:37450.service: Deactivated successfully. Dec 12 22:57:45.155454 systemd[1]: session-5.scope: Deactivated successfully. Dec 12 22:57:45.156240 systemd-logind[915]: Session 5 logged out. Waiting for processes to exit. Dec 12 22:57:45.157012 systemd-logind[915]: Removed session 5. Dec 12 22:57:45.190995 sshd[987]: Accepted publickey for core from 10.0.0.1 port 37464 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:45.192003 sshd[987]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:45.194688 systemd-logind[915]: New session 6 of user core. Dec 12 22:57:45.209654 systemd[1]: Started Session 6 of User core. Dec 12 22:57:45.260950 sudo[992]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Dec 12 22:57:45.261165 sudo[992]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 22:57:45.263832 sudo[992]: pam_unix(sudo:session): session closed for user root Dec 12 22:57:45.267275 sudo[991]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Dec 12 22:57:45.267716 sudo[991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 22:57:45.288410 systemd[1]: Stopping Load Security Auditing Rules... Dec 12 22:57:45.287000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Dec 12 22:57:45.290734 auditctl[995]: No rules Dec 12 22:57:45.290952 systemd[1]: audit-rules.service: Deactivated successfully. Dec 12 22:57:45.291181 systemd[1]: Stopped Load Security Auditing Rules. Dec 12 22:57:45.291476 kernel: kauditd_printk_skb: 11 callbacks suppressed Dec 12 22:57:45.291515 kernel: audit: type=1305 audit(1765580265.287:56): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Dec 12 22:57:45.292442 systemd[1]: Starting Load Security Auditing Rules... Dec 12 22:57:45.306533 augenrules[1012]: No rules Dec 12 22:57:45.307171 systemd[1]: Finished Load Security Auditing Rules. Dec 12 22:57:45.307899 sudo[991]: pam_unix(sudo:session): session closed for user root Dec 12 22:57:45.308981 sshd[987]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:45.316013 systemd[1]: sshd@5-10.0.0.8:22-10.0.0.1:37464.service: Deactivated successfully. Dec 12 22:57:45.316624 systemd[1]: session-6.scope: Deactivated successfully. Dec 12 22:57:45.317169 systemd-logind[915]: Session 6 logged out. Waiting for processes to exit. Dec 12 22:57:45.318114 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37472). Dec 12 22:57:45.318742 systemd-logind[915]: Removed session 6. Dec 12 22:57:45.358354 sshd[1018]: Accepted publickey for core from 10.0.0.1 port 37472 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:45.359179 sshd[1018]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:45.361511 kernel: audit: type=1006 audit(1765580265.358:57): pid=1018 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Dec 12 22:57:45.362512 systemd-logind[915]: New session 7 of user core. Dec 12 22:57:45.368630 systemd[1]: Started Session 7 of User core. Dec 12 22:57:45.419075 sudo[1021]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/bash -c cat >/etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem </etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem < Dec 12 22:57:48.323172 update_engine[1268]: Dec 12 22:57:48.323172 update_engine[1268]: Dec 12 22:57:48.323172 update_engine[1268]: Dec 12 22:57:48.323172 update_engine[1268]: Dec 12 22:57:48.323172 update_engine[1268]: Dec 12 22:57:48.323172 update_engine[1268]: Dec 12 22:57:48.323172 update_engine[1268]: Dec 12 22:57:48.323172 update_engine[1268]: Dec 12 22:57:48.323172 update_engine[1268]: I1212 22:57:48.323171 1268 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Dec 12 22:57:48.325722 update_engine[1268]: I1212 22:57:48.325692 1268 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Dec 12 22:57:48.326568 update_engine[1268]: I1212 22:57:48.326538 1268 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Dec 12 22:57:48.328217 update_engine[1268]: I1212 22:57:48.328187 1268 libcurl_http_fetcher.cc:248] HTTP response code: 200 Dec 12 22:57:48.328286 update_engine[1268]: I1212 22:57:48.328270 1268 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Dec 12 22:57:48.328286 update_engine[1268]: I1212 22:57:48.328280 1268 omaha_request_action.cc:619] Omaha request response: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.328286 update_engine[1268]: Dec 12 22:57:48.331243 update_engine[1268]: I1212 22:57:48.331203 1268 omaha_request_action.cc:447] Omaha Response manifest version = Dec 12 22:57:48.331243 update_engine[1268]: I1212 22:57:48.331238 1268 omaha_request_action.cc:470] Found 1 url(s) Dec 12 22:57:48.331243 update_engine[1268]: I1212 22:57:48.331251 1268 omaha_request_action.cc:506] Processing first of 1 package(s) Dec 12 22:57:48.331359 update_engine[1268]: I1212 22:57:48.331254 1268 omaha_request_action.cc:513] Omaha Response package name = update.gz Dec 12 22:57:48.331359 update_engine[1268]: I1212 22:57:48.331259 1268 omaha_request_action.cc:529] Url0: http://10.0.0.7:34567/packages/update.gz Dec 12 22:57:48.331359 update_engine[1268]: I1212 22:57:48.331267 1268 omaha_request_action.cc:541] Payload size = 404125651 bytes Dec 12 22:57:48.331359 update_engine[1268]: I1212 22:57:48.331277 1268 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Dec 12 22:57:48.331359 update_engine[1268]: I1212 22:57:48.331288 1268 payload_state.cc:51] Resetting all persisted state as this is a new response Dec 12 22:57:48.331359 update_engine[1268]: I1212 22:57:48.331291 1268 payload_state.cc:360] Current Response Signature = Dec 12 22:57:48.331359 update_engine[1268]: NumURLs = 1 Dec 12 22:57:48.331359 update_engine[1268]: Url0 = http://10.0.0.7:34567/packages/update.gz Dec 12 22:57:48.331359 update_engine[1268]: Payload Size = 404125651 Dec 12 22:57:48.331359 update_engine[1268]: Payload Sha256 Hash = 4hfcTZDmcDqsO9HQem8/SEl+FfeTS7xMT8GNrEcoLTM= Dec 12 22:57:48.331359 update_engine[1268]: Is Delta Payload = 0 Dec 12 22:57:48.331359 update_engine[1268]: Max Failure Count Per Url = 10 Dec 12 22:57:48.331359 update_engine[1268]: Disable Payload Backoff = 1 Dec 12 22:57:48.331603 update_engine[1268]: I1212 22:57:48.331471 1268 payload_state.cc:381] Payload Attempt Number = 0 Dec 12 22:57:48.331603 update_engine[1268]: I1212 22:57:48.331539 1268 payload_state.cc:404] Current URL Index = 0 Dec 12 22:57:48.331603 update_engine[1268]: I1212 22:57:48.331573 1268 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Dec 12 22:57:48.331603 update_engine[1268]: I1212 22:57:48.331600 1268 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Dec 12 22:57:48.331672 update_engine[1268]: I1212 22:57:48.331604 1268 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Dec 12 22:57:48.331672 update_engine[1268]: I1212 22:57:48.331637 1268 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Dec 12 22:57:48.331672 update_engine[1268]: I1212 22:57:48.331655 1268 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Dec 12 22:57:48.331672 update_engine[1268]: I1212 22:57:48.331660 1268 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Dec 12 22:57:48.331743 update_engine[1268]: I1212 22:57:48.331674 1268 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Dec 12 22:57:48.331743 update_engine[1268]: E1212 22:57:48.331681 1268 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Dec 12 22:57:48.332170 update_engine[1268]: I1212 22:57:48.332139 1268 omaha_response_handler_action.cc:85] Using this install plan: Dec 12 22:57:48.332170 update_engine[1268]: I1212 22:57:48.332170 1268 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.7:34567/packages/update.gz, payload size: 404125651, payload hash: 4hfcTZDmcDqsO9HQem8/SEl+FfeTS7xMT8GNrEcoLTM=, partition_path: /dev/vda4, kernel_path: /boot/flatcar/vmlinuz-b, pcr_policy_path: /var/lib/update_engine/pcrs-b.zip, old_partition_path: /dev/vda3, old_kernel_path: /boot/flatcar/vmlinuz-a Dec 12 22:57:48.332265 update_engine[1268]: I1212 22:57:48.332252 1268 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Dec 12 22:57:48.334066 update_engine[1268]: I1212 22:57:48.334035 1268 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Dec 12 22:57:48.419118 sshd[1281]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:48.421413 systemd[1]: session-25.scope: Deactivated successfully. Dec 12 22:57:48.422089 systemd-logind[915]: Session 25 logged out. Waiting for processes to exit. Dec 12 22:57:48.422189 systemd[1]: sshd@24-10.0.0.8:22-10.0.0.1:37604.service: Deactivated successfully. Dec 12 22:57:48.423132 systemd-logind[915]: Removed session 25. Dec 12 22:57:50.201717 update_engine[1268]: I1212 22:57:50.201681 1268 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Dec 12 22:57:50.202164 update_engine[1268]: I1212 22:57:50.202147 1268 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Dec 12 22:57:50.258277 update_engine[1268]: E1212 22:57:50.258235 1268 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Dec 12 22:57:50.258476 update_engine[1268]: I1212 22:57:50.258466 1268 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Dec 12 22:57:50.258547 update_engine[1268]: I1212 22:57:50.258538 1268 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Dec 12 22:57:50.258637 update_engine[1268]: I1212 22:57:50.258625 1268 update_attempter.cc:302] Processing Done. Dec 12 22:57:50.258722 update_engine[1268]: E1212 22:57:50.258711 1268 update_attempter.cc:615] Update failed. Dec 12 22:57:50.258768 update_engine[1268]: I1212 22:57:50.258759 1268 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Dec 12 22:57:50.258812 update_engine[1268]: I1212 22:57:50.258803 1268 payload_state.cc:276] Incrementing the URL failure count Dec 12 22:57:50.258854 update_engine[1268]: I1212 22:57:50.258846 1268 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Dec 12 22:57:50.259087 update_engine[1268]: I1212 22:57:50.259073 1268 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Dec 12 22:57:50.259167 update_engine[1268]: I1212 22:57:50.259156 1268 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.7:34567/v1/update Dec 12 22:57:50.259219 update_engine[1268]: I1212 22:57:50.259209 1268 omaha_request_action.cc:269] Request: Dec 12 22:57:50.259219 update_engine[1268]: Dec 12 22:57:50.259219 update_engine[1268]: Dec 12 22:57:50.259219 update_engine[1268]: Dec 12 22:57:50.259219 update_engine[1268]: Dec 12 22:57:50.259219 update_engine[1268]: Dec 12 22:57:50.259219 update_engine[1268]: Dec 12 22:57:50.259385 update_engine[1268]: I1212 22:57:50.259373 1268 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Dec 12 22:57:50.259505 update_engine[1268]: I1212 22:57:50.259478 1268 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Dec 12 22:57:50.259677 update_engine[1268]: I1212 22:57:50.259663 1268 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Dec 12 22:57:50.465878 update_engine[1268]: I1212 22:57:50.465394 1268 libcurl_http_fetcher.cc:248] HTTP response code: 200 Dec 12 22:57:50.466064 update_engine[1268]: I1212 22:57:50.466048 1268 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Dec 12 22:57:50.466139 update_engine[1268]: I1212 22:57:50.466128 1268 omaha_request_action.cc:619] Omaha request response: Dec 12 22:57:50.466139 update_engine[1268]: Dec 12 22:57:50.466139 update_engine[1268]: Dec 12 22:57:50.466139 update_engine[1268]: Dec 12 22:57:50.466139 update_engine[1268]: Dec 12 22:57:50.466139 update_engine[1268]: Dec 12 22:57:50.466139 update_engine[1268]: Dec 12 22:57:50.466297 update_engine[1268]: E1212 22:57:50.466288 1268 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Dec 12 22:57:50.466341 update_engine[1268]: I1212 22:57:50.466332 1268 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Dec 12 22:57:50.466384 update_engine[1268]: I1212 22:57:50.466375 1268 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Dec 12 22:57:50.466428 update_engine[1268]: I1212 22:57:50.466419 1268 update_attempter.cc:302] Processing Done. Dec 12 22:57:50.466474 update_engine[1268]: I1212 22:57:50.466465 1268 update_attempter.cc:306] Error event sent. Dec 12 22:57:58.457323 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56956). Dec 12 22:57:58.503067 sshd[1302]: Accepted publickey for core from 10.0.0.1 port 56956 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:58.504778 sshd[1302]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:58.504973 kernel: kauditd_printk_skb: 287 callbacks suppressed Dec 12 22:57:58.505010 kernel: audit: type=1006 audit(1765580278.502:353): pid=1302 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=26 res=1 Dec 12 22:57:58.508834 systemd-logind[915]: New session 26 of user core. Dec 12 22:57:58.518674 systemd[1]: Started Session 26 of User core. Dec 12 22:57:58.575870 sshd[1302]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:58.585357 systemd[1]: sshd@25-10.0.0.8:22-10.0.0.1:56956.service: Deactivated successfully. Dec 12 22:57:58.586011 systemd[1]: session-26.scope: Deactivated successfully. Dec 12 22:57:58.586689 systemd-logind[915]: Session 26 logged out. Waiting for processes to exit. Dec 12 22:57:58.587884 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56962). Dec 12 22:57:58.588569 systemd-logind[915]: Removed session 26. Dec 12 22:57:58.630499 sshd[1309]: Accepted publickey for core from 10.0.0.1 port 56962 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:58.631669 sshd[1309]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:58.633502 kernel: audit: type=1006 audit(1765580278.629:354): pid=1309 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=27 res=1 Dec 12 22:57:58.635350 systemd-logind[915]: New session 27 of user core. Dec 12 22:57:58.644692 systemd[1]: Started Session 27 of User core. Dec 12 22:57:58.701597 sshd[1309]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:58.713776 systemd[1]: sshd@26-10.0.0.8:22-10.0.0.1:56962.service: Deactivated successfully. Dec 12 22:57:58.714564 systemd[1]: session-27.scope: Deactivated successfully. Dec 12 22:57:58.715339 systemd-logind[915]: Session 27 logged out. Waiting for processes to exit. Dec 12 22:57:58.716732 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56978). Dec 12 22:57:58.717638 systemd-logind[915]: Removed session 27. Dec 12 22:57:58.757925 sshd[1317]: Accepted publickey for core from 10.0.0.1 port 56978 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:58.759058 sshd[1317]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:58.760499 kernel: audit: type=1006 audit(1765580278.758:355): pid=1317 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=28 res=1 Dec 12 22:57:58.762761 systemd-logind[915]: New session 28 of user core. Dec 12 22:57:58.776707 systemd[1]: Started Session 28 of User core. Dec 12 22:57:58.826872 sshd[1317]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:58.851087 systemd[1]: sshd@27-10.0.0.8:22-10.0.0.1:56978.service: Deactivated successfully. Dec 12 22:57:58.851767 systemd[1]: session-28.scope: Deactivated successfully. Dec 12 22:57:58.852392 systemd-logind[915]: Session 28 logged out. Waiting for processes to exit. Dec 12 22:57:58.853538 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56988). Dec 12 22:57:58.854210 systemd-logind[915]: Removed session 28. Dec 12 22:57:58.894601 sshd[1323]: Accepted publickey for core from 10.0.0.1 port 56988 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:58.896150 sshd[1323]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:58.897523 kernel: audit: type=1006 audit(1765580278.895:356): pid=1323 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=29 res=1 Dec 12 22:57:58.899767 systemd-logind[915]: New session 29 of user core. Dec 12 22:57:58.914671 systemd[1]: Started Session 29 of User core. Dec 12 22:57:58.964099 sshd[1323]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:58.972179 systemd[1]: sshd@28-10.0.0.8:22-10.0.0.1:56988.service: Deactivated successfully. Dec 12 22:57:58.972834 systemd[1]: session-29.scope: Deactivated successfully. Dec 12 22:57:58.973452 systemd-logind[915]: Session 29 logged out. Waiting for processes to exit. Dec 12 22:57:58.974598 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:57002). Dec 12 22:57:58.975276 systemd-logind[915]: Removed session 29. Dec 12 22:57:59.016711 sshd[1329]: Accepted publickey for core from 10.0.0.1 port 57002 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:57:59.018047 sshd[1329]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:57:59.019501 kernel: audit: type=1006 audit(1765580279.016:357): pid=1329 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=30 res=1 Dec 12 22:57:59.021699 systemd-logind[915]: New session 30 of user core. Dec 12 22:57:59.029662 systemd[1]: Started Session 30 of User core. Dec 12 22:57:59.081705 sudo[1333]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Dec 12 22:57:59.081913 sudo[1333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 22:57:59.087681 systemd[1]: sshd.socket: Deactivated successfully. Dec 12 22:57:59.088029 systemd[1]: Closed OpenSSH Server Socket. Dec 12 22:57:59.088990 sudo[1333]: pam_unix(sudo:session): session closed for user root Dec 12 22:57:59.092831 sudo[1332]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Dec 12 22:57:59.093043 sudo[1332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 22:57:59.108999 systemd[1]: Stopping Session 1 of User core... Dec 12 22:57:59.110005 sshd[951]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:59.110039 systemd[1]: Stopping Session 30 of User core... Dec 12 22:57:59.110594 sshd[1329]: pam_unix(sshd:session): session closed for user core Dec 12 22:57:59.110746 sudo[1332]: pam_unix(sudo:session): session closed for user root Dec 12 22:57:59.111816 systemd[1]: Removed slice Slice /system/addon-config. Dec 12 22:57:59.113044 systemd[1]: Removed slice Slice /system/addon-run. Dec 12 22:57:59.114184 systemd[1]: Removed slice Slice /system/modprobe. Dec 12 22:57:59.115318 systemd[1]: Removed slice Slice /system/system-cloudinit. Dec 12 22:57:59.116541 systemd[1]: Stopped target Multi-User System. Dec 12 22:57:59.117256 systemd[1]: Stopped target Login Prompts. Dec 12 22:57:59.118123 systemd[1]: Stopped target Containers. Dec 12 22:57:59.118916 systemd[1]: Stopped target Host and Network Name Lookups. Dec 12 22:57:59.119719 systemd[1]: Stopped target Remote Encrypted Volumes. Dec 12 22:57:59.120472 systemd[1]: Stopped target Timer Units. Dec 12 22:57:59.121102 systemd[1]: logrotate.timer: Deactivated successfully. Dec 12 22:57:59.121149 systemd[1]: Stopped Daily Log Rotation. Dec 12 22:57:59.122150 systemd[1]: mdadm.timer: Deactivated successfully. Dec 12 22:57:59.122188 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Dec 12 22:57:59.123162 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Dec 12 22:57:59.123214 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Dec 12 22:57:59.124081 systemd[1]: Stopped target System Time Set. Dec 12 22:57:59.124813 systemd[1]: Stopped target Load user-provided cloud configs. Dec 12 22:57:59.125654 systemd[1]: Stopped target Load system-provided cloud configs. Dec 12 22:57:59.126688 systemd[1]: systemd-coredump.socket: Deactivated successfully. Dec 12 22:57:59.126819 systemd[1]: Closed Process Core Dump Socket. Dec 12 22:57:59.128344 systemd[1]: Unmounting Boot partition... Dec 12 22:57:59.129381 systemd[1]: Stopping Getty on tty1... Dec 12 22:57:59.130210 systemd[1]: Stopping Serial Getty on ttyAMA0... Dec 12 22:57:59.131121 systemd[1]: Stopping OpenSSH per-connection server daemon... Dec 12 22:57:59.132008 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:57002)... Dec 12 22:57:59.132921 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Dec 12 22:57:59.133072 systemd[1]: Stopped Commit a transient machine-id on disk. Dec 12 22:57:59.133987 systemd[1]: Stopped target First Boot Complete. Dec 12 22:57:59.135963 systemd[1]: Stopping Load/Save Random Seed... Dec 12 22:57:59.136818 systemd[1]: Stopping Update Engine... Dec 12 22:57:59.140045 systemd[1]: getty@tty1.service: Deactivated successfully. Dec 12 22:57:59.140343 systemd[1]: Stopped Getty on tty1. Dec 12 22:57:59.141722 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Dec 12 22:57:59.141966 systemd[1]: Stopped Serial Getty on ttyAMA0. Dec 12 22:57:59.143234 systemd[1]: sshd@0-10.0.0.8:22-10.0.0.1:37398.service: Deactivated successfully. Dec 12 22:57:59.143439 systemd[1]: Stopped OpenSSH per-connection server daemon. Dec 12 22:57:59.145206 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Dec 12 22:57:59.145283 systemd[1]: update-engine.service: Failed with result 'exit-code'. Dec 12 22:57:59.145567 systemd[1]: Stopped Update Engine. Dec 12 22:57:59.146198 systemd[1]: update-engine.service: Consumed 2.374s CPU time. Dec 12 22:57:59.146437 systemd[1]: sshd@29-10.0.0.8:22-10.0.0.1:57002.service: Deactivated successfully. Dec 12 22:57:59.146753 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:57002). Dec 12 22:57:59.159330 systemd[1]: systemd-random-seed.service: Deactivated successfully. Dec 12 22:57:59.159603 systemd[1]: Stopped Load/Save Random Seed. Dec 12 22:57:59.160564 systemd[1]: session-30.scope: Deactivated successfully. Dec 12 22:57:59.160813 systemd[1]: Stopped Session 30 of User core. Dec 12 22:57:59.161773 systemd[1]: session-1.scope: Deactivated successfully. Dec 12 22:57:59.162024 systemd[1]: Stopped Session 1 of User core. Dec 12 22:57:59.163248 systemd-logind[915]: Session 1 logged out. Waiting for processes to exit. Dec 12 22:57:59.164271 systemd-logind[915]: Session 30 logged out. Waiting for processes to exit. Dec 12 22:57:59.164530 systemd[1]: Removed slice Slice /system/getty. Dec 12 22:57:59.165585 systemd[1]: Removed slice Slice /system/serial-getty. Dec 12 22:57:59.166672 systemd[1]: Removed slice Slice /system/sshd. Dec 12 22:57:59.167429 systemd[1]: sshd-keygen.service: Deactivated successfully. Dec 12 22:57:59.167942 systemd[1]: Stopped Generate sshd host keys. Dec 12 22:57:59.168871 systemd[1]: sshd-keygen.service: Consumed 1.425s CPU time. Dec 12 22:57:59.169061 systemd[1]: Stopping User Login Management... Dec 12 22:57:59.169758 systemd[1]: Stopping User Manager for UID 500... Dec 12 22:57:59.171043 systemd[954]: Stopped target Main User Target. Dec 12 22:57:59.171063 systemd[954]: Stopped target Basic System. Dec 12 22:57:59.171072 systemd[954]: Stopped target Paths. Dec 12 22:57:59.171080 systemd[954]: Stopped target Sockets. Dec 12 22:57:59.171094 systemd[954]: Reached target Shutdown. Dec 12 22:57:59.171101 systemd[954]: Stopped target Timers. Dec 12 22:57:59.171104 systemd[1]: boot.mount: Deactivated successfully. Dec 12 22:57:59.171255 systemd[954]: Finished Exit the Session. Dec 12 22:57:59.171280 systemd[954]: Reached target Exit the Session. Dec 12 22:57:59.171400 systemd[1]: Unmounted Boot partition. Dec 12 22:57:59.172531 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Dec 12 22:57:59.172695 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Dec 12 22:57:59.174208 systemd[1]: user@500.service: Deactivated successfully. Dec 12 22:57:59.174403 systemd[1]: Stopped User Manager for UID 500. Dec 12 22:57:59.175845 systemd-logind[915]: Removed session 30. Dec 12 22:57:59.176740 systemd[1]: Stopping User Runtime Directory /run/user/500... Dec 12 22:57:59.182186 systemd[1]: run-user-500.mount: Deactivated successfully. Dec 12 22:57:59.182256 systemd[1]: Unmounted /run/user/500. Dec 12 22:57:59.183376 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Dec 12 22:57:59.183642 systemd[1]: Stopped User Runtime Directory /run/user/500. Dec 12 22:57:59.185241 systemd[1]: Removed slice User Slice of UID 500. Dec 12 22:57:59.186988 systemd[1]: Stopping D-Bus System Message Bus... Dec 12 22:57:59.188769 systemd[1]: Stopping Permit User Sessions... Dec 12 22:57:59.190433 systemd[1]: systemd-logind.service: Deactivated successfully. Dec 12 22:57:59.190744 systemd[1]: Stopped User Login Management. Dec 12 22:57:59.193865 systemd[1]: dbus.service: Deactivated successfully. Dec 12 22:57:59.194274 systemd[1]: Stopped D-Bus System Message Bus. Dec 12 22:57:59.195410 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Dec 12 22:57:59.194000 audit: BPF prog-id=58 op=UNLOAD Dec 12 22:57:59.196046 systemd[1]: Stopped Permit User Sessions. Dec 12 22:57:59.196998 kernel: audit: type=1334 audit(1765580279.194:358): prog-id=58 op=UNLOAD Dec 12 22:57:59.197436 systemd[1]: Stopped target Basic System. Dec 12 22:57:59.198181 systemd[1]: Stopped target Network. Dec 12 22:57:59.198915 systemd[1]: Stopped target Path Units. Dec 12 22:57:59.199602 systemd[1]: motdgen.path: Deactivated successfully. Dec 12 22:57:59.203558 systemd[1]: Stopped Watch for update engine configuration changes. Dec 12 22:57:59.204758 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Dec 12 22:57:59.209549 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 12 22:57:59.210542 systemd[1]: Stopped target Remote File Systems. Dec 12 22:57:59.211281 systemd[1]: Stopped target Slice Units. Dec 12 22:57:59.212395 systemd[1]: Removed slice User and Session Slice. Dec 12 22:57:59.213195 systemd[1]: Stopped target Socket Units. Dec 12 22:57:59.213988 systemd[1]: dbus.socket: Deactivated successfully. Dec 12 22:57:59.214129 systemd[1]: Closed D-Bus System Message Bus Socket. Dec 12 22:57:59.215064 systemd[1]: docker.socket: Deactivated successfully. Dec 12 22:57:59.215465 systemd[1]: Closed Docker Socket for the API. Dec 12 22:57:59.216227 systemd[1]: Stopped target System Initialization. Dec 12 22:57:59.217075 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Dec 12 22:57:59.217282 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Dec 12 22:57:59.218313 systemd[1]: Stopped target Local Verity Protected Volumes. Dec 12 22:57:59.229425 systemd[1]: Stopping Load Security Auditing Rules... Dec 12 22:57:59.230643 systemd[1]: Stopping Network Name Resolution... Dec 12 22:57:59.231615 systemd[1]: Stopping Network Time Synchronization... Dec 12 22:57:59.232468 auditctl[1347]: No rules Dec 12 22:57:59.232720 systemd[1]: systemd-update-done.service: Deactivated successfully. Dec 12 22:57:59.232848 systemd[1]: Stopped Update is Completed. Dec 12 22:57:59.233567 systemd[1]: ldconfig.service: Deactivated successfully. Dec 12 22:57:59.233710 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Dec 12 22:57:59.234453 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Dec 12 22:57:59.234610 systemd[1]: Stopped Rebuild Hardware Database. Dec 12 22:57:59.235387 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Dec 12 22:57:59.235587 systemd[1]: Stopped Rebuild Journal Catalog. Dec 12 22:57:59.237262 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Dec 12 22:57:59.240094 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 12 22:57:59.240494 systemd[1]: Stopped Network Name Resolution. Dec 12 22:57:59.241551 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Dec 12 22:57:59.241898 systemd[1]: Stopped Network Time Synchronization. Dec 12 22:57:59.243032 systemd[1]: audit-rules.service: Deactivated successfully. Dec 12 22:57:59.243415 systemd[1]: Stopped Load Security Auditing Rules. Dec 12 22:57:59.245651 systemd[1]: Stopping Network Configuration... Dec 12 22:57:59.246768 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Dec 12 22:57:59.247077 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Dec 12 22:57:59.248588 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Dec 12 22:57:59.248790 systemd[1]: Stopped Create Volatile Files and Directories. Dec 12 22:57:59.249760 systemd[1]: Stopped target Local File Systems. Dec 12 22:57:59.264536 systemd-networkd[838]: eth0: DHCPv6 lease lost Dec 12 22:57:59.266000 audit: BPF prog-id=50 op=UNLOAD Dec 12 22:57:59.266000 audit: BPF prog-id=61 op=UNLOAD Dec 12 22:57:59.269212 kernel: audit: type=1334 audit(1765580279.266:359): prog-id=50 op=UNLOAD Dec 12 22:57:59.269283 kernel: audit: type=1334 audit(1765580279.266:360): prog-id=61 op=UNLOAD Dec 12 22:57:59.269495 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Dec 12 22:57:59.272249 systemd[1]: Unmounting External Media Directory... Dec 12 22:57:59.274136 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Dec 12 22:57:59.276113 systemd[1]: Unmounting /run/torcx/unpack... Dec 12 22:57:59.277540 systemd[1]: Unmounting Temporary Directory /tmp... Dec 12 22:57:59.279051 systemd[1]: Unmounting /usr/share/oem... Dec 12 22:57:59.280547 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Dec 12 22:57:59.283331 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 12 22:57:59.283623 systemd[1]: Stopped Network Configuration. Dec 12 22:57:59.284430 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Dec 12 22:57:59.284754 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Dec 12 22:57:59.285848 systemd[1]: media.mount: Deactivated successfully. Dec 12 22:57:59.286151 systemd[1]: Unmounted External Media Directory. Dec 12 22:57:59.287062 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Dec 12 22:57:59.287310 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Dec 12 22:57:59.288611 systemd[1]: tmp.mount: Deactivated successfully. Dec 12 22:57:59.288882 systemd[1]: Unmounted Temporary Directory /tmp. Dec 12 22:57:59.289727 systemd[1]: usr-share-oem.mount: Deactivated successfully. Dec 12 22:57:59.290026 systemd[1]: Unmounted /usr/share/oem. Dec 12 22:57:59.291042 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Dec 12 22:57:59.291286 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Dec 12 22:57:59.291000 audit: BPF prog-id=54 op=UNLOAD Dec 12 22:57:59.293166 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 12 22:57:59.293212 systemd[1]: Closed Network Service Netlink Socket. Dec 12 22:57:59.294512 kernel: audit: type=1334 audit(1765580279.291:361): prog-id=54 op=UNLOAD Dec 12 22:57:59.294577 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Dec 12 22:57:59.294702 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Dec 12 22:57:59.296071 systemd[1]: Removed slice Slice /system/systemd-fsck. Dec 12 22:57:59.297053 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 12 22:57:59.297192 systemd[1]: Stopped Apply Kernel Variables. Dec 12 22:57:59.298164 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Dec 12 22:57:59.298503 systemd[1]: Unmounted /run/torcx/unpack. Dec 12 22:57:59.299936 systemd[1]: Stopped target Preparation for Local File Systems. Dec 12 22:57:59.300933 systemd[1]: Stopped target Swaps. Dec 12 22:57:59.301602 systemd[1]: Reached target Unmount All Filesystems. Dec 12 22:57:59.302373 systemd[1]: lvm2-activation.service: Deactivated successfully. Dec 12 22:57:59.302527 systemd[1]: Stopped Activation of LVM2 logical volumes. Dec 12 22:57:59.303337 systemd[1]: Stopped target Local Encrypted Volumes. Dec 12 22:57:59.304379 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 12 22:57:59.304531 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Dec 12 22:57:59.305502 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Dec 12 22:57:59.310540 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Dec 12 22:57:59.311855 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Dec 12 22:57:59.311998 systemd[1]: Stopped Activation of LVM2 logical volumes. Dec 12 22:57:59.312891 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 12 22:57:59.313025 systemd[1]: Stopped Create Static Device Nodes in /dev. Dec 12 22:57:59.313889 systemd[1]: systemd-sysusers.service: Deactivated successfully. Dec 12 22:57:59.314019 systemd[1]: Stopped Create System Users. Dec 12 22:57:59.314755 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Dec 12 22:57:59.314887 systemd[1]: Stopped Remount Root and Kernel File Systems. Dec 12 22:57:59.315826 systemd[1]: Reached target System Shutdown. Dec 12 22:57:59.316581 systemd[1]: Reached target Late Shutdown Services. Dec 12 22:57:59.317423 systemd[1]: systemd-reboot.service: Deactivated successfully. Dec 12 22:57:59.317557 systemd[1]: Finished System Reboot. Dec 12 22:57:59.318223 systemd[1]: Reached target System Reboot. Dec 12 22:57:59.318989 systemd[1]: Shutting down. Dec 12 22:57:59.319000 audit: BPF prog-id=53 op=UNLOAD Dec 12 22:57:59.319000 audit: BPF prog-id=52 op=UNLOAD Dec 12 22:57:59.319000 audit: BPF prog-id=51 op=UNLOAD Dec 12 22:57:59.322510 kernel: audit: type=1334 audit(1765580279.319:362): prog-id=53 op=UNLOAD Dec 12 22:57:59.321000 audit: BPF prog-id=57 op=UNLOAD Dec 12 22:57:59.321000 audit: BPF prog-id=56 op=UNLOAD Dec 12 22:57:59.321000 audit: BPF prog-id=55 op=UNLOAD Dec 12 22:57:59.323000 audit: BPF prog-id=60 op=UNLOAD Dec 12 22:57:59.323000 audit: BPF prog-id=59 op=UNLOAD Dec 12 22:57:59.365516 systemd-shutdown[1]: Syncing filesystems and block devices. Dec 12 22:57:59.370518 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Dec 12 22:57:59.372158 systemd-journald[801]: Journal stopped -- Reboot -- Dec 12 22:58:06.663577 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Dec 12 22:58:06.663592 kernel: Linux version 5.10.107-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo 9.3.0-r1 p3) 9.3.0, GNU ld (Gentoo 2.36.1 p5) 2.36.1) #1 SMP PREEMPT Tue Mar 22 19:39:09 -00 2022 Dec 12 22:58:06.663601 kernel: efi: EFI v2.70 by EDK II Dec 12 22:58:06.663606 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Dec 12 22:58:06.663611 kernel: efi: seeding entropy pool Dec 12 22:58:06.663616 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Dec 12 22:58:06.663622 kernel: ACPI: Early table checksum verification disabled Dec 12 22:58:06.663628 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Dec 12 22:58:06.663633 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Dec 12 22:58:06.663638 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:58:06.663644 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:58:06.663649 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:58:06.663654 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:58:06.663660 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:58:06.663666 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:58:06.663672 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:58:06.663678 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:58:06.663684 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 22:58:06.663689 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Dec 12 22:58:06.663694 kernel: ACPI: NUMA: Failed to initialise from firmware Dec 12 22:58:06.663700 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 22:58:06.663705 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Dec 12 22:58:06.663710 kernel: Zone ranges: Dec 12 22:58:06.663715 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 22:58:06.663722 kernel: DMA32 empty Dec 12 22:58:06.663727 kernel: Normal empty Dec 12 22:58:06.663733 kernel: Movable zone start for each node Dec 12 22:58:06.663739 kernel: Early memory node ranges Dec 12 22:58:06.663744 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Dec 12 22:58:06.663750 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Dec 12 22:58:06.663755 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Dec 12 22:58:06.663760 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Dec 12 22:58:06.663765 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Dec 12 22:58:06.663771 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Dec 12 22:58:06.663776 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Dec 12 22:58:06.663781 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Dec 12 22:58:06.663787 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Dec 12 22:58:06.663792 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Dec 12 22:58:06.663797 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Dec 12 22:58:06.663803 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 22:58:06.663811 kernel: On node 0 totalpages: 643072 Dec 12 22:58:06.663817 kernel: DMA zone: 10048 pages used for memmap Dec 12 22:58:06.663822 kernel: DMA zone: 0 pages reserved Dec 12 22:58:06.663828 kernel: DMA zone: 643072 pages, LIFO batch:63 Dec 12 22:58:06.663834 kernel: psci: probing for conduit method from ACPI. Dec 12 22:58:06.663839 kernel: psci: PSCIv1.1 detected in firmware. Dec 12 22:58:06.663845 kernel: psci: Using standard PSCI v0.2 function IDs Dec 12 22:58:06.663850 kernel: psci: Trusted OS migration not required Dec 12 22:58:06.663857 kernel: psci: SMC Calling Convention v1.1 Dec 12 22:58:06.663863 kernel: ACPI: SRAT not present Dec 12 22:58:06.663868 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Dec 12 22:58:06.663874 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Dec 12 22:58:06.663879 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 12 22:58:06.663885 kernel: Detected PIPT I-cache on CPU0 Dec 12 22:58:06.663891 kernel: CPU features: detected: GIC system register CPU interface Dec 12 22:58:06.663896 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 12 22:58:06.663902 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 12 22:58:06.663908 kernel: CPU features: detected: Hardware dirty bit management Dec 12 22:58:06.663913 kernel: CPU features: detected: Spectre-v4 Dec 12 22:58:06.663920 kernel: CPU features: detected: ARM erratum 1418040 Dec 12 22:58:06.663925 kernel: CPU features: detected: Spectre-BHB Dec 12 22:58:06.663931 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Dec 12 22:58:06.663936 kernel: Policy zone: DMA Dec 12 22:58:06.663943 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=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Dec 12 22:58:06.663949 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 12 22:58:06.663954 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 12 22:58:06.663960 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 12 22:58:06.663966 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Dec 12 22:58:06.663972 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Dec 12 22:58:06.663977 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 12 22:58:06.663984 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 12 22:58:06.663990 kernel: rcu: RCU event tracing is enabled. Dec 12 22:58:06.663996 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Dec 12 22:58:06.664002 kernel: Trampoline variant of Tasks RCU enabled. Dec 12 22:58:06.664007 kernel: Tracing variant of Tasks RCU enabled. Dec 12 22:58:06.664013 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 12 22:58:06.664019 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 12 22:58:06.664024 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 12 22:58:06.664030 kernel: GICv3: 256 SPIs implemented Dec 12 22:58:06.664035 kernel: GICv3: 0 Extended SPIs implemented Dec 12 22:58:06.664040 kernel: GICv3: Distributor has no Range Selector support Dec 12 22:58:06.664046 kernel: GICv3: 16 PPIs implemented Dec 12 22:58:06.664052 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Dec 12 22:58:06.664058 kernel: ACPI: SRAT not present Dec 12 22:58:06.664063 kernel: ITS [mem 0x08080000-0x0809ffff] Dec 12 22:58:06.664069 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Dec 12 22:58:06.664075 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Dec 12 22:58:06.664080 kernel: GICv3: using LPI property table @0x00000000400d0000 Dec 12 22:58:06.664086 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Dec 12 22:58:06.664091 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 22:58:06.664097 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Dec 12 22:58:06.664103 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Dec 12 22:58:06.664109 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Dec 12 22:58:06.664115 kernel: arm-pv: using stolen time PV Dec 12 22:58:06.664121 kernel: Console: colour dummy device 80x25 Dec 12 22:58:06.664127 kernel: ACPI: Core revision 20200925 Dec 12 22:58:06.664133 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Dec 12 22:58:06.664139 kernel: pid_max: default: 32768 minimum: 301 Dec 12 22:58:06.664145 kernel: LSM: Security Framework initializing Dec 12 22:58:06.664150 kernel: SELinux: Initializing. Dec 12 22:58:06.664156 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 12 22:58:06.664162 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 12 22:58:06.664168 kernel: rcu: Hierarchical SRCU implementation. Dec 12 22:58:06.664174 kernel: Platform MSI: ITS@0x8080000 domain created Dec 12 22:58:06.664180 kernel: PCI/MSI: ITS@0x8080000 domain created Dec 12 22:58:06.664186 kernel: Remapping and enabling EFI services. Dec 12 22:58:06.664192 kernel: smp: Bringing up secondary CPUs ... Dec 12 22:58:06.664197 kernel: Detected PIPT I-cache on CPU1 Dec 12 22:58:06.664203 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Dec 12 22:58:06.664209 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Dec 12 22:58:06.664215 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 22:58:06.664221 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Dec 12 22:58:06.664227 kernel: Detected PIPT I-cache on CPU2 Dec 12 22:58:06.664234 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Dec 12 22:58:06.664240 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Dec 12 22:58:06.664246 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 22:58:06.664252 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Dec 12 22:58:06.664258 kernel: Detected PIPT I-cache on CPU3 Dec 12 22:58:06.664268 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Dec 12 22:58:06.664274 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Dec 12 22:58:06.664281 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 22:58:06.664287 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Dec 12 22:58:06.664293 kernel: smp: Brought up 1 node, 4 CPUs Dec 12 22:58:06.664299 kernel: SMP: Total of 4 processors activated. Dec 12 22:58:06.664305 kernel: CPU features: detected: Privileged Access Never Dec 12 22:58:06.664311 kernel: CPU features: detected: LSE atomic instructions Dec 12 22:58:06.664317 kernel: CPU features: detected: User Access Override Dec 12 22:58:06.664323 kernel: CPU features: detected: 32-bit EL0 Support Dec 12 22:58:06.664329 kernel: CPU features: detected: Common not Private translations Dec 12 22:58:06.664335 kernel: CPU features: detected: RAS Extension Support Dec 12 22:58:06.664358 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 12 22:58:06.664365 kernel: CPU features: detected: CRC32 instructions Dec 12 22:58:06.664371 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 12 22:58:06.664377 kernel: CPU: All CPU(s) started at EL1 Dec 12 22:58:06.664383 kernel: alternatives: patching kernel code Dec 12 22:58:06.664391 kernel: devtmpfs: initialized Dec 12 22:58:06.664397 kernel: KASLR enabled Dec 12 22:58:06.664403 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 12 22:58:06.664412 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 12 22:58:06.664418 kernel: pinctrl core: initialized pinctrl subsystem Dec 12 22:58:06.664424 kernel: SMBIOS 3.0.0 present. Dec 12 22:58:06.664430 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Dec 12 22:58:06.664436 kernel: NET: Registered protocol family 16 Dec 12 22:58:06.664443 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 12 22:58:06.664449 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 12 22:58:06.664456 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 12 22:58:06.664462 kernel: audit: initializing netlink subsys (disabled) Dec 12 22:58:06.664469 kernel: audit: type=2000 audit(0.032:1): state=initialized audit_enabled=0 res=1 Dec 12 22:58:06.664475 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 12 22:58:06.664481 kernel: cpuidle: using governor menu Dec 12 22:58:06.664487 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 12 22:58:06.664493 kernel: ASID allocator initialised with 32768 entries Dec 12 22:58:06.664499 kernel: ACPI: bus type PCI registered Dec 12 22:58:06.664505 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 12 22:58:06.664512 kernel: Serial: AMBA PL011 UART driver Dec 12 22:58:06.664518 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Dec 12 22:58:06.664525 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Dec 12 22:58:06.664531 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Dec 12 22:58:06.664537 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Dec 12 22:58:06.664543 kernel: cryptd: max_cpu_qlen set to 1000 Dec 12 22:58:06.664549 kernel: ACPI: Added _OSI(Module Device) Dec 12 22:58:06.664556 kernel: ACPI: Added _OSI(Processor Device) Dec 12 22:58:06.664562 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Dec 12 22:58:06.664569 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 12 22:58:06.664575 kernel: ACPI: Added _OSI(Linux-Dell-Video) Dec 12 22:58:06.664581 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Dec 12 22:58:06.664587 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Dec 12 22:58:06.664593 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 12 22:58:06.664599 kernel: ACPI: Interpreter enabled Dec 12 22:58:06.664605 kernel: ACPI: Using GIC for interrupt routing Dec 12 22:58:06.664611 kernel: ACPI: MCFG table detected, 1 entries Dec 12 22:58:06.664617 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Dec 12 22:58:06.664623 kernel: printk: console [ttyAMA0] enabled Dec 12 22:58:06.664631 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Dec 12 22:58:06.664733 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 12 22:58:06.664792 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 12 22:58:06.664846 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 12 22:58:06.664898 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Dec 12 22:58:06.664950 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Dec 12 22:58:06.664958 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Dec 12 22:58:06.664966 kernel: PCI host bridge to bus 0000:00 Dec 12 22:58:06.665032 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Dec 12 22:58:06.665088 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 12 22:58:06.665140 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Dec 12 22:58:06.665192 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 12 22:58:06.665266 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Dec 12 22:58:06.665332 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Dec 12 22:58:06.665418 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Dec 12 22:58:06.665567 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Dec 12 22:58:06.665632 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Dec 12 22:58:06.665689 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Dec 12 22:58:06.665746 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Dec 12 22:58:06.665802 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Dec 12 22:58:06.665858 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Dec 12 22:58:06.665913 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 12 22:58:06.665963 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Dec 12 22:58:06.665971 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Dec 12 22:58:06.665978 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Dec 12 22:58:06.665984 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Dec 12 22:58:06.665990 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Dec 12 22:58:06.665996 kernel: vgaarb: loaded Dec 12 22:58:06.666002 kernel: Registered efivars operations Dec 12 22:58:06.666009 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 12 22:58:06.666016 kernel: VFS: Disk quotas dquot_6.6.0 Dec 12 22:58:06.666023 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 12 22:58:06.666029 kernel: pnp: PnP ACPI init Dec 12 22:58:06.666095 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Dec 12 22:58:06.666147 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Dec 12 22:58:06.666156 kernel: pnp: PnP ACPI: found 1 devices Dec 12 22:58:06.666162 kernel: NET: Registered protocol family 2 Dec 12 22:58:06.666168 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 12 22:58:06.666176 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 12 22:58:06.666183 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 12 22:58:06.666189 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Dec 12 22:58:06.666196 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 12 22:58:06.666202 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 12 22:58:06.666208 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 12 22:58:06.666214 kernel: NET: Registered protocol family 1 Dec 12 22:58:06.666220 kernel: PCI: CLS 0 bytes, default 64 Dec 12 22:58:06.666227 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Dec 12 22:58:06.666235 kernel: kvm [1]: HYP mode not available Dec 12 22:58:06.666241 kernel: Initialise system trusted keyrings Dec 12 22:58:06.666247 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 12 22:58:06.666253 kernel: Key type asymmetric registered Dec 12 22:58:06.666259 kernel: Asymmetric key parser 'x509' registered Dec 12 22:58:06.666265 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Dec 12 22:58:06.666271 kernel: io scheduler mq-deadline registered Dec 12 22:58:06.666277 kernel: io scheduler kyber registered Dec 12 22:58:06.666284 kernel: io scheduler bfq registered Dec 12 22:58:06.666291 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 12 22:58:06.666297 kernel: ACPI: Power Button [PWRB] Dec 12 22:58:06.666303 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Dec 12 22:58:06.666382 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Dec 12 22:58:06.666391 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 12 22:58:06.666398 kernel: msm_serial: driver initialized Dec 12 22:58:06.666404 kernel: random: fast init done Dec 12 22:58:06.666410 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Dec 12 22:58:06.666416 kernel: random: crng init done Dec 12 22:58:06.666423 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Dec 12 22:58:06.666431 kernel: thunder_xcv, ver 1.0 Dec 12 22:58:06.666437 kernel: thunder_bgx, ver 1.0 Dec 12 22:58:06.666443 kernel: nicpf, ver 1.0 Dec 12 22:58:06.666449 kernel: nicvf, ver 1.0 Dec 12 22:58:06.666515 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 12 22:58:06.666575 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-12-12T22:58:06 UTC (1765580286) Dec 12 22:58:06.666584 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 12 22:58:06.666590 kernel: NET: Registered protocol family 10 Dec 12 22:58:06.666598 kernel: Segment Routing with IPv6 Dec 12 22:58:06.666604 kernel: NET: Registered protocol family 17 Dec 12 22:58:06.666610 kernel: Key type dns_resolver registered Dec 12 22:58:06.666616 kernel: registered taskstats version 1 Dec 12 22:58:06.666623 kernel: Loading compiled-in X.509 certificates Dec 12 22:58:06.666629 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Dec 12 22:58:06.666636 kernel: Key type ._fscrypt registered Dec 12 22:58:06.666642 kernel: Key type .fscrypt registered Dec 12 22:58:06.666648 kernel: Key type fscrypt-provisioning registered Dec 12 22:58:06.666655 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 12 22:58:06.666661 kernel: ima: Allocated hash algorithm: sha1 Dec 12 22:58:06.666667 kernel: ima: No architecture policies found Dec 12 22:58:06.666674 kernel: Freeing unused kernel memory: 34240K Dec 12 22:58:06.666680 kernel: Run /init as init process Dec 12 22:58:06.666686 kernel: with arguments: Dec 12 22:58:06.666692 kernel: /init Dec 12 22:58:06.666698 kernel: with environment: Dec 12 22:58:06.666704 kernel: HOME=/ Dec 12 22:58:06.666709 kernel: TERM=linux Dec 12 22:58:06.666717 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Dec 12 22:58:06.666725 systemd[1]: systemd 249 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 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Dec 12 22:58:06.666733 systemd[1]: Detected virtualization kvm. Dec 12 22:58:06.666740 systemd[1]: Detected architecture arm64. Dec 12 22:58:06.666746 systemd[1]: Running in initial RAM disk. Dec 12 22:58:06.666753 systemd[1]: No hostname configured, using default hostname. Dec 12 22:58:06.666759 systemd[1]: Hostname set to . Dec 12 22:58:06.666767 systemd[1]: Initializing machine ID from VM UUID. Dec 12 22:58:06.666774 systemd[1]: Queued start job for default target Initrd Default Target. Dec 12 22:58:06.666781 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Dec 12 22:58:06.666787 systemd[1]: Reached target Local Encrypted Volumes. Dec 12 22:58:06.666794 systemd[1]: Reached target Path Units. Dec 12 22:58:06.666800 systemd[1]: Reached target Slice Units. Dec 12 22:58:06.666807 systemd[1]: Reached target Swaps. Dec 12 22:58:06.666813 systemd[1]: Reached target Timer Units. Dec 12 22:58:06.666821 systemd[1]: Listening on Open-iSCSI iscsid Socket. Dec 12 22:58:06.666828 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Dec 12 22:58:06.666834 systemd[1]: Listening on Journal Audit Socket. Dec 12 22:58:06.666841 systemd[1]: Listening on Journal Socket (/dev/log). Dec 12 22:58:06.666848 systemd[1]: Listening on Journal Socket. Dec 12 22:58:06.666854 systemd[1]: Listening on udev Control Socket. Dec 12 22:58:06.666861 systemd[1]: Listening on udev Kernel Socket. Dec 12 22:58:06.666867 systemd[1]: Reached target Socket Units. Dec 12 22:58:06.666874 systemd[1]: Starting iSCSI UserSpace I/O driver... Dec 12 22:58:06.666882 systemd[1]: Starting Create List of Static Device Nodes... Dec 12 22:58:06.666888 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Dec 12 22:58:06.666895 systemd[1]: Starting Journal Service... Dec 12 22:58:06.666901 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Dec 12 22:58:06.666908 systemd[1]: Starting Apply Kernel Variables... Dec 12 22:58:06.666915 systemd[1]: Starting Setup Virtual Console... Dec 12 22:58:06.666921 systemd[1]: Started iSCSI UserSpace I/O driver. Dec 12 22:58:06.666928 systemd[1]: Finished Create List of Static Device Nodes. Dec 12 22:58:06.666934 kernel: SCSI subsystem initialized Dec 12 22:58:06.666941 systemd[1]: Finished Apply Kernel Variables. Dec 12 22:58:06.666949 systemd[1]: Starting Create Static Device Nodes in /dev... Dec 12 22:58:06.666955 kernel: Loading iSCSI transport class v2.0-870. Dec 12 22:58:06.666964 systemd-journald[268]: Journal started Dec 12 22:58:06.667018 systemd-journald[268]: Runtime Journal (/run/log/journal/3e1e88a1781049e89741dc5a5e75921b) is 6.0M, max 48.5M, 42.4M free. Dec 12 22:58:06.669392 systemd[1]: Started Journal Service. Dec 12 22:58:06.669016 systemd[1]: Finished Setup Virtual Console. Dec 12 22:58:06.669821 systemd[1]: Finished Create Static Device Nodes in /dev. Dec 12 22:58:06.671518 systemd[1]: Starting dracut ask for additional cmdline parameters... Dec 12 22:58:06.686359 systemd[1]: Finished dracut ask for additional cmdline parameters. Dec 12 22:58:06.687813 systemd[1]: Starting dracut cmdline hook... Dec 12 22:58:06.696551 dracut-cmdline[290]: dracut-dracut-053 Dec 12 22:58:06.699344 dracut-cmdline[290]: 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=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Dec 12 22:58:06.759394 kernel: iscsi: registered transport (tcp) Dec 12 22:58:06.771368 kernel: iscsi: registered transport (qla4xxx) Dec 12 22:58:06.771389 kernel: QLogic iSCSI HBA Driver Dec 12 22:58:06.780337 systemd[1]: Finished dracut cmdline hook. Dec 12 22:58:06.781767 systemd[1]: Starting dracut pre-udev hook... Dec 12 22:58:06.782903 systemd[1]: Starting Open-iSCSI... Dec 12 22:58:06.785244 iscsid[376]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Dec 12 22:58:06.785244 iscsid[376]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Dec 12 22:58:06.785244 iscsid[376]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Dec 12 22:58:06.785244 iscsid[376]: If using hardware iscsi like qla4xxx this message can be ignored. Dec 12 22:58:06.785244 iscsid[376]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Dec 12 22:58:06.785244 iscsid[376]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Dec 12 22:58:06.788724 systemd[1]: Started Open-iSCSI. Dec 12 22:58:06.797738 kernel: device-mapper: uevent: version 1.0.3 Dec 12 22:58:06.797759 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Dec 12 22:58:06.832374 kernel: raid6: neonx8 gen() 13806 MB/s Dec 12 22:58:06.849370 kernel: raid6: neonx8 xor() 10771 MB/s Dec 12 22:58:06.866380 kernel: raid6: neonx4 gen() 13691 MB/s Dec 12 22:58:06.883375 kernel: raid6: neonx4 xor() 11588 MB/s Dec 12 22:58:06.900375 kernel: raid6: neonx2 gen() 13016 MB/s Dec 12 22:58:06.917371 kernel: raid6: neonx2 xor() 9892 MB/s Dec 12 22:58:06.934372 kernel: raid6: neonx1 gen() 10705 MB/s Dec 12 22:58:06.951390 kernel: raid6: neonx1 xor() 8860 MB/s Dec 12 22:58:06.968395 kernel: raid6: int64x8 gen() 6829 MB/s Dec 12 22:58:06.985387 kernel: raid6: int64x8 xor() 3799 MB/s Dec 12 22:58:07.002385 kernel: raid6: int64x4 gen() 6908 MB/s Dec 12 22:58:07.019385 kernel: raid6: int64x4 xor() 3835 MB/s Dec 12 22:58:07.036394 kernel: raid6: int64x2 gen() 6187 MB/s Dec 12 22:58:07.053397 kernel: raid6: int64x2 xor() 3317 MB/s Dec 12 22:58:07.070395 kernel: raid6: int64x1 gen() 5015 MB/s Dec 12 22:58:07.087828 kernel: raid6: int64x1 xor() 2596 MB/s Dec 12 22:58:07.087881 kernel: raid6: using algorithm neonx8 gen() 13806 MB/s Dec 12 22:58:07.087891 kernel: raid6: .... xor() 10771 MB/s, rmw enabled Dec 12 22:58:07.087899 kernel: raid6: using neon recovery algorithm Dec 12 22:58:07.098738 kernel: xor: measuring software checksum speed Dec 12 22:58:07.098782 kernel: 8regs : 17152 MB/sec Dec 12 22:58:07.099639 kernel: 32regs : 20770 MB/sec Dec 12 22:58:07.100433 kernel: arm64_neon : 28895 MB/sec Dec 12 22:58:07.100448 kernel: xor: using function: arm64_neon (28895 MB/sec) Dec 12 22:58:07.145400 kernel: Btrfs loaded, crc32c=crc32c-generic Dec 12 22:58:07.155281 systemd[1]: Finished dracut pre-udev hook. Dec 12 22:58:07.157374 kernel: audit: type=1334 audit(1765580287.156:2): prog-id=6 op=LOAD Dec 12 22:58:07.157406 kernel: audit: type=1334 audit(1765580287.156:3): prog-id=7 op=LOAD Dec 12 22:58:07.157416 kernel: audit: type=1334 audit(1765580287.156:4): prog-id=8 op=LOAD Dec 12 22:58:07.156000 audit: BPF prog-id=6 op=LOAD Dec 12 22:58:07.156000 audit: BPF prog-id=7 op=LOAD Dec 12 22:58:07.156000 audit: BPF prog-id=8 op=LOAD Dec 12 22:58:07.157078 systemd[1]: Starting Rule-based Manager for Device Events and Files... Dec 12 22:58:07.169565 systemd-udevd[409]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Dec 12 22:58:07.171322 systemd[1]: Started Rule-based Manager for Device Events and Files. Dec 12 22:58:07.173423 systemd[1]: Starting dracut pre-trigger hook... Dec 12 22:58:07.185036 dracut-pre-trigger[417]: rd.md=0: removing MD RAID activation Dec 12 22:58:07.211779 systemd[1]: Finished dracut pre-trigger hook. Dec 12 22:58:07.213137 systemd[1]: Starting Coldplug All udev Devices... Dec 12 22:58:07.223200 systemd-udevd[409]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Dec 12 22:58:07.244284 systemd[1]: Finished Coldplug All udev Devices. Dec 12 22:58:07.245863 systemd[1]: Starting dracut initqueue hook... Dec 12 22:58:07.259956 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Dec 12 22:58:07.260082 kernel: vda: detected capacity change from 0 to 4756340736 Dec 12 22:58:07.276938 systemd-udevd[460]: Using default interface naming scheme 'v249'. Dec 12 22:58:07.286364 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 12 22:58:07.307055 systemd[1]: Found device /dev/disk/by-label/ROOT. Dec 12 22:58:07.312369 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (469) Dec 12 22:58:07.316469 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Dec 12 22:58:07.317330 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Dec 12 22:58:07.318963 systemd[1]: Reached target Initrd Root Device. Dec 12 22:58:07.320785 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Dec 12 22:58:07.323661 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 12 22:58:07.323779 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Dec 12 22:58:07.325247 systemd[1]: Reached target Preparation for Local File Systems. Dec 12 22:58:07.327223 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Dec 12 22:58:07.330753 systemd[1]: Finished dracut initqueue hook. Dec 12 22:58:07.331459 systemd[1]: Reached target Preparation for Remote File Systems. Dec 12 22:58:07.332934 systemd[1]: Reached target Remote Encrypted Volumes. Dec 12 22:58:07.334227 systemd[1]: Reached target Remote File Systems. Dec 12 22:58:07.336098 systemd[1]: Starting dracut pre-mount hook... Dec 12 22:58:07.344424 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Dec 12 22:58:07.349190 systemd[1]: Finished dracut pre-mount hook. Dec 12 22:58:07.350535 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Dec 12 22:58:07.360008 systemd-fsck[506]: ROOT: clean, 640/553792 files, 39961/553472 blocks Dec 12 22:58:07.362858 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Dec 12 22:58:07.364503 systemd[1]: Mounting /sysroot... Dec 12 22:58:07.367132 systemd[1]: Found device /dev/mapper/usr. Dec 12 22:58:07.369397 systemd[1]: Starting File System Check on /dev/mapper/usr... Dec 12 22:58:07.372585 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Dec 12 22:58:07.379252 systemd-fsck[515]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Dec 12 22:58:07.379252 systemd-fsck[515]: You must have r/w access to the filesystem or be root Dec 12 22:58:07.380987 systemd-fsck[512]: fsck failed with exit status 8. Dec 12 22:58:07.380990 systemd-fsck[512]: Ignoring error. Dec 12 22:58:07.381639 systemd[1]: Finished File System Check on /dev/mapper/usr. Dec 12 22:58:07.383620 systemd[1]: Mounting /sysusr/usr... Dec 12 22:58:07.403643 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Dec 12 22:58:07.403683 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Dec 12 22:58:07.404527 systemd[1]: Mounted /sysroot. Dec 12 22:58:07.405099 systemd[1]: Reached target Initrd Root File System. Dec 12 22:58:07.406665 systemd[1]: Starting Reload Configuration from the Real Root... Dec 12 22:58:07.411011 systemd[1]: Reloading. Dec 12 22:58:07.411768 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Dec 12 22:58:07.412000 audit: BPF prog-id=3 op=UNLOAD Dec 12 22:58:07.414364 kernel: audit: type=1334 audit(1765580287.412:5): prog-id=3 op=UNLOAD Dec 12 22:58:07.414000 audit: BPF prog-id=6 op=UNLOAD Dec 12 22:58:07.416384 kernel: audit: type=1334 audit(1765580287.414:6): prog-id=6 op=UNLOAD Dec 12 22:58:07.493000 audit: BPF prog-id=9 op=LOAD Dec 12 22:58:07.493000 audit: BPF prog-id=10 op=LOAD Dec 12 22:58:07.494865 kernel: audit: type=1334 audit(1765580287.493:7): prog-id=9 op=LOAD Dec 12 22:58:07.494887 kernel: audit: type=1334 audit(1765580287.493:8): prog-id=10 op=LOAD Dec 12 22:58:07.494896 kernel: audit: type=1334 audit(1765580287.494:9): prog-id=11 op=LOAD Dec 12 22:58:07.494000 audit: BPF prog-id=11 op=LOAD Dec 12 22:58:07.495518 kernel: audit: type=1334 audit(1765580287.494:10): prog-id=4 op=UNLOAD Dec 12 22:58:07.494000 audit: BPF prog-id=4 op=UNLOAD Dec 12 22:58:07.494000 audit: BPF prog-id=5 op=UNLOAD Dec 12 22:58:07.495000 audit: BPF prog-id=12 op=LOAD Dec 12 22:58:07.495000 audit: BPF prog-id=13 op=LOAD Dec 12 22:58:07.495000 audit: BPF prog-id=14 op=LOAD Dec 12 22:58:07.495000 audit: BPF prog-id=7 op=UNLOAD Dec 12 22:58:07.495000 audit: BPF prog-id=8 op=UNLOAD Dec 12 22:58:07.497388 systemd[1]: Mounted /sysusr/usr. Dec 12 22:58:07.499321 systemd[1]: Reached target Local File Systems. Dec 12 22:58:07.499994 systemd[1]: Reached target System Initialization. Dec 12 22:58:07.501137 systemd[1]: Reached target Basic System. Dec 12 22:58:07.503463 systemd[1]: Mounting /sysroot/usr... Dec 12 22:58:07.505787 systemd[1]: Mounted /sysroot/usr. Dec 12 22:58:07.514542 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 12 22:58:07.514672 systemd[1]: Finished Reload Configuration from the Real Root. Dec 12 22:58:07.516214 systemd[1]: Reached target Initrd File Systems. Dec 12 22:58:07.517381 systemd[1]: Reached target Initrd Default Target. Dec 12 22:58:07.518591 systemd[1]: Condition check resulted in dracut mount hook being skipped. Dec 12 22:58:07.519240 systemd[1]: Starting dracut pre-pivot and cleanup hook... Dec 12 22:58:07.529464 systemd[1]: Finished dracut pre-pivot and cleanup hook. Dec 12 22:58:07.531025 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Dec 12 22:58:07.536883 systemd[1]: Stopped target Remote Encrypted Volumes. Dec 12 22:58:07.537756 systemd[1]: Stopped target Timer Units. Dec 12 22:58:07.538945 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 12 22:58:07.539057 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Dec 12 22:58:07.540218 systemd[1]: Stopped target Initrd Default Target. Dec 12 22:58:07.541490 systemd[1]: Stopped target Basic System. Dec 12 22:58:07.542629 systemd[1]: Stopped target Initrd Root Device. Dec 12 22:58:07.543753 systemd[1]: Stopped target Path Units. Dec 12 22:58:07.544799 systemd[1]: Stopped target Remote File Systems. Dec 12 22:58:07.545953 systemd[1]: Stopped target Preparation for Remote File Systems. Dec 12 22:58:07.547215 systemd[1]: Stopped target Slice Units. Dec 12 22:58:07.548304 systemd[1]: Stopped target Socket Units. Dec 12 22:58:07.549572 systemd[1]: Stopped target System Initialization. Dec 12 22:58:07.550676 systemd[1]: Stopped target Local File Systems. Dec 12 22:58:07.551729 systemd[1]: Stopped target Preparation for Local File Systems. Dec 12 22:58:07.552999 systemd[1]: Stopped target Swaps. Dec 12 22:58:07.553958 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 12 22:58:07.554071 systemd[1]: Stopped dracut pre-mount hook. Dec 12 22:58:07.555217 systemd[1]: Stopped target Local Encrypted Volumes. Dec 12 22:58:07.556183 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 12 22:58:07.559417 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Dec 12 22:58:07.560312 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 12 22:58:07.560449 systemd[1]: Stopped dracut initqueue hook. Dec 12 22:58:07.564918 iscsid[376]: iscsid shutting down. Dec 12 22:58:07.561868 systemd[1]: Stopping Open-iSCSI... Dec 12 22:58:07.564387 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 12 22:58:07.564504 systemd[1]: Stopped Apply Kernel Variables. Dec 12 22:58:07.565575 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 12 22:58:07.565659 systemd[1]: Stopped Coldplug All udev Devices. Dec 12 22:58:07.566649 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 12 22:58:07.566734 systemd[1]: Stopped dracut pre-trigger hook. Dec 12 22:58:07.567782 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Dec 12 22:58:07.572057 systemd[1]: iscsid.service: Deactivated successfully. Dec 12 22:58:07.572177 systemd[1]: Stopped Open-iSCSI. Dec 12 22:58:07.573197 systemd[1]: iscsid.socket: Deactivated successfully. Dec 12 22:58:07.573255 systemd[1]: Closed Open-iSCSI iscsid Socket. Dec 12 22:58:07.574049 systemd[1]: Stopping iSCSI UserSpace I/O driver... Dec 12 22:58:07.576665 systemd[1]: iscsiuio.service: Deactivated successfully. Dec 12 22:58:07.576776 systemd[1]: Stopped iSCSI UserSpace I/O driver. Dec 12 22:58:07.577711 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 12 22:58:07.577823 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Dec 12 22:58:07.579597 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 12 22:58:07.579703 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Dec 12 22:58:07.590000 audit: BPF prog-id=12 op=UNLOAD Dec 12 22:58:07.581395 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 12 22:58:07.581447 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Dec 12 22:58:07.582503 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 12 22:58:07.582542 systemd[1]: Closed udev Control Socket. Dec 12 22:58:07.583636 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 12 22:58:07.583668 systemd[1]: Closed udev Kernel Socket. Dec 12 22:58:07.584703 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 12 22:58:07.584744 systemd[1]: Stopped dracut pre-udev hook. Dec 12 22:58:07.585886 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 12 22:58:07.585922 systemd[1]: Stopped dracut cmdline hook. Dec 12 22:58:07.587016 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 12 22:58:07.587051 systemd[1]: Stopped dracut ask for additional cmdline parameters. Dec 12 22:58:07.589043 systemd[1]: Starting Cleanup udev Database... Dec 12 22:58:07.589746 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Dec 12 22:58:07.591143 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 12 22:58:07.591198 systemd[1]: Stopped Create Static Device Nodes in /dev. Dec 12 22:58:07.606000 audit: BPF prog-id=9 op=UNLOAD Dec 12 22:58:07.592471 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 12 22:58:07.592512 systemd[1]: Stopped Create List of Static Device Nodes. Dec 12 22:58:07.593713 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 12 22:58:07.593750 systemd[1]: Stopped Setup Virtual Console. Dec 12 22:58:07.595015 systemd[1]: rngd.service: Deactivated successfully. Dec 12 22:58:07.595119 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Dec 12 22:58:07.596279 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 12 22:58:07.596405 systemd[1]: Finished Cleanup udev Database. Dec 12 22:58:07.597248 systemd[1]: Reached target Switch Root. Dec 12 22:58:07.598979 systemd[1]: Starting Switch Root... Dec 12 22:58:07.606051 systemd[1]: Switching root. Dec 12 22:58:07.620597 systemd-journald[268]: Journal stopped Dec 12 22:58:09.661886 systemd-journald[268]: Received SIGTERM from PID 1 (systemd). Dec 12 22:58:09.661934 kernel: SELinux: policy capability network_peer_controls=1 Dec 12 22:58:09.661946 kernel: SELinux: policy capability open_perms=1 Dec 12 22:58:09.661958 kernel: SELinux: policy capability extended_socket_class=1 Dec 12 22:58:09.661969 kernel: SELinux: policy capability always_check_network=0 Dec 12 22:58:09.661978 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 12 22:58:09.661987 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 12 22:58:09.661996 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 12 22:58:09.662005 systemd[1]: Successfully loaded SELinux policy in 35.620ms. Dec 12 22:58:09.662019 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.453ms. Dec 12 22:58:09.662035 systemd[1]: systemd 249 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 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Dec 12 22:58:09.662047 systemd[1]: Detected virtualization kvm. Dec 12 22:58:09.662058 systemd[1]: Detected architecture arm64. Dec 12 22:58:09.662071 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Dec 12 22:58:09.662084 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Dec 12 22:58:09.662095 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 12 22:58:09.662105 systemd[1]: Stopped Switch Root. Dec 12 22:58:09.662114 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 12 22:58:09.662126 systemd[1]: Created slice Slice /system/addon-config. Dec 12 22:58:09.662136 systemd[1]: Created slice Slice /system/addon-run. Dec 12 22:58:09.662146 systemd[1]: Created slice Slice /system/getty. Dec 12 22:58:09.662164 systemd[1]: Created slice Slice /system/modprobe. Dec 12 22:58:09.662177 systemd[1]: Created slice Slice /system/serial-getty. Dec 12 22:58:09.662187 systemd[1]: Created slice Slice /system/system-cloudinit. Dec 12 22:58:09.662206 systemd[1]: Created slice Slice /system/systemd-fsck. Dec 12 22:58:09.662216 systemd[1]: Created slice User and Session Slice. Dec 12 22:58:09.662225 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Dec 12 22:58:09.662235 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Dec 12 22:58:09.662245 systemd[1]: Set up automount Boot partition Automount Point. Dec 12 22:58:09.662255 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Dec 12 22:58:09.662267 systemd[1]: Stopped target Switch Root. Dec 12 22:58:09.662276 systemd[1]: Stopped target Initrd File Systems. Dec 12 22:58:09.662310 systemd[1]: Stopped target Initrd Root File System. Dec 12 22:58:09.662334 systemd[1]: Reached target Remote Encrypted Volumes. Dec 12 22:58:09.662347 systemd[1]: Reached target Remote File Systems. Dec 12 22:58:09.662385 systemd[1]: Reached target Slice Units. Dec 12 22:58:09.662396 systemd[1]: Reached target Swaps. Dec 12 22:58:09.662405 systemd[1]: Reached target Verify torcx succeeded. Dec 12 22:58:09.662416 systemd[1]: Reached target Local Verity Protected Volumes. Dec 12 22:58:09.662426 systemd[1]: Listening on Process Core Dump Socket. Dec 12 22:58:09.662439 systemd[1]: Listening on initctl Compatibility Named Pipe. Dec 12 22:58:09.662449 systemd[1]: Listening on Network Service Netlink Socket. Dec 12 22:58:09.662459 systemd[1]: Listening on udev Control Socket. Dec 12 22:58:09.662469 systemd[1]: Listening on udev Kernel Socket. Dec 12 22:58:09.662479 systemd[1]: Mounting Huge Pages File System... Dec 12 22:58:09.662489 systemd[1]: Mounting POSIX Message Queue File System... Dec 12 22:58:09.662499 systemd[1]: Mounting External Media Directory... Dec 12 22:58:09.662509 systemd[1]: Mounting Kernel Debug File System... Dec 12 22:58:09.662519 systemd[1]: Mounting Kernel Trace File System... Dec 12 22:58:09.662529 systemd[1]: Mounting Temporary Directory /tmp... Dec 12 22:58:09.662540 systemd[1]: Starting Create missing system files... Dec 12 22:58:09.662550 systemd[1]: Starting Create List of Static Device Nodes... Dec 12 22:58:09.662560 systemd[1]: Starting Load Kernel Module configfs... Dec 12 22:58:09.662570 systemd[1]: Starting Load Kernel Module drm... Dec 12 22:58:09.662579 systemd[1]: Starting Load Kernel Module fuse... Dec 12 22:58:09.662589 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Dec 12 22:58:09.662599 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 12 22:58:09.662608 systemd[1]: Stopped File System Check on Root Device. Dec 12 22:58:09.662618 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 12 22:58:09.662629 systemd[1]: Stopped systemd-fsck-usr.service. Dec 12 22:58:09.662639 systemd[1]: Stopped Journal Service. Dec 12 22:58:09.662649 kernel: fuse: init (API version 7.32) Dec 12 22:58:09.662658 systemd[1]: Starting Journal Service... Dec 12 22:58:09.662668 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Dec 12 22:58:09.662678 systemd[1]: Starting Remount Root and Kernel File Systems... Dec 12 22:58:09.662688 systemd[1]: Starting Apply Kernel Variables... Dec 12 22:58:09.662698 systemd[1]: Starting Coldplug All udev Devices... Dec 12 22:58:09.662707 systemd[1]: verity-setup.service: Deactivated successfully. Dec 12 22:58:09.662717 systemd[1]: Stopped verity-setup.service. Dec 12 22:58:09.662728 systemd[1]: Mounted Huge Pages File System. Dec 12 22:58:09.662739 systemd-journald[693]: Journal started Dec 12 22:58:09.662781 systemd-journald[693]: Runtime Journal (/run/log/journal/3e1e88a1781049e89741dc5a5e75921b) is 6.0M, max 48.5M, 42.4M free. Dec 12 22:58:07.695000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 12 22:58:07.722000 audit[1]: AVC avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Dec 12 22:58:07.722000 audit[1]: AVC avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Dec 12 22:58:07.722000 audit: BPF prog-id=15 op=LOAD Dec 12 22:58:07.722000 audit: BPF prog-id=15 op=UNLOAD Dec 12 22:58:07.722000 audit: BPF prog-id=16 op=LOAD Dec 12 22:58:07.722000 audit: BPF prog-id=16 op=UNLOAD Dec 12 22:58:07.759000 audit[645]: AVC avc: denied { associate } for pid=645 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Dec 12 22:58:09.560000 audit: BPF prog-id=17 op=LOAD Dec 12 22:58:09.560000 audit: BPF prog-id=18 op=LOAD Dec 12 22:58:09.560000 audit: BPF prog-id=19 op=LOAD Dec 12 22:58:09.560000 audit: BPF prog-id=10 op=UNLOAD Dec 12 22:58:09.560000 audit: BPF prog-id=11 op=UNLOAD Dec 12 22:58:09.574000 audit: BPF prog-id=17 op=UNLOAD Dec 12 22:58:09.648000 audit: BPF prog-id=20 op=LOAD Dec 12 22:58:09.648000 audit: BPF prog-id=21 op=LOAD Dec 12 22:58:09.648000 audit: BPF prog-id=22 op=LOAD Dec 12 22:58:09.648000 audit: BPF prog-id=18 op=UNLOAD Dec 12 22:58:09.648000 audit: BPF prog-id=19 op=UNLOAD Dec 12 22:58:09.660000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Dec 12 22:58:09.549376 systemd[1]: Queued start job for default target Multi-User System. Dec 12 22:58:07.757792 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3033.2.4 /usr/share/oem/torcx/store /var/lib/torcx/store/3033.2.4 /var/lib/torcx/store]" Dec 12 22:58:09.561267 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 12 22:58:07.758069 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 12 22:58:07.758087 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 12 22:58:07.758405 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Dec 12 22:58:07.758418 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=debug msg="skipped missing lower profile" missing profile=oem Dec 12 22:58:07.758463 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Dec 12 22:58:07.758486 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Dec 12 22:58:07.758826 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Dec 12 22:58:07.758863 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 12 22:58:07.758878 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 12 22:58:07.759222 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Dec 12 22:58:07.759254 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Dec 12 22:58:07.759273 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3033.2.4: no such file or directory" path=/usr/share/oem/torcx/store/3033.2.4 Dec 12 22:58:07.759289 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Dec 12 22:58:07.759396 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3033.2.4: no such file or directory" path=/var/lib/torcx/store/3033.2.4 Dec 12 22:58:09.664371 systemd[1]: Started Journal Service. Dec 12 22:58:07.759415 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:07Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Dec 12 22:58:09.465452 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:09Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 12 22:58:09.465718 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:09Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 12 22:58:09.465819 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:09Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 12 22:58:09.465949 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:09Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 12 22:58:09.466041 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:09Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Dec 12 22:58:09.466102 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T22:58:09Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Dec 12 22:58:09.665268 systemd[1]: Mounted POSIX Message Queue File System. Dec 12 22:58:09.666142 systemd[1]: Mounted External Media Directory. Dec 12 22:58:09.666961 systemd[1]: Mounted Kernel Debug File System. Dec 12 22:58:09.667733 systemd[1]: Mounted Kernel Trace File System. Dec 12 22:58:09.668479 systemd[1]: Mounted Temporary Directory /tmp. Dec 12 22:58:09.669464 systemd[1]: Finished Create missing system files. Dec 12 22:58:09.670518 systemd[1]: Finished Create List of Static Device Nodes. Dec 12 22:58:09.671511 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 12 22:58:09.671683 systemd[1]: Finished Load Kernel Module configfs. Dec 12 22:58:09.672605 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 12 22:58:09.672778 systemd[1]: Finished Load Kernel Module drm. Dec 12 22:58:09.673642 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 12 22:58:09.673813 systemd[1]: Finished Load Kernel Module fuse. Dec 12 22:58:09.674778 systemd[1]: Finished Remount Root and Kernel File Systems. Dec 12 22:58:09.685870 systemd[1]: Finished Apply Kernel Variables. Dec 12 22:58:09.688661 systemd[1]: Mounting FUSE Control File System... Dec 12 22:58:09.690226 systemd[1]: Mounting Kernel Configuration File System... Dec 12 22:58:09.690983 systemd[1]: Condition check resulted in Remount Root File System being skipped. Dec 12 22:58:09.691870 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Dec 12 22:58:09.692808 systemd[1]: Starting Flush Journal to Persistent Storage... Dec 12 22:58:09.693829 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Dec 12 22:58:09.694744 systemd[1]: Starting Load/Save Random Seed... Dec 12 22:58:09.698142 systemd-journald[693]: Time spent on flushing to /var/log/journal/3e1e88a1781049e89741dc5a5e75921b is 12.213ms for 654 entries. Dec 12 22:58:09.698142 systemd-journald[693]: System Journal (/var/log/journal/3e1e88a1781049e89741dc5a5e75921b) is 8.0M, max 203.0M, 195.0M free. Dec 12 22:58:09.721000 audit: BPF prog-id=23 op=LOAD Dec 12 22:58:09.721000 audit: BPF prog-id=24 op=LOAD Dec 12 22:58:09.721000 audit: BPF prog-id=25 op=LOAD Dec 12 22:58:09.721000 audit: BPF prog-id=13 op=UNLOAD Dec 12 22:58:09.721000 audit: BPF prog-id=14 op=UNLOAD Dec 12 22:58:09.695504 systemd[1]: Condition check resulted in Create System Users being skipped. Dec 12 22:58:09.696464 systemd[1]: Starting Create Static Device Nodes in /dev... Dec 12 22:58:09.698051 systemd[1]: Mounted FUSE Control File System. Dec 12 22:58:09.699817 systemd[1]: Mounted Kernel Configuration File System. Dec 12 22:58:09.703394 systemd[1]: Finished Load/Save Random Seed. Dec 12 22:58:09.704624 systemd[1]: Condition check resulted in First Boot Complete being skipped. Dec 12 22:58:09.707629 systemd[1]: Finished Coldplug All udev Devices. Dec 12 22:58:09.718566 systemd[1]: Starting Wait for udev To Complete Device Initialization... Dec 12 22:58:09.719787 systemd[1]: Finished Create Static Device Nodes in /dev. Dec 12 22:58:09.722114 systemd[1]: Starting Rule-based Manager for Device Events and Files... Dec 12 22:58:09.723506 systemd[1]: Finished Flush Journal to Persistent Storage. Dec 12 22:58:09.744686 systemd[1]: Started Rule-based Manager for Device Events and Files. Dec 12 22:58:09.754538 systemd[1]: Starting Network Configuration... Dec 12 22:58:09.753000 audit: BPF prog-id=26 op=LOAD Dec 12 22:58:09.783865 systemd-networkd[726]: lo: Link UP Dec 12 22:58:09.783873 systemd-networkd[726]: lo: Gained carrier Dec 12 22:58:09.784177 systemd-networkd[726]: Enumeration completed Dec 12 22:58:09.784274 systemd[1]: Started Network Configuration. Dec 12 22:58:09.785954 systemd-udevd[723]: Using default interface naming scheme 'v249'. Dec 12 22:58:09.811495 udevadm[706]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Dec 12 22:58:09.820854 systemd-networkd[726]: eth0: Link UP Dec 12 22:58:09.833411 systemd-networkd[726]: eth0: Gained carrier Dec 12 22:58:09.840544 systemd[1]: Finished Wait for udev To Complete Device Initialization. Dec 12 22:58:09.845485 systemd-networkd[726]: eth0: DHCPv4 address 10.0.0.8/16 via 10.0.0.1 Dec 12 22:58:09.853246 systemd[1]: Starting Activation of LVM2 logical volumes... Dec 12 22:58:09.861468 lvm[734]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 12 22:58:09.888318 systemd[1]: Finished Activation of LVM2 logical volumes. Dec 12 22:58:09.889198 systemd[1]: Reached target Local Encrypted Volumes. Dec 12 22:58:09.898339 systemd[1]: Starting Activation of LVM2 logical volumes... Dec 12 22:58:09.901806 lvm[735]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 12 22:58:09.925416 systemd[1]: Finished Activation of LVM2 logical volumes. Dec 12 22:58:09.926260 systemd[1]: Reached target Preparation for Local File Systems. Dec 12 22:58:09.927161 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Dec 12 22:58:09.927188 systemd[1]: Reached target Containers. Dec 12 22:58:09.940616 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Dec 12 22:58:09.952553 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Dec 12 22:58:09.966239 systemd[1]: Mounting /usr/share/oem... Dec 12 22:58:09.972362 kernel: BTRFS info (device vda6): disk space caching is enabled Dec 12 22:58:09.972421 kernel: BTRFS info (device vda6): has skinny extents Dec 12 22:58:09.975097 systemd[1]: Mounted /usr/share/oem. Dec 12 22:58:09.975812 systemd[1]: Reached target Local File Systems. Dec 12 22:58:09.976545 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Dec 12 22:58:09.976942 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Dec 12 22:58:09.976980 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Dec 12 22:58:09.977009 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Dec 12 22:58:09.977970 systemd[1]: Starting Create Volatile Files and Directories... Dec 12 22:58:09.983873 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Dec 12 22:58:09.984894 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Dec 12 22:58:10.012494 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Dec 12 22:58:10.012505 systemd-tmpfiles[758]: Skipping /boot Dec 12 22:58:10.017981 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Dec 12 22:58:10.017996 systemd-tmpfiles[758]: Skipping /boot Dec 12 22:58:10.048127 systemd[1]: Finished Create Volatile Files and Directories. Dec 12 22:58:10.058329 systemd[1]: Starting Load Security Auditing Rules... Dec 12 22:58:10.059972 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Dec 12 22:58:10.060906 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Dec 12 22:58:10.061000 audit: BPF prog-id=27 op=LOAD Dec 12 22:58:10.062333 systemd[1]: Starting Network Name Resolution... Dec 12 22:58:10.063000 audit: BPF prog-id=28 op=LOAD Dec 12 22:58:10.064407 systemd[1]: Starting Network Time Synchronization... Dec 12 22:58:10.065140 systemd[1]: Condition check resulted in Update is Completed being skipped. Dec 12 22:58:10.066105 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Dec 12 22:58:10.067475 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Dec 12 22:58:10.068565 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Dec 12 22:58:10.073424 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Dec 12 22:58:10.084084 augenrules[779]: No rules Dec 12 22:58:10.083000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Dec 12 22:58:10.085005 systemd[1]: Finished Load Security Auditing Rules. Dec 12 22:58:10.099946 systemd-timesyncd[768]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Dec 12 22:58:10.100386 systemd-resolved[762]: Positive Trust Anchors: Dec 12 22:58:10.100393 systemd-resolved[762]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 12 22:58:10.100421 systemd-resolved[762]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Dec 12 22:58:10.100516 systemd[1]: Started Network Time Synchronization. Dec 12 22:58:10.101499 systemd-resolved[762]: Defaulting to hostname 'linux'. Dec 12 22:58:10.101622 systemd[1]: Reached target System Initialization. Dec 12 22:58:10.102454 systemd[1]: Started Watch for update engine configuration changes. Dec 12 22:58:10.103432 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 12 22:58:10.104397 systemd[1]: Started Daily Cleanup of Temporary Directories. Dec 12 22:58:10.105178 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Dec 12 22:58:10.105204 systemd[1]: Reached target Path Units. Dec 12 22:58:10.105875 systemd[1]: Reached target System Time Set. Dec 12 22:58:10.106787 systemd[1]: Started Daily Log Rotation. Dec 12 22:58:10.107470 systemd[1]: Started Weekly check for MD array's redundancy information.. Dec 12 22:58:10.108312 systemd[1]: Reached target Timer Units. Dec 12 22:58:10.109243 systemd[1]: Listening on D-Bus System Message Bus Socket. Dec 12 22:58:10.120041 systemd[1]: Starting Docker Socket for the API... Dec 12 22:58:10.123305 systemd[1]: Listening on OpenSSH Server Socket. Dec 12 22:58:10.124448 systemd[1]: Started Network Name Resolution. Dec 12 22:58:10.125200 systemd[1]: Listening on Docker Socket for the API. Dec 12 22:58:10.126021 systemd[1]: Reached target Network. Dec 12 22:58:10.126644 systemd[1]: Reached target Host and Network Name Lookups. Dec 12 22:58:10.127414 systemd[1]: Reached target Socket Units. Dec 12 22:58:10.128008 systemd[1]: Reached target Basic System. Dec 12 22:58:10.128705 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Dec 12 22:58:10.128734 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Dec 12 22:58:10.129701 systemd[1]: Started D-Bus System Message Bus. Dec 12 22:58:10.132674 systemd[1]: Starting Extend Filesystems... Dec 12 22:58:10.133419 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Dec 12 22:58:10.134476 systemd[1]: Starting Generate /run/flatcar/motd... Dec 12 22:58:10.136544 systemd[1]: Starting Install an ssh key from /proc/cmdline... Dec 12 22:58:10.138383 systemd[1]: Starting Generate sshd host keys... Dec 12 22:58:10.139086 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Dec 12 22:58:10.139125 systemd[1]: Reached target Load system-provided cloud configs. Dec 12 22:58:10.143250 systemd[1]: Starting User Login Management... Dec 12 22:58:10.145577 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 12 22:58:10.146290 systemd[1]: Starting Update Engine... Dec 12 22:58:10.147038 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Dec 12 22:58:10.147079 systemd[1]: Reached target Load user-provided cloud configs. Dec 12 22:58:10.148709 systemd[1]: motdgen.service: Deactivated successfully. Dec 12 22:58:10.149018 systemd[1]: Finished Generate /run/flatcar/motd. Dec 12 22:58:10.150210 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 12 22:58:10.150526 systemd[1]: Finished Install an ssh key from /proc/cmdline. Dec 12 22:58:10.155811 extend-filesystems[789]: Found vda Dec 12 22:58:10.155811 extend-filesystems[789]: Found vda1 Dec 12 22:58:10.155811 extend-filesystems[789]: Found vda2 Dec 12 22:58:10.155811 extend-filesystems[789]: Found vda3 Dec 12 22:58:10.155811 extend-filesystems[789]: Found usr Dec 12 22:58:10.155811 extend-filesystems[789]: Found vda4 Dec 12 22:58:10.155811 extend-filesystems[789]: Found vda6 Dec 12 22:58:10.155811 extend-filesystems[789]: Found vda7 Dec 12 22:58:10.155811 extend-filesystems[789]: Found vda9 Dec 12 22:58:10.155811 extend-filesystems[789]: Checking size of /dev/vda9 Dec 12 22:58:10.175725 extend-filesystems[789]: Old size kept for /dev/vda9 Dec 12 22:58:10.177061 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 12 22:58:10.177541 systemd[1]: Finished Extend Filesystems. Dec 12 22:58:10.183093 systemd-logind[800]: Watching system buttons on /dev/input/event0 (Power Button) Dec 12 22:58:10.183646 systemd-logind[800]: New seat seat0. Dec 12 22:58:10.189232 systemd[1]: Started User Login Management. Dec 12 22:58:10.203999 update_engine[805]: I1212 22:58:10.203619 805 main.cc:89] Flatcar Update Engine starting Dec 12 22:58:10.204775 update_engine[805]: I1212 22:58:10.204646 805 payload_state.cc:360] Current Response Signature = Dec 12 22:58:10.204775 update_engine[805]: NumURLs = 1 Dec 12 22:58:10.204775 update_engine[805]: Url0 = http://10.0.0.7:34567/packages/update.gz Dec 12 22:58:10.204775 update_engine[805]: Payload Size = 404125651 Dec 12 22:58:10.204775 update_engine[805]: Payload Sha256 Hash = 4hfcTZDmcDqsO9HQem8/SEl+FfeTS7xMT8GNrEcoLTM= Dec 12 22:58:10.204775 update_engine[805]: Is Delta Payload = 0 Dec 12 22:58:10.204775 update_engine[805]: Max Failure Count Per Url = 10 Dec 12 22:58:10.204775 update_engine[805]: Disable Payload Backoff = 1 Dec 12 22:58:10.205170 update_engine[805]: I1212 22:58:10.205040 805 payload_state.cc:381] Payload Attempt Number = 0 Dec 12 22:58:10.205415 update_engine[805]: I1212 22:58:10.205276 805 payload_state.cc:404] Current URL Index = 0 Dec 12 22:58:10.205596 update_engine[805]: I1212 22:58:10.205489 805 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Dec 12 22:58:10.205590 systemd[1]: Finished Generate sshd host keys. Dec 12 22:58:10.205770 update_engine[805]: I1212 22:58:10.205741 805 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Dec 12 22:58:10.207818 update_engine[805]: I1212 22:58:10.207779 805 update_check_scheduler.cc:74] Next update check in 4m9s Dec 12 22:58:10.213492 systemd[1]: Starting Generate /run/issue... Dec 12 22:58:10.214236 systemd[1]: Started Update Engine. Dec 12 22:58:10.217881 systemd[1]: issuegen.service: Deactivated successfully. Dec 12 22:58:10.218118 systemd[1]: Finished Generate /run/issue. Dec 12 22:58:10.220073 systemd[1]: Starting Permit User Sessions... Dec 12 22:58:10.224722 systemd[1]: Finished Permit User Sessions. Dec 12 22:58:10.226741 systemd[1]: Started Getty on tty1. Dec 12 22:58:10.228460 systemd[1]: Started Serial Getty on ttyAMA0. Dec 12 22:58:10.229265 systemd[1]: Reached target Login Prompts. Dec 12 22:58:10.230054 systemd[1]: Reached target Multi-User System. Dec 12 22:58:10.232051 systemd[1]: Starting Record Runlevel Change in UTMP... Dec 12 22:58:10.237093 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Dec 12 22:58:10.237330 systemd[1]: Finished Record Runlevel Change in UTMP. Dec 12 22:58:10.238167 systemd[1]: Startup finished in 685ms (kernel) + 1.104s (initrd) + 2.580s (userspace) = 4.369s. Dec 12 22:58:11.019730 systemd-networkd[726]: eth0: Gained IPv6LL Dec 12 22:58:20.162335 systemd[1]: Created slice Slice /system/sshd. Dec 12 22:58:20.163302 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36602). Dec 12 22:58:20.207048 sshd[829]: Accepted publickey for core from 10.0.0.1 port 36602 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:58:20.209204 sshd[829]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:58:20.227882 systemd[1]: Created slice User Slice of UID 500. Dec 12 22:58:20.228942 systemd[1]: Starting User Runtime Directory /run/user/500... Dec 12 22:58:20.230584 systemd-logind[800]: New session 1 of user core. Dec 12 22:58:20.235138 systemd[1]: Finished User Runtime Directory /run/user/500. Dec 12 22:58:20.236312 systemd[1]: Starting User Manager for UID 500... Dec 12 22:58:20.238509 systemd[832]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:58:20.287853 systemd[832]: Queued start job for default target Main User Target. Dec 12 22:58:20.288010 systemd[832]: Reached target Paths. Dec 12 22:58:20.288024 systemd[832]: Reached target Sockets. Dec 12 22:58:20.288035 systemd[832]: Reached target Timers. Dec 12 22:58:20.288045 systemd[832]: Reached target Basic System. Dec 12 22:58:20.288092 systemd[832]: Reached target Main User Target. Dec 12 22:58:20.288104 systemd[832]: Startup finished in 45ms. Dec 12 22:58:20.288415 systemd[1]: Started User Manager for UID 500. Dec 12 22:58:20.295513 systemd[1]: Started Session 1 of User core. Dec 12 22:58:20.358859 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36608). Dec 12 22:58:20.405366 sshd[841]: Accepted publickey for core from 10.0.0.1 port 36608 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:58:20.406348 sshd[841]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:58:20.409530 systemd-logind[800]: New session 2 of user core. Dec 12 22:58:20.420504 systemd[1]: Started Session 2 of User core. Dec 12 22:58:20.472521 sshd[841]: pam_unix(sshd:session): session closed for user core Dec 12 22:58:20.488924 systemd[1]: sshd@1-10.0.0.8:22-10.0.0.1:36608.service: Deactivated successfully. Dec 12 22:58:20.489481 systemd[1]: session-2.scope: Deactivated successfully. Dec 12 22:58:20.490084 systemd-logind[800]: Session 2 logged out. Waiting for processes to exit. Dec 12 22:58:20.491077 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36622). Dec 12 22:58:20.491683 systemd-logind[800]: Removed session 2. Dec 12 22:58:20.531175 sshd[847]: Accepted publickey for core from 10.0.0.1 port 36622 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:58:20.532477 sshd[847]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:58:20.535092 systemd-logind[800]: New session 3 of user core. Dec 12 22:58:20.544521 systemd[1]: Started Session 3 of User core. Dec 12 22:58:20.593717 sshd[847]: pam_unix(sshd:session): session closed for user core Dec 12 22:58:20.604284 systemd[1]: sshd@2-10.0.0.8:22-10.0.0.1:36622.service: Deactivated successfully. Dec 12 22:58:20.604960 systemd[1]: session-3.scope: Deactivated successfully. Dec 12 22:58:20.605578 systemd-logind[800]: Session 3 logged out. Waiting for processes to exit. Dec 12 22:58:20.606542 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36628). Dec 12 22:58:20.607223 systemd-logind[800]: Removed session 3. Dec 12 22:58:20.646592 sshd[853]: Accepted publickey for core from 10.0.0.1 port 36628 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:58:20.647913 sshd[853]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:58:20.650647 systemd-logind[800]: New session 4 of user core. Dec 12 22:58:20.665531 systemd[1]: Started Session 4 of User core. Dec 12 22:58:20.717888 sshd[853]: pam_unix(sshd:session): session closed for user core Dec 12 22:58:20.726912 systemd[1]: sshd@3-10.0.0.8:22-10.0.0.1:36628.service: Deactivated successfully. Dec 12 22:58:20.727449 systemd[1]: session-4.scope: Deactivated successfully. Dec 12 22:58:20.728072 systemd-logind[800]: Session 4 logged out. Waiting for processes to exit. Dec 12 22:58:20.729055 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36632). Dec 12 22:58:20.729780 systemd-logind[800]: Removed session 4. Dec 12 22:58:20.769524 sshd[859]: Accepted publickey for core from 10.0.0.1 port 36632 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:58:20.770512 sshd[859]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:58:20.773399 systemd-logind[800]: New session 5 of user core. Dec 12 22:58:20.785529 systemd[1]: Started Session 5 of User core. Dec 12 22:58:20.842525 sudo[862]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Dec 12 22:58:20.842753 sudo[862]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 22:58:20.851420 sudo[862]: pam_unix(sudo:session): session closed for user root Dec 12 22:58:20.853287 sshd[859]: pam_unix(sshd:session): session closed for user core Dec 12 22:58:20.870588 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:44412). Dec 12 22:58:20.871950 dbus-daemon[788]: [system] Reloaded configuration Dec 12 22:58:20.875038 systemd[1]: sshd@4-10.0.0.8:22-10.0.0.1:36632.service: Deactivated successfully. Dec 12 22:58:20.875770 systemd[1]: session-5.scope: Deactivated successfully. Dec 12 22:58:20.876474 systemd-logind[800]: Session 5 logged out. Waiting for processes to exit. Dec 12 22:58:20.877283 systemd-logind[800]: Removed session 5. Dec 12 22:58:20.911597 sshd[865]: Accepted publickey for core from 10.0.0.1 port 44412 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:58:20.913000 sshd[865]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:58:20.915631 systemd-logind[800]: New session 6 of user core. Dec 12 22:58:20.925525 systemd[1]: Started Session 6 of User core. Dec 12 22:58:20.976074 sudo[870]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Dec 12 22:58:20.976284 sudo[870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 22:58:20.978837 sudo[870]: pam_unix(sudo:session): session closed for user root Dec 12 22:58:20.982597 sudo[869]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Dec 12 22:58:20.982804 sudo[869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 22:58:20.998350 systemd[1]: Stopping Load Security Auditing Rules... Dec 12 22:58:20.998000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Dec 12 22:58:21.000545 auditctl[873]: No rules Dec 12 22:58:21.000856 systemd[1]: audit-rules.service: Deactivated successfully. Dec 12 22:58:21.001107 systemd[1]: Stopped Load Security Auditing Rules. Dec 12 22:58:21.001407 kernel: kauditd_printk_skb: 37 callbacks suppressed Dec 12 22:58:21.001452 kernel: audit: type=1305 audit(1765580300.998:48): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Dec 12 22:58:21.002450 systemd[1]: Starting Load Security Auditing Rules... Dec 12 22:58:21.017460 augenrules[890]: No rules Dec 12 22:58:21.018159 systemd[1]: Finished Load Security Auditing Rules. Dec 12 22:58:21.019258 sudo[869]: pam_unix(sudo:session): session closed for user root Dec 12 22:58:21.020504 sshd[865]: pam_unix(sshd:session): session closed for user core Dec 12 22:58:21.027968 systemd[1]: sshd@5-10.0.0.8:22-10.0.0.1:44412.service: Deactivated successfully. Dec 12 22:58:21.028499 systemd[1]: session-6.scope: Deactivated successfully. Dec 12 22:58:21.029073 systemd-logind[800]: Session 6 logged out. Waiting for processes to exit. Dec 12 22:58:21.029969 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:44416). Dec 12 22:58:21.030606 systemd-logind[800]: Removed session 6. Dec 12 22:58:21.070612 sshd[896]: Accepted publickey for core from 10.0.0.1 port 44416 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:58:21.073381 kernel: audit: type=1006 audit(1765580301.071:49): pid=896 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Dec 12 22:58:21.073344 sshd[896]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:58:21.076016 systemd-logind[800]: New session 7 of user core. Dec 12 22:58:21.085509 systemd[1]: Started Session 7 of User core. Dec 12 22:58:21.133593 sshd[896]: pam_unix(sshd:session): session closed for user core Dec 12 22:58:21.141853 systemd[1]: sshd@6-10.0.0.8:22-10.0.0.1:44416.service: Deactivated successfully. Dec 12 22:58:21.142387 systemd[1]: session-7.scope: Deactivated successfully. Dec 12 22:58:21.142955 systemd-logind[800]: Session 7 logged out. Waiting for processes to exit. Dec 12 22:58:21.143882 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:44420). Dec 12 22:58:21.144567 systemd-logind[800]: Removed session 7. Dec 12 22:58:21.184142 sshd[902]: Accepted publickey for core from 10.0.0.1 port 44420 ssh2: RSA SHA256:8GVaGCdQ9c4068W7C98Ai8ipm6V2P3Uiwonj8mAoNjk Dec 12 22:58:21.185240 sshd[902]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 22:58:21.187372 kernel: audit: type=1006 audit(1765580301.184:50): pid=902 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Dec 12 22:58:21.188588 systemd-logind[800]: New session 8 of user core. Dec 12 22:58:21.198536 systemd[1]: Started Session 8 of User core. Dec 12 22:58:21.247178 sshd[902]: pam_unix(sshd:session): session closed for user core Dec 12 22:58:21.250020 systemd[1]: sshd@7-10.0.0.8:22-10.0.0.1:44420.service: Deactivated successfully. Dec 12 22:58:21.250657 systemd[1]: session-8.scope: Deactivated successfully. Dec 12 22:58:21.251251 systemd-logind[800]: Session 8 logged out. Waiting for processes to exit. Dec 12 22:58:21.251902 systemd-logind[800]: Removed session 8.