Dec 12 23:05:05.672422 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Dec 12 23:05:05.672438 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 23:05:05.672446 kernel: efi: EFI v2.70 by EDK II Dec 12 23:05:05.672452 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Dec 12 23:05:05.672456 kernel: efi: seeding entropy pool Dec 12 23:05:05.672462 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Dec 12 23:05:05.672468 kernel: ACPI: Early table checksum verification disabled Dec 12 23:05:05.672473 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Dec 12 23:05:05.672478 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Dec 12 23:05:05.672483 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:05.672489 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:05.672494 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:05.672499 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:05.672505 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:05.672511 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:05.672516 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:05.672531 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:05.672537 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:05.672542 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Dec 12 23:05:05.672548 kernel: ACPI: NUMA: Failed to initialise from firmware Dec 12 23:05:05.672553 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 23:05:05.672558 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Dec 12 23:05:05.672563 kernel: Zone ranges: Dec 12 23:05:05.672569 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 23:05:05.672574 kernel: DMA32 empty Dec 12 23:05:05.672579 kernel: Normal empty Dec 12 23:05:05.672584 kernel: Movable zone start for each node Dec 12 23:05:05.672591 kernel: Early memory node ranges Dec 12 23:05:05.672596 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Dec 12 23:05:05.672602 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Dec 12 23:05:05.672607 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Dec 12 23:05:05.672612 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Dec 12 23:05:05.672618 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Dec 12 23:05:05.672623 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Dec 12 23:05:05.672628 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Dec 12 23:05:05.672633 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Dec 12 23:05:05.672638 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Dec 12 23:05:05.672644 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Dec 12 23:05:05.672649 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Dec 12 23:05:05.672654 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 23:05:05.672663 kernel: On node 0 totalpages: 643072 Dec 12 23:05:05.672669 kernel: DMA zone: 10048 pages used for memmap Dec 12 23:05:05.672675 kernel: DMA zone: 0 pages reserved Dec 12 23:05:05.672680 kernel: DMA zone: 643072 pages, LIFO batch:63 Dec 12 23:05:05.672686 kernel: psci: probing for conduit method from ACPI. Dec 12 23:05:05.672691 kernel: psci: PSCIv1.1 detected in firmware. Dec 12 23:05:05.672697 kernel: psci: Using standard PSCI v0.2 function IDs Dec 12 23:05:05.672703 kernel: psci: Trusted OS migration not required Dec 12 23:05:05.672710 kernel: psci: SMC Calling Convention v1.1 Dec 12 23:05:05.672715 kernel: ACPI: SRAT not present Dec 12 23:05:05.672721 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Dec 12 23:05:05.672727 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Dec 12 23:05:05.672733 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 12 23:05:05.672739 kernel: Detected PIPT I-cache on CPU0 Dec 12 23:05:05.672744 kernel: CPU features: detected: GIC system register CPU interface Dec 12 23:05:05.672750 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 12 23:05:05.672756 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 12 23:05:05.672761 kernel: CPU features: detected: Hardware dirty bit management Dec 12 23:05:05.672767 kernel: CPU features: detected: Spectre-v4 Dec 12 23:05:05.672773 kernel: CPU features: detected: ARM erratum 1418040 Dec 12 23:05:05.672779 kernel: CPU features: detected: Spectre-BHB Dec 12 23:05:05.672785 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Dec 12 23:05:05.672790 kernel: Policy zone: DMA Dec 12 23:05:05.672797 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 23:05:05.672804 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 12 23:05:05.672809 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 12 23:05:05.672815 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 12 23:05:05.672821 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Dec 12 23:05:05.672827 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Dec 12 23:05:05.672833 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 12 23:05:05.672840 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 12 23:05:05.672846 kernel: rcu: RCU event tracing is enabled. Dec 12 23:05:05.672852 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Dec 12 23:05:05.672857 kernel: Trampoline variant of Tasks RCU enabled. Dec 12 23:05:05.672863 kernel: Tracing variant of Tasks RCU enabled. Dec 12 23:05:05.672869 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 12 23:05:05.672874 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 12 23:05:05.672880 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 12 23:05:05.672885 kernel: GICv3: 256 SPIs implemented Dec 12 23:05:05.672891 kernel: GICv3: 0 Extended SPIs implemented Dec 12 23:05:05.672897 kernel: GICv3: Distributor has no Range Selector support Dec 12 23:05:05.672902 kernel: GICv3: 16 PPIs implemented Dec 12 23:05:05.672909 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Dec 12 23:05:05.672914 kernel: ACPI: SRAT not present Dec 12 23:05:05.672920 kernel: ITS [mem 0x08080000-0x0809ffff] Dec 12 23:05:05.672925 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Dec 12 23:05:05.672931 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Dec 12 23:05:05.672937 kernel: GICv3: using LPI property table @0x00000000400d0000 Dec 12 23:05:05.672942 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Dec 12 23:05:05.672948 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 23:05:05.672954 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Dec 12 23:05:05.672960 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Dec 12 23:05:05.672965 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Dec 12 23:05:05.672971 kernel: arm-pv: using stolen time PV Dec 12 23:05:05.672978 kernel: Console: colour dummy device 80x25 Dec 12 23:05:05.672984 kernel: ACPI: Core revision 20200925 Dec 12 23:05:05.672990 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Dec 12 23:05:05.672996 kernel: pid_max: default: 32768 minimum: 301 Dec 12 23:05:05.673001 kernel: LSM: Security Framework initializing Dec 12 23:05:05.673007 kernel: SELinux: Initializing. Dec 12 23:05:05.673021 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 12 23:05:05.673028 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 12 23:05:05.673034 kernel: rcu: Hierarchical SRCU implementation. Dec 12 23:05:05.673041 kernel: Platform MSI: ITS@0x8080000 domain created Dec 12 23:05:05.673047 kernel: PCI/MSI: ITS@0x8080000 domain created Dec 12 23:05:05.673052 kernel: Remapping and enabling EFI services. Dec 12 23:05:05.673058 kernel: smp: Bringing up secondary CPUs ... Dec 12 23:05:05.673064 kernel: Detected PIPT I-cache on CPU1 Dec 12 23:05:05.673070 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Dec 12 23:05:05.673076 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Dec 12 23:05:05.673082 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 23:05:05.673087 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Dec 12 23:05:05.673093 kernel: Detected PIPT I-cache on CPU2 Dec 12 23:05:05.673100 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Dec 12 23:05:05.673106 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Dec 12 23:05:05.673112 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 23:05:05.673118 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Dec 12 23:05:05.673124 kernel: Detected PIPT I-cache on CPU3 Dec 12 23:05:05.673134 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Dec 12 23:05:05.673140 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Dec 12 23:05:05.673147 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 23:05:05.673153 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Dec 12 23:05:05.673159 kernel: smp: Brought up 1 node, 4 CPUs Dec 12 23:05:05.673165 kernel: SMP: Total of 4 processors activated. Dec 12 23:05:05.673171 kernel: CPU features: detected: Privileged Access Never Dec 12 23:05:05.673177 kernel: CPU features: detected: LSE atomic instructions Dec 12 23:05:05.673183 kernel: CPU features: detected: User Access Override Dec 12 23:05:05.673189 kernel: CPU features: detected: 32-bit EL0 Support Dec 12 23:05:05.673195 kernel: CPU features: detected: Common not Private translations Dec 12 23:05:05.673201 kernel: CPU features: detected: RAS Extension Support Dec 12 23:05:05.673209 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 12 23:05:05.673215 kernel: CPU features: detected: CRC32 instructions Dec 12 23:05:05.673221 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 12 23:05:05.673227 kernel: CPU: All CPU(s) started at EL1 Dec 12 23:05:05.673233 kernel: alternatives: patching kernel code Dec 12 23:05:05.673240 kernel: devtmpfs: initialized Dec 12 23:05:05.673246 kernel: KASLR enabled Dec 12 23:05:05.673252 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 12 23:05:05.673259 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 12 23:05:05.673265 kernel: pinctrl core: initialized pinctrl subsystem Dec 12 23:05:05.673271 kernel: SMBIOS 3.0.0 present. Dec 12 23:05:05.673277 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Dec 12 23:05:05.673283 kernel: NET: Registered protocol family 16 Dec 12 23:05:05.673289 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 12 23:05:05.673295 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 12 23:05:05.673303 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 12 23:05:05.673309 kernel: audit: initializing netlink subsys (disabled) Dec 12 23:05:05.673315 kernel: audit: type=2000 audit(0.033:1): state=initialized audit_enabled=0 res=1 Dec 12 23:05:05.673321 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 12 23:05:05.673327 kernel: cpuidle: using governor menu Dec 12 23:05:05.673333 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 12 23:05:05.673339 kernel: ASID allocator initialised with 32768 entries Dec 12 23:05:05.673345 kernel: ACPI: bus type PCI registered Dec 12 23:05:05.673351 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 12 23:05:05.673359 kernel: Serial: AMBA PL011 UART driver Dec 12 23:05:05.673365 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Dec 12 23:05:05.673371 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Dec 12 23:05:05.673377 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Dec 12 23:05:05.673383 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Dec 12 23:05:05.673389 kernel: cryptd: max_cpu_qlen set to 1000 Dec 12 23:05:05.673395 kernel: ACPI: Added _OSI(Module Device) Dec 12 23:05:05.673401 kernel: ACPI: Added _OSI(Processor Device) Dec 12 23:05:05.673407 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Dec 12 23:05:05.673414 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 12 23:05:05.673420 kernel: ACPI: Added _OSI(Linux-Dell-Video) Dec 12 23:05:05.673426 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Dec 12 23:05:05.673432 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Dec 12 23:05:05.673438 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 12 23:05:05.673444 kernel: ACPI: Interpreter enabled Dec 12 23:05:05.673450 kernel: ACPI: Using GIC for interrupt routing Dec 12 23:05:05.673456 kernel: ACPI: MCFG table detected, 1 entries Dec 12 23:05:05.673462 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Dec 12 23:05:05.673469 kernel: printk: console [ttyAMA0] enabled Dec 12 23:05:05.673476 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Dec 12 23:05:05.673585 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 12 23:05:05.673644 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 12 23:05:05.673696 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 12 23:05:05.673749 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Dec 12 23:05:05.673799 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Dec 12 23:05:05.673807 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Dec 12 23:05:05.673815 kernel: PCI host bridge to bus 0000:00 Dec 12 23:05:05.673874 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Dec 12 23:05:05.673923 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 12 23:05:05.673970 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Dec 12 23:05:05.674025 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 12 23:05:05.674091 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Dec 12 23:05:05.674151 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Dec 12 23:05:05.674209 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Dec 12 23:05:05.674262 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Dec 12 23:05:05.674315 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Dec 12 23:05:05.674369 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Dec 12 23:05:05.674426 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Dec 12 23:05:05.674481 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Dec 12 23:05:05.674538 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Dec 12 23:05:05.674591 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 12 23:05:05.674653 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Dec 12 23:05:05.674661 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Dec 12 23:05:05.674668 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Dec 12 23:05:05.674674 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Dec 12 23:05:05.674680 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Dec 12 23:05:05.674686 kernel: vgaarb: loaded Dec 12 23:05:05.674692 kernel: Registered efivars operations Dec 12 23:05:05.674699 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 12 23:05:05.674706 kernel: VFS: Disk quotas dquot_6.6.0 Dec 12 23:05:05.674713 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 12 23:05:05.674719 kernel: pnp: PnP ACPI init Dec 12 23:05:05.674781 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Dec 12 23:05:05.674835 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Dec 12 23:05:05.674844 kernel: pnp: PnP ACPI: found 1 devices Dec 12 23:05:05.674850 kernel: NET: Registered protocol family 2 Dec 12 23:05:05.674856 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 12 23:05:05.674865 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 12 23:05:05.674872 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 12 23:05:05.674878 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Dec 12 23:05:05.674884 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 12 23:05:05.674890 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 12 23:05:05.674897 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 12 23:05:05.674903 kernel: NET: Registered protocol family 1 Dec 12 23:05:05.674909 kernel: PCI: CLS 0 bytes, default 64 Dec 12 23:05:05.674916 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Dec 12 23:05:05.674924 kernel: kvm [1]: HYP mode not available Dec 12 23:05:05.674930 kernel: Initialise system trusted keyrings Dec 12 23:05:05.674936 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 12 23:05:05.674943 kernel: Key type asymmetric registered Dec 12 23:05:05.674949 kernel: Asymmetric key parser 'x509' registered Dec 12 23:05:05.674957 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Dec 12 23:05:05.674963 kernel: io scheduler mq-deadline registered Dec 12 23:05:05.674969 kernel: io scheduler kyber registered Dec 12 23:05:05.674975 kernel: io scheduler bfq registered Dec 12 23:05:05.674983 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 12 23:05:05.674989 kernel: ACPI: Power Button [PWRB] Dec 12 23:05:05.674995 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Dec 12 23:05:05.675059 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Dec 12 23:05:05.675068 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 12 23:05:05.675074 kernel: msm_serial: driver initialized Dec 12 23:05:05.675080 kernel: random: fast init done Dec 12 23:05:05.675086 kernel: random: crng init done Dec 12 23:05:05.675093 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Dec 12 23:05:05.675099 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Dec 12 23:05:05.675107 kernel: thunder_xcv, ver 1.0 Dec 12 23:05:05.675113 kernel: thunder_bgx, ver 1.0 Dec 12 23:05:05.675119 kernel: nicpf, ver 1.0 Dec 12 23:05:05.675125 kernel: nicvf, ver 1.0 Dec 12 23:05:05.675185 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 12 23:05:05.675235 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-12-12T23:05:05 UTC (1765580705) Dec 12 23:05:05.675243 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 12 23:05:05.675250 kernel: NET: Registered protocol family 10 Dec 12 23:05:05.675257 kernel: Segment Routing with IPv6 Dec 12 23:05:05.675263 kernel: NET: Registered protocol family 17 Dec 12 23:05:05.675269 kernel: Key type dns_resolver registered Dec 12 23:05:05.675275 kernel: registered taskstats version 1 Dec 12 23:05:05.675281 kernel: Loading compiled-in X.509 certificates Dec 12 23:05:05.675288 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Dec 12 23:05:05.675294 kernel: Key type ._fscrypt registered Dec 12 23:05:05.675300 kernel: Key type .fscrypt registered Dec 12 23:05:05.675306 kernel: Key type fscrypt-provisioning registered Dec 12 23:05:05.675313 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 12 23:05:05.675320 kernel: ima: Allocated hash algorithm: sha1 Dec 12 23:05:05.675326 kernel: ima: No architecture policies found Dec 12 23:05:05.675332 kernel: Freeing unused kernel memory: 34240K Dec 12 23:05:05.675338 kernel: Run /init as init process Dec 12 23:05:05.675344 kernel: with arguments: Dec 12 23:05:05.675350 kernel: /init Dec 12 23:05:05.675356 kernel: with environment: Dec 12 23:05:05.675362 kernel: HOME=/ Dec 12 23:05:05.675368 kernel: TERM=linux Dec 12 23:05:05.675375 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Dec 12 23:05:05.675383 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 23:05:05.675392 systemd[1]: Detected virtualization kvm. Dec 12 23:05:05.675399 systemd[1]: Detected architecture arm64. Dec 12 23:05:05.675405 systemd[1]: Running in initial RAM disk. Dec 12 23:05:05.675412 systemd[1]: No hostname configured, using default hostname. Dec 12 23:05:05.675418 systemd[1]: Hostname set to . Dec 12 23:05:05.675426 systemd[1]: Initializing machine ID from VM UUID. Dec 12 23:05:05.675433 systemd[1]: Queued start job for default target Initrd Default Target. Dec 12 23:05:05.675440 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Dec 12 23:05:05.675446 systemd[1]: Reached target Local Encrypted Volumes. Dec 12 23:05:05.675453 systemd[1]: Reached target Path Units. Dec 12 23:05:05.675459 systemd[1]: Reached target Slice Units. Dec 12 23:05:05.675466 systemd[1]: Reached target Swaps. Dec 12 23:05:05.675472 systemd[1]: Reached target Timer Units. Dec 12 23:05:05.675480 systemd[1]: Listening on Open-iSCSI iscsid Socket. Dec 12 23:05:05.675487 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Dec 12 23:05:05.675493 systemd[1]: Listening on Journal Audit Socket. Dec 12 23:05:05.675500 systemd[1]: Listening on Journal Socket (/dev/log). Dec 12 23:05:05.675506 systemd[1]: Listening on Journal Socket. Dec 12 23:05:05.675513 systemd[1]: Listening on Network Service Netlink Socket. Dec 12 23:05:05.675519 systemd[1]: Listening on udev Control Socket. Dec 12 23:05:05.675533 systemd[1]: Listening on udev Kernel Socket. Dec 12 23:05:05.675540 systemd[1]: Reached target Socket Units. Dec 12 23:05:05.675549 systemd[1]: Starting Create List of Static Device Nodes... Dec 12 23:05:05.675556 systemd[1]: Finished Network Cleanup. Dec 12 23:05:05.675562 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Dec 12 23:05:05.675569 systemd[1]: Starting Journal Service... Dec 12 23:05:05.675575 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Dec 12 23:05:05.675582 systemd[1]: Starting Apply Kernel Variables... Dec 12 23:05:05.675589 systemd[1]: Starting Setup Virtual Console... Dec 12 23:05:05.675595 systemd[1]: Finished Create List of Static Device Nodes. Dec 12 23:05:05.675602 systemd[1]: Finished Apply Kernel Variables. Dec 12 23:05:05.675609 systemd[1]: Finished Setup Virtual Console. Dec 12 23:05:05.675616 systemd[1]: Starting dracut ask for additional cmdline parameters... Dec 12 23:05:05.675623 systemd[1]: Starting Create Static Device Nodes in /dev... Dec 12 23:05:05.675631 systemd-journald[278]: Journal started Dec 12 23:05:05.675667 systemd-journald[278]: Runtime Journal (/run/log/journal/c312ca44bdae4a0f8fd7bebfcc5a72b7) is 6.0M, max 48.5M, 42.4M free. Dec 12 23:05:05.678045 systemd[1]: Started Journal Service. Dec 12 23:05:05.678136 systemd[1]: Finished Create Static Device Nodes in /dev. Dec 12 23:05:05.687840 systemd[1]: Finished dracut ask for additional cmdline parameters. Dec 12 23:05:05.689346 systemd[1]: Starting dracut cmdline hook... Dec 12 23:05:05.697903 dracut-cmdline[296]: dracut-dracut-053 Dec 12 23:05:05.700120 dracut-cmdline[296]: 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 23:05:05.758036 kernel: SCSI subsystem initialized Dec 12 23:05:05.761033 kernel: Loading iSCSI transport class v2.0-870. Dec 12 23:05:05.767057 kernel: iscsi: registered transport (tcp) Dec 12 23:05:05.778034 kernel: iscsi: registered transport (qla4xxx) Dec 12 23:05:05.778053 kernel: QLogic iSCSI HBA Driver Dec 12 23:05:05.787788 systemd[1]: Finished dracut cmdline hook. Dec 12 23:05:05.789220 systemd[1]: Starting dracut pre-udev hook... Dec 12 23:05:05.802317 kernel: device-mapper: uevent: version 1.0.3 Dec 12 23:05:05.802346 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Dec 12 23:05:05.837033 kernel: raid6: neonx8 gen() 13800 MB/s Dec 12 23:05:05.854028 kernel: raid6: neonx8 xor() 10751 MB/s Dec 12 23:05:05.871027 kernel: raid6: neonx4 gen() 13602 MB/s Dec 12 23:05:05.888028 kernel: raid6: neonx4 xor() 11562 MB/s Dec 12 23:05:05.905027 kernel: raid6: neonx2 gen() 13028 MB/s Dec 12 23:05:05.922030 kernel: raid6: neonx2 xor() 9899 MB/s Dec 12 23:05:05.939028 kernel: raid6: neonx1 gen() 10961 MB/s Dec 12 23:05:05.956029 kernel: raid6: neonx1 xor() 8831 MB/s Dec 12 23:05:05.973042 kernel: raid6: int64x8 gen() 6834 MB/s Dec 12 23:05:05.990043 kernel: raid6: int64x8 xor() 3795 MB/s Dec 12 23:05:06.007040 kernel: raid6: int64x4 gen() 6914 MB/s Dec 12 23:05:06.024036 kernel: raid6: int64x4 xor() 3823 MB/s Dec 12 23:05:06.041034 kernel: raid6: int64x2 gen() 6178 MB/s Dec 12 23:05:06.058035 kernel: raid6: int64x2 xor() 3317 MB/s Dec 12 23:05:06.075038 kernel: raid6: int64x1 gen() 5009 MB/s Dec 12 23:05:06.092066 kernel: raid6: int64x1 xor() 2599 MB/s Dec 12 23:05:06.092076 kernel: raid6: using algorithm neonx8 gen() 13800 MB/s Dec 12 23:05:06.092084 kernel: raid6: .... xor() 10751 MB/s, rmw enabled Dec 12 23:05:06.093057 kernel: raid6: using neon recovery algorithm Dec 12 23:05:06.103468 kernel: xor: measuring software checksum speed Dec 12 23:05:06.103489 kernel: 8regs : 17159 MB/sec Dec 12 23:05:06.104441 kernel: 32regs : 20755 MB/sec Dec 12 23:05:06.105296 kernel: arm64_neon : 29111 MB/sec Dec 12 23:05:06.105308 kernel: xor: using function: arm64_neon (29111 MB/sec) Dec 12 23:05:06.151036 kernel: Btrfs loaded, crc32c=crc32c-generic Dec 12 23:05:06.161251 systemd[1]: Finished dracut pre-udev hook. Dec 12 23:05:06.162000 audit: BPF prog-id=6 op=LOAD Dec 12 23:05:06.163000 audit: BPF prog-id=7 op=LOAD Dec 12 23:05:06.163000 audit: BPF prog-id=8 op=LOAD Dec 12 23:05:06.164360 systemd[1]: Starting Rule-based Manager for Device Events and Files... Dec 12 23:05:06.166544 kernel: audit: type=1334 audit(1765580706.162:2): prog-id=6 op=LOAD Dec 12 23:05:06.166567 kernel: audit: type=1334 audit(1765580706.163:3): prog-id=7 op=LOAD Dec 12 23:05:06.166576 kernel: audit: type=1334 audit(1765580706.163:4): prog-id=8 op=LOAD Dec 12 23:05:06.177098 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Dec 12 23:05:06.179127 systemd[1]: Started Rule-based Manager for Device Events and Files. Dec 12 23:05:06.181862 systemd[1]: Starting dracut pre-trigger hook... Dec 12 23:05:06.183000 audit: BPF prog-id=9 op=LOAD Dec 12 23:05:06.183871 systemd[1]: Starting Network Configuration... Dec 12 23:05:06.185691 kernel: audit: type=1334 audit(1765580706.183:5): prog-id=9 op=LOAD Dec 12 23:05:06.194312 dracut-pre-trigger[424]: rd.md=0: removing MD RAID activation Dec 12 23:05:06.202515 systemd-networkd[428]: lo: Link UP Dec 12 23:05:06.202530 systemd-networkd[428]: lo: Gained carrier Dec 12 23:05:06.202837 systemd-networkd[428]: Enumeration completed Dec 12 23:05:06.202931 systemd[1]: Started Network Configuration. Dec 12 23:05:06.207078 kernel: audit: type=1334 audit(1765580706.204:6): prog-id=10 op=LOAD Dec 12 23:05:06.204000 audit: BPF prog-id=10 op=LOAD Dec 12 23:05:06.204950 systemd[1]: Starting Network Name Resolution... Dec 12 23:05:06.223490 systemd[1]: Finished dracut pre-trigger hook. Dec 12 23:05:06.225130 systemd[1]: Starting Coldplug All udev Devices... Dec 12 23:05:06.235661 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Dec 12 23:05:06.239813 systemd-resolved[444]: Positive Trust Anchors: Dec 12 23:05:06.239825 systemd-resolved[444]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 12 23:05:06.239855 systemd-resolved[444]: 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 23:05:06.240303 systemd-resolved[444]: Defaulting to hostname 'linux'. Dec 12 23:05:06.243647 systemd[1]: Started Network Name Resolution. Dec 12 23:05:06.248343 systemd[1]: Reached target Network. Dec 12 23:05:06.248987 systemd[1]: Reached target Host and Network Name Lookups. Dec 12 23:05:06.251963 systemd[1]: Starting iSCSI UserSpace I/O driver... Dec 12 23:05:06.258221 systemd[1]: Started iSCSI UserSpace I/O driver. Dec 12 23:05:06.259726 systemd[1]: Starting Open-iSCSI... Dec 12 23:05:06.262223 systemd[1]: Finished Coldplug All udev Devices. Dec 12 23:05:06.263580 iscsid[482]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Dec 12 23:05:06.263580 iscsid[482]: 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 23:05:06.263580 iscsid[482]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Dec 12 23:05:06.263580 iscsid[482]: If using hardware iscsi like qla4xxx this message can be ignored. Dec 12 23:05:06.263580 iscsid[482]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Dec 12 23:05:06.263580 iscsid[482]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Dec 12 23:05:06.265809 systemd[1]: Started Open-iSCSI. Dec 12 23:05:06.272039 systemd[1]: Starting dracut initqueue hook... Dec 12 23:05:06.285425 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Dec 12 23:05:06.285548 kernel: vda: detected capacity change from 0 to 4756340736 Dec 12 23:05:06.300900 systemd-udevd[465]: Using default interface naming scheme 'v249'. Dec 12 23:05:06.301952 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 12 23:05:06.306894 systemd-networkd[428]: eth0: Link UP Dec 12 23:05:06.319033 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (466) Dec 12 23:05:06.322891 systemd[1]: Found device /dev/disk/by-label/ROOT. Dec 12 23:05:06.326433 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Dec 12 23:05:06.329340 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Dec 12 23:05:06.330096 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Dec 12 23:05:06.333369 systemd[1]: Found device /dev/disk/by-label/OEM. Dec 12 23:05:06.335047 systemd[1]: Finished dracut initqueue hook. Dec 12 23:05:06.336503 systemd[1]: Reached target Initrd Root Device. Dec 12 23:05:06.337856 systemd[1]: Reached target Preparation for Remote File Systems. Dec 12 23:05:06.338822 systemd[1]: Reached target Remote Encrypted Volumes. Dec 12 23:05:06.340251 systemd[1]: Reached target Remote File Systems. Dec 12 23:05:06.342262 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Dec 12 23:05:06.343895 systemd[1]: Starting dracut pre-mount hook... Dec 12 23:05:06.351062 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 12 23:05:06.352437 systemd[1]: Finished dracut pre-mount hook. Dec 12 23:05:06.355035 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 12 23:05:06.358032 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 12 23:05:07.289943 systemd-networkd[428]: eth0: Gained carrier Dec 12 23:05:07.291045 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Dec 12 23:05:07.301081 systemd-networkd[428]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Dec 12 23:05:07.360764 disk-uuid[503]: The operation has completed successfully. Dec 12 23:05:07.361705 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 12 23:05:07.377790 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 12 23:05:07.377913 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Dec 12 23:05:07.383125 systemd[1]: Starting Ignition (setup)... Dec 12 23:05:07.390271 kernel: BTRFS info (device vda6): disk space caching is enabled Dec 12 23:05:07.390300 kernel: BTRFS info (device vda6): has skinny extents Dec 12 23:05:07.396092 systemd[1]: mnt-oem.mount: Deactivated successfully. Dec 12 23:05:07.401507 systemd[1]: ignition-setup.service: Deactivated successfully. Dec 12 23:05:07.401628 systemd[1]: Finished Ignition (setup). Dec 12 23:05:07.403637 systemd[1]: Starting Ignition (disks)... Dec 12 23:05:07.413012 ignition[539]: Ignition v0.36.1-15-gde4e6cc9 Dec 12 23:05:07.413031 ignition[539]: Stage: disks Dec 12 23:05:07.413041 ignition[539]: reading system config file "/usr/lib/ignition/base.ign" Dec 12 23:05:07.413051 ignition[539]: no config at "/usr/lib/ignition/base.ign" Dec 12 23:05:07.413092 ignition[539]: parsed url from cmdline: "" Dec 12 23:05:07.413095 ignition[539]: no config URL provided Dec 12 23:05:07.413100 ignition[539]: reading system config file "/usr/lib/ignition/user.ign" Dec 12 23:05:07.413107 ignition[539]: no config at "/usr/lib/ignition/user.ign" Dec 12 23:05:07.413125 ignition[539]: op(1): [started] loading QEMU firmware config module Dec 12 23:05:07.413130 ignition[539]: op(1): executing: "modprobe" "qemu_fw_cfg" Dec 12 23:05:07.414130 ignition[539]: op(1): [finished] loading QEMU firmware config module Dec 12 23:05:07.426639 ignition[539]: parsing config with SHA512: 3f545ff619e8fe94f414708e6030876f475093431f75150fde22863c4b5a32348929c5016cdce6c4e09eeeced4999cf86b78ae05074c8abcec5d1f127e70ec3f Dec 12 23:05:07.428536 ignition[539]: disks: disks passed Dec 12 23:05:07.428544 ignition[539]: Ignition finished successfully Dec 12 23:05:07.429309 systemd[1]: ignition-disks.service: Deactivated successfully. Dec 12 23:05:07.429426 systemd[1]: Finished Ignition (disks). Dec 12 23:05:07.430470 systemd[1]: Reached target Preparation for Local File Systems. Dec 12 23:05:07.432418 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Dec 12 23:05:07.434374 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Dec 12 23:05:07.442337 systemd-fsck[552]: ROOT: clean, 528/553792 files, 37752/553472 blocks Dec 12 23:05:07.445103 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Dec 12 23:05:07.446154 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Dec 12 23:05:07.447559 systemd[1]: Mounting /sysroot... Dec 12 23:05:07.463758 systemd[1]: Found device /dev/mapper/usr. Dec 12 23:05:07.465483 systemd[1]: Starting File System Check on /dev/mapper/usr... Dec 12 23:05:07.467279 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Dec 12 23:05:07.475111 systemd-fsck[568]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Dec 12 23:05:07.475111 systemd-fsck[568]: You must have r/w access to the filesystem or be root Dec 12 23:05:07.475158 systemd-fsck[565]: fsck failed with exit status 8. Dec 12 23:05:07.475163 systemd-fsck[565]: Ignoring error. Dec 12 23:05:07.475848 systemd[1]: Finished File System Check on /dev/mapper/usr. Dec 12 23:05:07.477976 systemd[1]: Mounting /sysusr/usr... Dec 12 23:05:07.493399 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Dec 12 23:05:07.493438 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Dec 12 23:05:07.493919 systemd[1]: Mounted /sysroot. Dec 12 23:05:07.494662 systemd[1]: Reached target Initrd Root File System. Dec 12 23:05:07.506703 systemd[1]: Mounted /sysusr/usr. Dec 12 23:05:07.507788 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Dec 12 23:05:07.507364 systemd[1]: Reached target Local File Systems. Dec 12 23:05:07.508394 systemd[1]: Reached target System Initialization. Dec 12 23:05:07.509687 systemd[1]: Reached target Basic System. Dec 12 23:05:07.512288 systemd[1]: Mounting /sysroot/usr... Dec 12 23:05:07.514336 systemd[1]: Mounted /sysroot/usr. Dec 12 23:05:07.515527 systemd[1]: Starting Root filesystem setup... Dec 12 23:05:07.541588 systemd[1]: initrd-setup-root.service: Deactivated successfully. Dec 12 23:05:07.541731 systemd[1]: Finished Root filesystem setup. Dec 12 23:05:07.543909 systemd[1]: Starting Ignition (files)... Dec 12 23:05:07.545167 systemd[1]: Starting /sysroot/boot... Dec 12 23:05:07.547294 ignition[584]: Ignition v0.36.1-15-gde4e6cc9 Dec 12 23:05:07.547325 ignition[584]: Stage: files Dec 12 23:05:07.547336 ignition[584]: reading system config file "/usr/lib/ignition/base.ign" Dec 12 23:05:07.547346 ignition[584]: no config at "/usr/lib/ignition/base.ign" Dec 12 23:05:07.547842 ignition[584]: files: compiled without relabeling support, skipping Dec 12 23:05:07.564037 ignition[584]: files: createUsers: op(1): [started] creating or modifying user "core" Dec 12 23:05:07.564049 ignition[584]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Dec 12 23:05:07.565763 ignition[584]: files: createUsers: op(1): [finished] creating or modifying user "core" Dec 12 23:05:07.565773 ignition[584]: files: createUsers: op(2): [started] adding ssh keys to user "core" Dec 12 23:05:07.569610 ignition[584]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Dec 12 23:05:07.569638 ignition[584]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Dec 12 23:05:07.569650 systemd[1]: Finished /sysroot/boot. Dec 12 23:05:07.570955 ignition[584]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Dec 12 23:05:07.570963 ignition[584]: files: op(4): [started] processing unit "coreos-metadata.service" Dec 12 23:05:07.571084 ignition[584]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Dec 12 23:05:07.573252 ignition[584]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Dec 12 23:05:07.576945 systemd[1]: ignition-files.service: Deactivated successfully. Dec 12 23:05:07.573258 ignition[584]: files: op(4): [finished] processing unit "coreos-metadata.service" Dec 12 23:05:07.577075 systemd[1]: Finished Ignition (files). Dec 12 23:05:07.573263 ignition[584]: files: files passed Dec 12 23:05:07.579012 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Dec 12 23:05:07.573267 ignition[584]: Ignition finished successfully Dec 12 23:05:07.579694 systemd[1]: Starting Ignition (record completion)... Dec 12 23:05:07.581615 systemd[1]: Starting Reload Configuration from the Real Root... Dec 12 23:05:07.582829 systemd[1]: ignition-quench.service: Deactivated successfully. Dec 12 23:05:07.582954 systemd[1]: Finished Ignition (record completion). Dec 12 23:05:07.585911 systemd[1]: Reloading. Dec 12 23:05:07.592000 audit: BPF prog-id=6 op=UNLOAD Dec 12 23:05:07.593000 audit: BPF prog-id=3 op=UNLOAD Dec 12 23:05:07.594536 kernel: audit: type=1334 audit(1765580707.592:7): prog-id=6 op=UNLOAD Dec 12 23:05:07.594557 kernel: audit: type=1334 audit(1765580707.593:8): prog-id=3 op=UNLOAD Dec 12 23:05:07.594566 kernel: audit: type=1334 audit(1765580707.593:9): prog-id=10 op=UNLOAD Dec 12 23:05:07.593000 audit: BPF prog-id=10 op=UNLOAD Dec 12 23:05:07.594000 audit: BPF prog-id=9 op=UNLOAD Dec 12 23:05:07.596036 kernel: audit: type=1334 audit(1765580707.594:10): prog-id=9 op=UNLOAD Dec 12 23:05:07.674000 audit: BPF prog-id=11 op=LOAD Dec 12 23:05:07.674000 audit: BPF prog-id=12 op=LOAD Dec 12 23:05:07.674000 audit: BPF prog-id=13 op=LOAD Dec 12 23:05:07.674000 audit: BPF prog-id=7 op=UNLOAD Dec 12 23:05:07.674000 audit: BPF prog-id=8 op=UNLOAD Dec 12 23:05:07.675000 audit: BPF prog-id=14 op=LOAD Dec 12 23:05:07.675000 audit: BPF prog-id=15 op=LOAD Dec 12 23:05:07.675000 audit: BPF prog-id=16 op=LOAD Dec 12 23:05:07.675000 audit: BPF prog-id=4 op=UNLOAD Dec 12 23:05:07.675000 audit: BPF prog-id=5 op=UNLOAD Dec 12 23:05:07.675000 audit: BPF prog-id=17 op=LOAD Dec 12 23:05:07.675000 audit: BPF prog-id=18 op=LOAD Dec 12 23:05:07.690396 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 12 23:05:07.690545 systemd[1]: Finished Reload Configuration from the Real Root. Dec 12 23:05:07.692142 systemd[1]: Reached target Initrd File Systems. Dec 12 23:05:07.693527 systemd[1]: Reached target Initrd Default Target. Dec 12 23:05:07.694847 systemd[1]: Condition check resulted in dracut mount hook being skipped. Dec 12 23:05:07.695529 systemd[1]: Starting dracut pre-pivot and cleanup hook... Dec 12 23:05:07.705649 systemd[1]: Finished dracut pre-pivot and cleanup hook. Dec 12 23:05:07.707182 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Dec 12 23:05:07.713298 systemd[1]: Stopped target Host and Network Name Lookups. Dec 12 23:05:07.714158 systemd[1]: Stopped target Remote Encrypted Volumes. Dec 12 23:05:07.715568 systemd[1]: Stopped target Timer Units. Dec 12 23:05:07.716750 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 12 23:05:07.716852 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Dec 12 23:05:07.718093 systemd[1]: Stopped target Initrd Default Target. Dec 12 23:05:07.719561 systemd[1]: Stopped target Basic System. Dec 12 23:05:07.720885 systemd[1]: Stopped target Initrd Root Device. Dec 12 23:05:07.722201 systemd[1]: Stopped target Path Units. Dec 12 23:05:07.723340 systemd[1]: Stopped target Remote File Systems. Dec 12 23:05:07.724639 systemd[1]: Stopped target Preparation for Remote File Systems. Dec 12 23:05:07.725974 systemd[1]: Stopped target Slice Units. Dec 12 23:05:07.727170 systemd[1]: Stopped target Socket Units. Dec 12 23:05:07.728553 systemd[1]: Stopped target System Initialization. Dec 12 23:05:07.729820 systemd[1]: Stopped target Local File Systems. Dec 12 23:05:07.731046 systemd[1]: Stopped target Preparation for Local File Systems. Dec 12 23:05:07.732545 systemd[1]: Stopped target Swaps. Dec 12 23:05:07.733682 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 12 23:05:07.733793 systemd[1]: Stopped dracut pre-mount hook. Dec 12 23:05:07.735196 systemd[1]: Stopped target Local Encrypted Volumes. Dec 12 23:05:07.736336 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 12 23:05:07.740046 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Dec 12 23:05:07.741057 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 12 23:05:07.741162 systemd[1]: Stopped dracut initqueue hook. Dec 12 23:05:07.744510 iscsid[482]: iscsid shutting down. Dec 12 23:05:07.742841 systemd[1]: Stopping Open-iSCSI... Dec 12 23:05:07.744606 systemd[1]: Stopping /sysroot/boot... Dec 12 23:05:07.745169 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 12 23:05:07.745280 systemd[1]: Stopped Coldplug All udev Devices. Dec 12 23:05:07.746412 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 12 23:05:07.746490 systemd[1]: Stopped dracut pre-trigger hook. Dec 12 23:05:07.748565 systemd[1]: iscsid.service: Deactivated successfully. Dec 12 23:05:07.748694 systemd[1]: Stopped Open-iSCSI. Dec 12 23:05:07.750129 systemd[1]: iscsid.socket: Deactivated successfully. Dec 12 23:05:07.750195 systemd[1]: Closed Open-iSCSI iscsid Socket. Dec 12 23:05:07.751824 systemd[1]: Stopping iSCSI UserSpace I/O driver... Dec 12 23:05:07.752908 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 12 23:05:07.753047 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Dec 12 23:05:07.754345 systemd[1]: iscsiuio.service: Deactivated successfully. Dec 12 23:05:07.754481 systemd[1]: Stopped iSCSI UserSpace I/O driver. Dec 12 23:05:07.756563 systemd[1]: Stopped target Network. Dec 12 23:05:07.757684 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 12 23:05:07.757746 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Dec 12 23:05:07.759118 systemd[1]: Stopping Network Name Resolution... Dec 12 23:05:07.760393 systemd[1]: sysroot-boot.service: Deactivated successfully. Dec 12 23:05:07.760504 systemd[1]: Stopped /sysroot/boot. Dec 12 23:05:07.764090 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 12 23:05:07.770000 audit: BPF prog-id=17 op=UNLOAD Dec 12 23:05:07.764212 systemd[1]: Stopped Network Name Resolution. Dec 12 23:05:07.765407 systemd[1]: Stopping Network Configuration... Dec 12 23:05:07.769460 systemd-networkd[428]: eth0: DHCP lease lost Dec 12 23:05:07.773092 systemd-networkd[428]: eth0: DHCPv6 lease lost Dec 12 23:05:07.774861 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 12 23:05:07.774990 systemd[1]: Stopped Network Configuration. Dec 12 23:05:07.776743 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 12 23:05:07.776776 systemd[1]: Closed Network Service Netlink Socket. Dec 12 23:05:07.778546 systemd[1]: Stopping Network Cleanup... Dec 12 23:05:07.779242 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 12 23:05:07.779323 systemd[1]: Stopped Apply Kernel Variables. Dec 12 23:05:07.783000 audit: BPF prog-id=18 op=UNLOAD Dec 12 23:05:07.781383 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Dec 12 23:05:07.786752 systemd[1]: network-cleanup.service: Deactivated successfully. Dec 12 23:05:07.786886 systemd[1]: Stopped Network Cleanup. Dec 12 23:05:07.788585 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 12 23:05:07.788704 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Dec 12 23:05:07.790106 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 12 23:05:07.790148 systemd[1]: Closed udev Control Socket. Dec 12 23:05:07.791424 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 12 23:05:07.791459 systemd[1]: Closed udev Kernel Socket. Dec 12 23:05:07.792852 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 12 23:05:07.792896 systemd[1]: Stopped dracut pre-udev hook. Dec 12 23:05:07.794366 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 12 23:05:07.794404 systemd[1]: Stopped dracut cmdline hook. Dec 12 23:05:07.802000 audit: BPF prog-id=11 op=UNLOAD Dec 12 23:05:07.795481 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 12 23:05:07.795527 systemd[1]: Stopped dracut ask for additional cmdline parameters. Dec 12 23:05:07.797722 systemd[1]: Starting Cleanup udev Database... Dec 12 23:05:07.799114 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Dec 12 23:05:07.800296 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 12 23:05:07.800358 systemd[1]: Stopped Create Static Device Nodes in /dev. Dec 12 23:05:07.801881 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 12 23:05:07.801920 systemd[1]: Stopped Create List of Static Device Nodes. Dec 12 23:05:07.803245 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 12 23:05:07.803286 systemd[1]: Stopped Setup Virtual Console. Dec 12 23:05:07.804942 systemd[1]: rngd.service: Deactivated successfully. Dec 12 23:05:07.805069 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Dec 12 23:05:07.806420 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 12 23:05:07.806537 systemd[1]: Finished Cleanup udev Database. Dec 12 23:05:07.817000 audit: BPF prog-id=14 op=UNLOAD Dec 12 23:05:07.807600 systemd[1]: Reached target Switch Root. Dec 12 23:05:07.809405 systemd[1]: Starting Switch Root... Dec 12 23:05:07.814311 systemd[1]: Switching root. Dec 12 23:05:07.830297 systemd-journald[278]: Journal stopped Dec 12 23:05:09.981678 systemd-journald[278]: Received SIGTERM from PID 1 (systemd). Dec 12 23:05:09.981736 kernel: SELinux: policy capability network_peer_controls=1 Dec 12 23:05:09.981748 kernel: SELinux: policy capability open_perms=1 Dec 12 23:05:09.981757 kernel: SELinux: policy capability extended_socket_class=1 Dec 12 23:05:09.981766 kernel: SELinux: policy capability always_check_network=0 Dec 12 23:05:09.981775 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 12 23:05:09.981785 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 12 23:05:09.981794 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 12 23:05:09.981804 systemd[1]: Successfully loaded SELinux policy in 30.051ms. Dec 12 23:05:09.981822 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.474ms. Dec 12 23:05:09.981834 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 23:05:09.981844 systemd[1]: Detected virtualization kvm. Dec 12 23:05:09.981854 systemd[1]: Detected architecture arm64. Dec 12 23:05:09.981864 systemd[1]: Detected first boot. Dec 12 23:05:09.981873 systemd[1]: Initializing machine ID from VM UUID. Dec 12 23:05:09.981883 systemd[1]: Populated /etc with preset unit settings. Dec 12 23:05:09.981894 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 23:05:09.981906 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Dec 12 23:05:09.981917 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 12 23:05:09.981926 systemd[1]: Stopped Switch Root. Dec 12 23:05:09.981936 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 12 23:05:09.981946 systemd[1]: Created slice Slice /system/addon-config. Dec 12 23:05:09.981955 systemd[1]: Created slice Slice /system/addon-run. Dec 12 23:05:09.981965 systemd[1]: Created slice Slice /system/getty. Dec 12 23:05:09.981974 systemd[1]: Created slice Slice /system/modprobe. Dec 12 23:05:09.981984 systemd[1]: Created slice Slice /system/serial-getty. Dec 12 23:05:09.981995 systemd[1]: Created slice Slice /system/system-cloudinit. Dec 12 23:05:09.982005 systemd[1]: Created slice Slice /system/systemd-fsck. Dec 12 23:05:09.982039 systemd[1]: Created slice User and Session Slice. Dec 12 23:05:09.982051 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Dec 12 23:05:09.982061 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Dec 12 23:05:09.982070 systemd[1]: Set up automount Boot partition Automount Point. Dec 12 23:05:09.982080 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Dec 12 23:05:09.982093 systemd[1]: Stopped target Switch Root. Dec 12 23:05:09.982102 systemd[1]: Stopped target Initrd File Systems. Dec 12 23:05:09.982114 systemd[1]: Stopped target Initrd Root File System. Dec 12 23:05:09.982124 systemd[1]: Reached target Remote Encrypted Volumes. Dec 12 23:05:09.982137 systemd[1]: Reached target Remote File Systems. Dec 12 23:05:09.982147 systemd[1]: Reached target Slice Units. Dec 12 23:05:09.982156 systemd[1]: Reached target Swaps. Dec 12 23:05:09.982166 systemd[1]: Reached target Verify torcx succeeded. Dec 12 23:05:09.982175 systemd[1]: Reached target Local Verity Protected Volumes. Dec 12 23:05:09.982185 systemd[1]: Listening on Process Core Dump Socket. Dec 12 23:05:09.982194 systemd[1]: Listening on initctl Compatibility Named Pipe. Dec 12 23:05:09.982204 systemd[1]: Listening on Network Service Netlink Socket. Dec 12 23:05:09.982290 systemd[1]: Listening on udev Control Socket. Dec 12 23:05:09.982307 systemd[1]: Listening on udev Kernel Socket. Dec 12 23:05:09.982317 systemd[1]: Mounting Huge Pages File System... Dec 12 23:05:09.982327 systemd[1]: Mounting POSIX Message Queue File System... Dec 12 23:05:09.982337 systemd[1]: Mounting External Media Directory... Dec 12 23:05:09.982346 systemd[1]: Mounting Kernel Debug File System... Dec 12 23:05:09.982359 systemd[1]: Mounting Kernel Trace File System... Dec 12 23:05:09.982421 systemd[1]: Mounting Temporary Directory /tmp... Dec 12 23:05:09.982430 systemd[1]: Starting Create missing system files... Dec 12 23:05:09.982441 systemd[1]: Starting Create List of Static Device Nodes... Dec 12 23:05:09.982454 systemd[1]: Starting Load Kernel Module configfs... Dec 12 23:05:09.982464 systemd[1]: Starting Load Kernel Module drm... Dec 12 23:05:09.982473 systemd[1]: Starting Load Kernel Module fuse... Dec 12 23:05:09.982483 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Dec 12 23:05:09.982494 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 12 23:05:09.982509 systemd[1]: Stopped File System Check on Root Device. Dec 12 23:05:09.982520 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 12 23:05:09.982530 systemd[1]: Stopped systemd-fsck-usr.service. Dec 12 23:05:09.982540 systemd[1]: Stopped Journal Service. Dec 12 23:05:09.982552 kernel: fuse: init (API version 7.32) Dec 12 23:05:09.982586 kernel: kauditd_printk_skb: 36 callbacks suppressed Dec 12 23:05:09.982601 kernel: audit: type=1334 audit(1765580709.966:47): prog-id=27 op=LOAD Dec 12 23:05:09.982611 kernel: audit: type=1334 audit(1765580709.967:48): prog-id=28 op=LOAD Dec 12 23:05:09.982621 systemd[1]: Starting Journal Service... Dec 12 23:05:09.982631 kernel: audit: type=1334 audit(1765580709.967:49): prog-id=29 op=LOAD Dec 12 23:05:09.982641 kernel: audit: type=1334 audit(1765580709.967:50): prog-id=25 op=UNLOAD Dec 12 23:05:09.982649 kernel: audit: type=1334 audit(1765580709.967:51): prog-id=26 op=UNLOAD Dec 12 23:05:09.982660 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Dec 12 23:05:09.982670 systemd[1]: Starting Remount Root and Kernel File Systems... Dec 12 23:05:09.982682 systemd[1]: Starting Apply Kernel Variables... Dec 12 23:05:09.982696 systemd[1]: Starting Coldplug All udev Devices... Dec 12 23:05:09.982706 systemd[1]: verity-setup.service: Deactivated successfully. Dec 12 23:05:09.982717 kernel: audit: type=1305 audit(1765580709.980:52): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Dec 12 23:05:09.982727 systemd[1]: Stopped verity-setup.service. Dec 12 23:05:09.982742 systemd-journald[799]: Journal started Dec 12 23:05:09.982783 systemd-journald[799]: Runtime Journal (/run/log/journal/c312ca44bdae4a0f8fd7bebfcc5a72b7) is 6.0M, max 48.5M, 42.4M free. Dec 12 23:05:07.891000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 12 23:05:07.920000 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 23:05:07.920000 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 23:05:07.920000 audit: BPF prog-id=19 op=LOAD Dec 12 23:05:07.920000 audit: BPF prog-id=19 op=UNLOAD Dec 12 23:05:07.920000 audit: BPF prog-id=20 op=LOAD Dec 12 23:05:07.920000 audit: BPF prog-id=20 op=UNLOAD Dec 12 23:05:07.952000 audit[749]: AVC avc: denied { associate } for pid=749 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 23:05:09.862000 audit: BPF prog-id=21 op=LOAD Dec 12 23:05:09.862000 audit: BPF prog-id=22 op=LOAD Dec 12 23:05:09.862000 audit: BPF prog-id=23 op=LOAD Dec 12 23:05:09.862000 audit: BPF prog-id=15 op=UNLOAD Dec 12 23:05:09.862000 audit: BPF prog-id=16 op=UNLOAD Dec 12 23:05:09.874000 audit: BPF prog-id=24 op=LOAD Dec 12 23:05:09.874000 audit: BPF prog-id=21 op=UNLOAD Dec 12 23:05:09.874000 audit: BPF prog-id=25 op=LOAD Dec 12 23:05:09.874000 audit: BPF prog-id=26 op=LOAD Dec 12 23:05:09.874000 audit: BPF prog-id=22 op=UNLOAD Dec 12 23:05:09.874000 audit: BPF prog-id=23 op=UNLOAD Dec 12 23:05:09.884000 audit: BPF prog-id=24 op=UNLOAD Dec 12 23:05:09.966000 audit: BPF prog-id=27 op=LOAD Dec 12 23:05:09.967000 audit: BPF prog-id=28 op=LOAD Dec 12 23:05:09.967000 audit: BPF prog-id=29 op=LOAD Dec 12 23:05:09.967000 audit: BPF prog-id=25 op=UNLOAD Dec 12 23:05:09.967000 audit: BPF prog-id=26 op=UNLOAD Dec 12 23:05:09.980000 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 23:05:09.861783 systemd[1]: Queued start job for default target Multi-User System. Dec 12 23:05:07.950478 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05: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 23:05:09.874889 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 12 23:05:07.950749 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:07Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 12 23:05:07.950767 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:07Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 12 23:05:07.950869 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:07Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Dec 12 23:05:07.950880 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:07Z" level=debug msg="skipped missing lower profile" missing profile=oem Dec 12 23:05:07.950909 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:07Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Dec 12 23:05:07.950922 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:07Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Dec 12 23:05:07.951131 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:07Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Dec 12 23:05:07.951166 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:07Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 12 23:05:07.951182 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:07Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 12 23:05:07.951533 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05: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 23:05:07.951566 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05: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 23:05:07.951588 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05: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 23:05:07.951604 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05: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 23:05:07.951623 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05: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 23:05:07.951638 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:07Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Dec 12 23:05:09.684574 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:09Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 12 23:05:09.684846 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05: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 23:05:09.684946 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05: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 23:05:09.685086 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05: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 23:05:09.685140 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05:09Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Dec 12 23:05:09.685194 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-12-12T23:05: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 23:05:09.986435 systemd[1]: Started Journal Service. Dec 12 23:05:09.986966 systemd[1]: Mounted Huge Pages File System. Dec 12 23:05:09.987790 systemd[1]: Mounted POSIX Message Queue File System. Dec 12 23:05:09.988677 systemd[1]: Mounted External Media Directory. Dec 12 23:05:09.989491 systemd[1]: Mounted Kernel Debug File System. Dec 12 23:05:09.990334 systemd[1]: Mounted Kernel Trace File System. Dec 12 23:05:09.991107 systemd[1]: Mounted Temporary Directory /tmp. Dec 12 23:05:09.992191 systemd[1]: Finished Create missing system files. Dec 12 23:05:09.993282 systemd[1]: Finished Create List of Static Device Nodes. Dec 12 23:05:09.994330 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 12 23:05:09.994542 systemd[1]: Finished Load Kernel Module configfs. Dec 12 23:05:09.995474 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 12 23:05:09.995674 systemd[1]: Finished Load Kernel Module drm. Dec 12 23:05:09.996627 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 12 23:05:09.996807 systemd[1]: Finished Load Kernel Module fuse. Dec 12 23:05:09.997847 systemd[1]: Finished Remount Root and Kernel File Systems. Dec 12 23:05:10.007524 systemd[1]: Finished Apply Kernel Variables. Dec 12 23:05:10.010475 systemd[1]: Mounting FUSE Control File System... Dec 12 23:05:10.012157 systemd[1]: Mounting Kernel Configuration File System... Dec 12 23:05:10.012902 systemd[1]: Condition check resulted in Remount Root File System being skipped. Dec 12 23:05:10.014491 systemd[1]: Starting Rebuild Hardware Database... Dec 12 23:05:10.016293 systemd[1]: Starting Flush Journal to Persistent Storage... Dec 12 23:05:10.017436 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Dec 12 23:05:10.018452 systemd[1]: Starting Load/Save Random Seed... Dec 12 23:05:10.020723 systemd-journald[799]: Time spent on flushing to /var/log/journal/c312ca44bdae4a0f8fd7bebfcc5a72b7 is 8.383ms for 775 entries. Dec 12 23:05:10.020723 systemd-journald[799]: System Journal (/var/log/journal/c312ca44bdae4a0f8fd7bebfcc5a72b7) is 8.0M, max 203.0M, 195.0M free. Dec 12 23:05:10.020344 systemd[1]: Starting Create System Users... Dec 12 23:05:10.024201 systemd[1]: Mounted FUSE Control File System. Dec 12 23:05:10.025478 systemd[1]: Mounted Kernel Configuration File System. Dec 12 23:05:10.030440 systemd[1]: Finished Load/Save Random Seed. Dec 12 23:05:10.031321 systemd[1]: Reached target First Boot Complete. Dec 12 23:05:10.032748 systemd-sysusers[811]: Creating group sgx with gid 999. Dec 12 23:05:10.033525 systemd-sysusers[811]: Creating group systemd-oom with gid 998. Dec 12 23:05:10.033998 systemd-sysusers[811]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Dec 12 23:05:10.034669 systemd-sysusers[811]: Creating group systemd-timesync with gid 997. Dec 12 23:05:10.035137 systemd-sysusers[811]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Dec 12 23:05:10.035741 systemd-sysusers[811]: Creating group systemd-coredump with gid 996. Dec 12 23:05:10.036231 systemd-sysusers[811]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Dec 12 23:05:10.043412 systemd[1]: Finished Coldplug All udev Devices. Dec 12 23:05:10.044699 systemd[1]: Finished Flush Journal to Persistent Storage. Dec 12 23:05:10.052009 systemd[1]: Starting Wait for udev To Complete Device Initialization... Dec 12 23:05:10.053222 systemd[1]: Finished Create System Users. Dec 12 23:05:10.055158 systemd[1]: Starting Create Static Device Nodes in /dev... Dec 12 23:05:10.067773 systemd[1]: Finished Create Static Device Nodes in /dev. Dec 12 23:05:10.303169 systemd[1]: Finished Rebuild Hardware Database. Dec 12 23:05:10.319000 audit: BPF prog-id=30 op=LOAD Dec 12 23:05:10.320000 audit: BPF prog-id=31 op=LOAD Dec 12 23:05:10.321222 kernel: audit: type=1334 audit(1765580710.319:53): prog-id=30 op=LOAD Dec 12 23:05:10.321262 kernel: audit: type=1334 audit(1765580710.320:54): prog-id=31 op=LOAD Dec 12 23:05:10.321280 kernel: audit: type=1334 audit(1765580710.321:55): prog-id=32 op=LOAD Dec 12 23:05:10.321000 audit: BPF prog-id=32 op=LOAD Dec 12 23:05:10.321885 systemd[1]: Starting Rule-based Manager for Device Events and Files... Dec 12 23:05:10.321000 audit: BPF prog-id=12 op=UNLOAD Dec 12 23:05:10.321000 audit: BPF prog-id=13 op=UNLOAD Dec 12 23:05:10.322055 kernel: audit: type=1334 audit(1765580710.321:56): prog-id=12 op=UNLOAD Dec 12 23:05:10.346625 systemd[1]: Started Rule-based Manager for Device Events and Files. Dec 12 23:05:10.357000 audit: BPF prog-id=33 op=LOAD Dec 12 23:05:10.358331 systemd[1]: Starting Network Configuration... Dec 12 23:05:10.386757 systemd-udevd[818]: Using default interface naming scheme 'v249'. Dec 12 23:05:10.388118 systemd-networkd[836]: lo: Link UP Dec 12 23:05:10.388125 systemd-networkd[836]: lo: Gained carrier Dec 12 23:05:10.388435 systemd-networkd[836]: Enumeration completed Dec 12 23:05:10.388536 systemd[1]: Started Network Configuration. Dec 12 23:05:10.390568 systemd-networkd[836]: eth0: Link UP Dec 12 23:05:10.395084 systemd-networkd[836]: eth0: Gained carrier Dec 12 23:05:10.409257 udevadm[815]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Dec 12 23:05:10.417169 systemd-networkd[836]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Dec 12 23:05:10.449332 systemd[1]: Finished Wait for udev To Complete Device Initialization. Dec 12 23:05:10.463038 systemd[1]: Starting Activation of LVM2 logical volumes... Dec 12 23:05:10.471000 lvm[844]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 12 23:05:10.491029 systemd[1]: Finished Activation of LVM2 logical volumes. Dec 12 23:05:10.491891 systemd[1]: Reached target Local Encrypted Volumes. Dec 12 23:05:10.504102 systemd[1]: Starting Activation of LVM2 logical volumes... Dec 12 23:05:10.507316 lvm[845]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 12 23:05:10.535954 systemd[1]: Finished Activation of LVM2 logical volumes. Dec 12 23:05:10.536901 systemd[1]: Reached target Preparation for Local File Systems. Dec 12 23:05:10.537795 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Dec 12 23:05:10.537820 systemd[1]: Reached target Containers. Dec 12 23:05:10.549333 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Dec 12 23:05:10.561303 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Dec 12 23:05:10.563409 systemd[1]: Mounting /usr/share/oem... Dec 12 23:05:10.570039 kernel: BTRFS info (device vda6): disk space caching is enabled Dec 12 23:05:10.570095 kernel: BTRFS info (device vda6): has skinny extents Dec 12 23:05:10.572068 systemd[1]: Mounted /usr/share/oem. Dec 12 23:05:10.572774 systemd[1]: Reached target Local File Systems. Dec 12 23:05:10.579979 systemd[1]: Starting Rebuild Dynamic Linker Cache... Dec 12 23:05:10.581088 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Dec 12 23:05:10.581134 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Dec 12 23:05:10.582636 systemd[1]: Starting Commit a transient machine-id on disk... Dec 12 23:05:10.584630 systemd[1]: Starting Create Volatile Files and Directories... Dec 12 23:05:10.590406 systemd-tmpfiles[870]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Dec 12 23:05:10.591437 systemd-tmpfiles[870]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Dec 12 23:05:10.600082 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Dec 12 23:05:10.601239 systemd[1]: Finished Commit a transient machine-id on disk. Dec 12 23:05:10.619398 systemd-tmpfiles[870]: Detected autofs mount point /boot during canonicalization of /boot. Dec 12 23:05:10.619410 systemd-tmpfiles[870]: Skipping /boot Dec 12 23:05:10.624269 systemd-tmpfiles[870]: Detected autofs mount point /boot during canonicalization of /boot. Dec 12 23:05:10.624284 systemd-tmpfiles[870]: Skipping /boot Dec 12 23:05:10.656061 systemd[1]: Finished Create Volatile Files and Directories. Dec 12 23:05:10.667052 systemd[1]: Starting Load Security Auditing Rules... Dec 12 23:05:10.668737 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Dec 12 23:05:10.670626 systemd[1]: Starting Rebuild Journal Catalog... Dec 12 23:05:10.672000 audit: BPF prog-id=34 op=LOAD Dec 12 23:05:10.673148 systemd[1]: Starting Network Name Resolution... Dec 12 23:05:10.675000 audit: BPF prog-id=35 op=LOAD Dec 12 23:05:10.675871 systemd[1]: Starting Network Time Synchronization... Dec 12 23:05:10.678972 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Dec 12 23:05:10.680544 systemd[1]: Finished Rebuild Dynamic Linker Cache. Dec 12 23:05:10.681903 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Dec 12 23:05:10.684527 systemd[1]: Finished Rebuild Journal Catalog. Dec 12 23:05:10.690063 systemd[1]: Starting Update is Completed... Dec 12 23:05:10.690716 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Dec 12 23:05:10.691251 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Dec 12 23:05:10.694710 systemd[1]: Finished Update is Completed. Dec 12 23:05:10.696000 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 23:05:10.697110 augenrules[892]: No rules Dec 12 23:05:10.697800 systemd[1]: Finished Load Security Auditing Rules. Dec 12 23:05:10.719480 systemd-resolved[875]: Positive Trust Anchors: Dec 12 23:05:10.719697 systemd-resolved[875]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 12 23:05:10.719772 systemd-resolved[875]: 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 23:05:10.720561 systemd-resolved[875]: Defaulting to hostname 'linux'. Dec 12 23:05:10.720706 systemd[1]: Started Network Time Synchronization. Dec 12 23:05:10.721341 systemd-timesyncd[881]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Dec 12 23:05:10.721727 systemd[1]: Reached target System Initialization. Dec 12 23:05:10.722566 systemd[1]: Started Watch for update engine configuration changes. Dec 12 23:05:10.723424 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 12 23:05:10.724289 systemd[1]: Started Daily Cleanup of Temporary Directories. Dec 12 23:05:10.725024 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Dec 12 23:05:10.725055 systemd[1]: Reached target Path Units. Dec 12 23:05:10.725607 systemd[1]: Reached target System Time Set. Dec 12 23:05:10.726362 systemd[1]: Started Daily Log Rotation. Dec 12 23:05:10.727053 systemd[1]: Started Weekly check for MD array's redundancy information.. Dec 12 23:05:10.727869 systemd[1]: Reached target Timer Units. Dec 12 23:05:10.728786 systemd[1]: Listening on D-Bus System Message Bus Socket. Dec 12 23:05:10.739753 systemd[1]: Starting Docker Socket for the API... Dec 12 23:05:10.742609 systemd[1]: Listening on OpenSSH Server Socket. Dec 12 23:05:10.743681 systemd[1]: Started Network Name Resolution. Dec 12 23:05:10.744441 systemd[1]: Listening on Docker Socket for the API. Dec 12 23:05:10.745173 systemd[1]: Reached target Network. Dec 12 23:05:10.745735 systemd[1]: Reached target Host and Network Name Lookups. Dec 12 23:05:10.746530 systemd[1]: Reached target Socket Units. Dec 12 23:05:10.747127 systemd[1]: Reached target Basic System. Dec 12 23:05:10.747749 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Dec 12 23:05:10.747774 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Dec 12 23:05:10.748703 systemd[1]: Started D-Bus System Message Bus. Dec 12 23:05:10.751649 systemd[1]: Starting Extend Filesystems... Dec 12 23:05:10.752370 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Dec 12 23:05:10.753281 systemd[1]: Starting Generate /run/flatcar/motd... Dec 12 23:05:10.754924 systemd[1]: Starting Install an ssh key from /proc/cmdline... Dec 12 23:05:10.757357 systemd[1]: Starting Generate sshd host keys... Dec 12 23:05:10.758063 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Dec 12 23:05:10.758093 systemd[1]: Reached target Load system-provided cloud configs. Dec 12 23:05:10.760726 systemd[1]: Starting User Login Management... Dec 12 23:05:10.760961 extend-filesystems[901]: Found vda Dec 12 23:05:10.761672 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 12 23:05:10.761932 extend-filesystems[901]: Found vda1 Dec 12 23:05:10.762455 systemd[1]: Starting Update Engine... Dec 12 23:05:10.762733 extend-filesystems[901]: Found vda2 Dec 12 23:05:10.763522 extend-filesystems[901]: Found vda3 Dec 12 23:05:10.764264 extend-filesystems[901]: Found usr Dec 12 23:05:10.764762 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Dec 12 23:05:10.764791 systemd[1]: Reached target Load user-provided cloud configs. Dec 12 23:05:10.765362 extend-filesystems[901]: Found vda4 Dec 12 23:05:10.766438 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 12 23:05:10.766569 extend-filesystems[901]: Found vda6 Dec 12 23:05:10.766663 systemd[1]: Finished Install an ssh key from /proc/cmdline. Dec 12 23:05:10.767233 extend-filesystems[901]: Found vda7 Dec 12 23:05:10.768253 extend-filesystems[901]: Found vda9 Dec 12 23:05:10.768253 extend-filesystems[901]: Checking size of /dev/vda9 Dec 12 23:05:10.771189 systemd[1]: motdgen.service: Deactivated successfully. Dec 12 23:05:10.771413 systemd[1]: Finished Generate /run/flatcar/motd. Dec 12 23:05:10.778043 extend-filesystems[901]: Old size kept for /dev/vda9 Dec 12 23:05:10.782356 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 12 23:05:10.782611 systemd[1]: Finished Extend Filesystems. Dec 12 23:05:10.798184 systemd-logind[910]: Watching system buttons on /dev/input/event0 (Power Button) Dec 12 23:05:10.798366 systemd-logind[910]: New seat seat0. Dec 12 23:05:10.800180 systemd[1]: Started User Login Management. Dec 12 23:05:10.806944 update_engine[913]: I1212 23:05:10.806695 913 main.cc:89] Flatcar Update Engine starting Dec 12 23:05:10.808965 systemd[1]: Started Update Engine. Dec 12 23:05:10.809285 update_engine[913]: I1212 23:05:10.809257 913 update_check_scheduler.cc:74] Next update check in 7m33s Dec 12 23:05:10.817226 systemd[1]: Started Cluster reboot manager. Dec 12 23:05:10.841431 locksmithd[924]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Dec 12 23:05:11.504344 sshd_keygen[920]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Dec 12 23:05:11.522414 systemd[1]: Finished Generate sshd host keys. Dec 12 23:05:11.532156 systemd[1]: Starting Generate /run/issue... Dec 12 23:05:11.536262 systemd[1]: issuegen.service: Deactivated successfully. Dec 12 23:05:11.536466 systemd[1]: Finished Generate /run/issue. Dec 12 23:05:11.538260 systemd[1]: Starting Permit User Sessions... Dec 12 23:05:11.542432 systemd[1]: Finished Permit User Sessions. Dec 12 23:05:11.544248 systemd[1]: Started Getty on tty1. Dec 12 23:05:11.545862 systemd[1]: Started Serial Getty on ttyAMA0. Dec 12 23:05:11.546716 systemd[1]: Reached target Login Prompts. Dec 12 23:05:11.547484 systemd[1]: Reached target Multi-User System. Dec 12 23:05:11.549203 systemd[1]: Starting Record Runlevel Change in UTMP... Dec 12 23:05:11.554013 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Dec 12 23:05:11.554240 systemd[1]: Finished Record Runlevel Change in UTMP. Dec 12 23:05:11.555092 systemd[1]: Startup finished in 667ms (kernel) + 2.301s (initrd) + 3.695s (userspace) = 6.665s. Dec 12 23:05:12.410302 systemd-networkd[836]: eth0: Gained IPv6LL Dec 12 23:05:17.405703 systemd[1]: Created slice Slice /system/sshd. Dec 12 23:05:17.406707 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:51504). Dec 12 23:05:17.459390 sshd[945]: Accepted publickey for core from 10.0.0.1 port 51504 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:17.461455 sshd[945]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:17.475505 systemd[1]: Created slice User Slice of UID 500. Dec 12 23:05:17.476541 systemd[1]: Starting User Runtime Directory /run/user/500... Dec 12 23:05:17.478080 systemd-logind[910]: New session 1 of user core. Dec 12 23:05:17.482990 systemd[1]: Finished User Runtime Directory /run/user/500. Dec 12 23:05:17.484321 systemd[1]: Starting User Manager for UID 500... Dec 12 23:05:17.486575 systemd[948]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:17.532998 systemd[948]: Queued start job for default target Main User Target. Dec 12 23:05:17.533157 systemd[948]: Reached target Paths. Dec 12 23:05:17.533171 systemd[948]: Reached target Sockets. Dec 12 23:05:17.533181 systemd[948]: Reached target Timers. Dec 12 23:05:17.533191 systemd[948]: Reached target Basic System. Dec 12 23:05:17.533229 systemd[948]: Reached target Main User Target. Dec 12 23:05:17.533243 systemd[948]: Startup finished in 42ms. Dec 12 23:05:17.533291 systemd[1]: Started User Manager for UID 500. Dec 12 23:05:17.539200 systemd[1]: Started Session 1 of User core. Dec 12 23:05:17.602538 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:51512). Dec 12 23:05:17.646801 sshd[957]: Accepted publickey for core from 10.0.0.1 port 51512 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:17.647803 sshd[957]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:17.650532 systemd-logind[910]: New session 2 of user core. Dec 12 23:05:17.668234 systemd[1]: Started Session 2 of User core. Dec 12 23:05:17.720788 sshd[957]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:17.731661 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:51512.service: Deactivated successfully. Dec 12 23:05:17.732545 systemd[1]: session-2.scope: Deactivated successfully. Dec 12 23:05:17.733232 systemd-logind[910]: Session 2 logged out. Waiting for processes to exit. Dec 12 23:05:17.734223 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:51516). Dec 12 23:05:17.734770 systemd-logind[910]: Removed session 2. Dec 12 23:05:17.775223 sshd[963]: Accepted publickey for core from 10.0.0.1 port 51516 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:17.776406 sshd[963]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:17.778885 systemd-logind[910]: New session 3 of user core. Dec 12 23:05:17.788180 systemd[1]: Started Session 3 of User core. Dec 12 23:05:17.835616 sshd[963]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:17.844993 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:51516.service: Deactivated successfully. Dec 12 23:05:17.846874 systemd[1]: session-3.scope: Deactivated successfully. Dec 12 23:05:17.847602 systemd-logind[910]: Session 3 logged out. Waiting for processes to exit. Dec 12 23:05:17.849161 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:51524). Dec 12 23:05:17.850943 systemd-logind[910]: Removed session 3. Dec 12 23:05:17.889872 sshd[970]: Accepted publickey for core from 10.0.0.1 port 51524 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:17.890774 sshd[970]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:17.895928 systemd-logind[910]: New session 4 of user core. Dec 12 23:05:17.908192 systemd[1]: Started Session 4 of User core. Dec 12 23:05:17.963423 sshd[970]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:17.972634 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:51524.service: Deactivated successfully. Dec 12 23:05:17.973178 systemd[1]: session-4.scope: Deactivated successfully. Dec 12 23:05:17.973704 systemd-logind[910]: Session 4 logged out. Waiting for processes to exit. Dec 12 23:05:17.974683 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:51526). Dec 12 23:05:17.975275 systemd-logind[910]: Removed session 4. Dec 12 23:05:18.016444 sshd[976]: Accepted publickey for core from 10.0.0.1 port 51526 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:18.017727 sshd[976]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:18.020467 systemd-logind[910]: New session 5 of user core. Dec 12 23:05:18.026173 systemd[1]: Started Session 5 of User core. Dec 12 23:05:18.081183 sudo[979]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Dec 12 23:05:18.081386 sudo[979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 23:05:18.093341 sudo[979]: pam_unix(sudo:session): session closed for user root Dec 12 23:05:18.095274 sshd[976]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:18.096465 dbus-daemon[900]: [system] Reloaded configuration Dec 12 23:05:18.104929 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:51526.service: Deactivated successfully. Dec 12 23:05:18.105532 systemd[1]: session-5.scope: Deactivated successfully. Dec 12 23:05:18.106130 systemd-logind[910]: Session 5 logged out. Waiting for processes to exit. Dec 12 23:05:18.107156 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:51542). Dec 12 23:05:18.107804 systemd-logind[910]: Removed session 5. Dec 12 23:05:18.148236 sshd[983]: Accepted publickey for core from 10.0.0.1 port 51542 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:18.149321 sshd[983]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:18.151857 systemd-logind[910]: New session 6 of user core. Dec 12 23:05:18.161198 systemd[1]: Started Session 6 of User core. Dec 12 23:05:18.211588 sudo[987]: 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 23:05:18.211786 sudo[987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 23:05:18.214381 sudo[987]: pam_unix(sudo:session): session closed for user root Dec 12 23:05:18.218143 sudo[986]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Dec 12 23:05:18.218357 sudo[986]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 23:05:18.235087 systemd[1]: Stopping Load Security Auditing Rules... Dec 12 23:05:18.235000 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 23:05:18.236362 auditctl[990]: No rules Dec 12 23:05:18.237269 systemd[1]: audit-rules.service: Deactivated successfully. Dec 12 23:05:18.237517 systemd[1]: Stopped Load Security Auditing Rules. Dec 12 23:05:18.238189 kernel: kauditd_printk_skb: 5 callbacks suppressed Dec 12 23:05:18.238230 kernel: audit: type=1305 audit(1765580718.235:62): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Dec 12 23:05:18.238873 systemd[1]: Starting Load Security Auditing Rules... Dec 12 23:05:18.253837 augenrules[1007]: No rules Dec 12 23:05:18.254541 systemd[1]: Finished Load Security Auditing Rules. Dec 12 23:05:18.255662 sudo[986]: pam_unix(sudo:session): session closed for user root Dec 12 23:05:18.256923 sshd[983]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:18.269711 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:51542.service: Deactivated successfully. Dec 12 23:05:18.270273 systemd[1]: session-6.scope: Deactivated successfully. Dec 12 23:05:18.270834 systemd-logind[910]: Session 6 logged out. Waiting for processes to exit. Dec 12 23:05:18.271889 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:51544). Dec 12 23:05:18.272501 systemd-logind[910]: Removed session 6. Dec 12 23:05:18.313490 sshd[1013]: Accepted publickey for core from 10.0.0.1 port 51544 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:18.315008 sshd[1013]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:18.317038 kernel: audit: type=1006 audit(1765580718.313:63): pid=1013 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 23:05:18.318672 systemd-logind[910]: New session 7 of user core. Dec 12 23:05:18.327180 systemd[1]: Started Session 7 of User core. Dec 12 23:05:18.377120 sudo[1016]: 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 23:05:21.243122 update_engine[1263]: Dec 12 23:05:21.243122 update_engine[1263]: Dec 12 23:05:21.243122 update_engine[1263]: Dec 12 23:05:21.243122 update_engine[1263]: Dec 12 23:05:21.243122 update_engine[1263]: Dec 12 23:05:21.243122 update_engine[1263]: Dec 12 23:05:21.243122 update_engine[1263]: Dec 12 23:05:21.243122 update_engine[1263]: Dec 12 23:05:21.243122 update_engine[1263]: I1212 23:05:21.243120 1263 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Dec 12 23:05:21.246342 update_engine[1263]: I1212 23:05:21.246308 1263 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Dec 12 23:05:21.246582 update_engine[1263]: I1212 23:05:21.246555 1263 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Dec 12 23:05:21.248138 update_engine[1263]: I1212 23:05:21.248104 1263 libcurl_http_fetcher.cc:248] HTTP response code: 200 Dec 12 23:05:21.248259 update_engine[1263]: I1212 23:05:21.248241 1263 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Dec 12 23:05:21.248259 update_engine[1263]: I1212 23:05:21.248255 1263 omaha_request_action.cc:619] Omaha request response: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.248259 update_engine[1263]: Dec 12 23:05:21.257991 update_engine[1263]: I1212 23:05:21.257932 1263 omaha_request_action.cc:447] Omaha Response manifest version = Dec 12 23:05:21.257991 update_engine[1263]: I1212 23:05:21.257972 1263 omaha_request_action.cc:470] Found 1 url(s) Dec 12 23:05:21.257991 update_engine[1263]: I1212 23:05:21.257988 1263 omaha_request_action.cc:506] Processing first of 1 package(s) Dec 12 23:05:21.257991 update_engine[1263]: I1212 23:05:21.257992 1263 omaha_request_action.cc:513] Omaha Response package name = update.gz Dec 12 23:05:21.257991 update_engine[1263]: I1212 23:05:21.257995 1263 omaha_request_action.cc:529] Url0: http://10.0.0.5:34567/packages/update.gz Dec 12 23:05:21.258171 update_engine[1263]: I1212 23:05:21.258003 1263 omaha_request_action.cc:541] Payload size = 404125651 bytes Dec 12 23:05:21.261036 update_engine[1263]: I1212 23:05:21.258014 1263 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Dec 12 23:05:21.261116 update_engine[1263]: I1212 23:05:21.261080 1263 payload_state.cc:51] Resetting all persisted state as this is a new response Dec 12 23:05:21.261116 update_engine[1263]: I1212 23:05:21.261090 1263 payload_state.cc:360] Current Response Signature = Dec 12 23:05:21.261116 update_engine[1263]: NumURLs = 1 Dec 12 23:05:21.261116 update_engine[1263]: Url0 = http://10.0.0.5:34567/packages/update.gz Dec 12 23:05:21.261116 update_engine[1263]: Payload Size = 404125651 Dec 12 23:05:21.261116 update_engine[1263]: Payload Sha256 Hash = 4hfcTZDmcDqsO9HQem8/SEl+FfeTS7xMT8GNrEcoLTM= Dec 12 23:05:21.261116 update_engine[1263]: Is Delta Payload = 0 Dec 12 23:05:21.261116 update_engine[1263]: Max Failure Count Per Url = 10 Dec 12 23:05:21.261116 update_engine[1263]: Disable Payload Backoff = 1 Dec 12 23:05:21.261296 update_engine[1263]: I1212 23:05:21.261183 1263 payload_state.cc:381] Payload Attempt Number = 0 Dec 12 23:05:21.261296 update_engine[1263]: I1212 23:05:21.261225 1263 payload_state.cc:404] Current URL Index = 0 Dec 12 23:05:21.261296 update_engine[1263]: I1212 23:05:21.261255 1263 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Dec 12 23:05:21.261296 update_engine[1263]: I1212 23:05:21.261296 1263 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Dec 12 23:05:21.261364 update_engine[1263]: I1212 23:05:21.261299 1263 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Dec 12 23:05:21.261364 update_engine[1263]: I1212 23:05:21.261333 1263 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Dec 12 23:05:21.261364 update_engine[1263]: I1212 23:05:21.261356 1263 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Dec 12 23:05:21.261364 update_engine[1263]: I1212 23:05:21.261360 1263 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Dec 12 23:05:21.261435 update_engine[1263]: I1212 23:05:21.261375 1263 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Dec 12 23:05:21.261435 update_engine[1263]: E1212 23:05:21.261380 1263 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Dec 12 23:05:21.262832 update_engine[1263]: I1212 23:05:21.262797 1263 omaha_response_handler_action.cc:85] Using this install plan: Dec 12 23:05:21.262832 update_engine[1263]: I1212 23:05:21.262826 1263 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.5: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 23:05:21.262928 update_engine[1263]: I1212 23:05:21.262912 1263 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Dec 12 23:05:21.263938 update_engine[1263]: I1212 23:05:21.263899 1263 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Dec 12 23:05:21.288928 sshd[1278]: Accepted publickey for core from 10.0.0.1 port 48608 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:21.290352 sshd[1278]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:21.293238 systemd-logind[910]: New session 25 of user core. Dec 12 23:05:21.303209 systemd[1]: Started Session 25 of User core. Dec 12 23:05:21.357237 sshd[1278]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:21.360687 systemd[1]: sshd@24-10.0.0.6:22-10.0.0.1:48608.service: Deactivated successfully. Dec 12 23:05:21.361578 systemd[1]: session-25.scope: Deactivated successfully. Dec 12 23:05:21.362210 systemd-logind[910]: Session 25 logged out. Waiting for processes to exit. Dec 12 23:05:21.362884 systemd-logind[910]: Removed session 25. Dec 12 23:05:23.002403 update_engine[1263]: I1212 23:05:23.002367 1263 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Dec 12 23:05:23.002403 update_engine[1263]: I1212 23:05:23.002404 1263 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Dec 12 23:05:23.061916 update_engine[1263]: E1212 23:05:23.061865 1263 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Dec 12 23:05:23.061916 update_engine[1263]: I1212 23:05:23.061905 1263 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Dec 12 23:05:23.061916 update_engine[1263]: I1212 23:05:23.061909 1263 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Dec 12 23:05:23.061916 update_engine[1263]: I1212 23:05:23.061913 1263 update_attempter.cc:302] Processing Done. Dec 12 23:05:23.062128 update_engine[1263]: E1212 23:05:23.061959 1263 update_attempter.cc:615] Update failed. Dec 12 23:05:23.062128 update_engine[1263]: I1212 23:05:23.061964 1263 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Dec 12 23:05:23.062128 update_engine[1263]: I1212 23:05:23.061968 1263 payload_state.cc:276] Incrementing the URL failure count Dec 12 23:05:23.062128 update_engine[1263]: I1212 23:05:23.061971 1263 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Dec 12 23:05:23.062227 update_engine[1263]: I1212 23:05:23.062201 1263 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Dec 12 23:05:23.062227 update_engine[1263]: I1212 23:05:23.062225 1263 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.5:34567/v1/update Dec 12 23:05:23.062273 update_engine[1263]: I1212 23:05:23.062229 1263 omaha_request_action.cc:269] Request: Dec 12 23:05:23.062273 update_engine[1263]: Dec 12 23:05:23.062273 update_engine[1263]: Dec 12 23:05:23.062273 update_engine[1263]: Dec 12 23:05:23.062273 update_engine[1263]: Dec 12 23:05:23.062273 update_engine[1263]: Dec 12 23:05:23.062273 update_engine[1263]: Dec 12 23:05:23.062273 update_engine[1263]: I1212 23:05:23.062234 1263 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Dec 12 23:05:23.062411 update_engine[1263]: I1212 23:05:23.062288 1263 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Dec 12 23:05:23.062411 update_engine[1263]: I1212 23:05:23.062390 1263 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Dec 12 23:05:23.173750 update_engine[1263]: I1212 23:05:23.173707 1263 libcurl_http_fetcher.cc:248] HTTP response code: 200 Dec 12 23:05:23.173861 update_engine[1263]: I1212 23:05:23.173779 1263 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Dec 12 23:05:23.173861 update_engine[1263]: I1212 23:05:23.173785 1263 omaha_request_action.cc:619] Omaha request response: Dec 12 23:05:23.173861 update_engine[1263]: Dec 12 23:05:23.173861 update_engine[1263]: Dec 12 23:05:23.173861 update_engine[1263]: Dec 12 23:05:23.173861 update_engine[1263]: Dec 12 23:05:23.173861 update_engine[1263]: Dec 12 23:05:23.173861 update_engine[1263]: Dec 12 23:05:23.173861 update_engine[1263]: E1212 23:05:23.173797 1263 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Dec 12 23:05:23.173861 update_engine[1263]: I1212 23:05:23.173801 1263 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Dec 12 23:05:23.173861 update_engine[1263]: I1212 23:05:23.173804 1263 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Dec 12 23:05:23.173861 update_engine[1263]: I1212 23:05:23.173807 1263 update_attempter.cc:302] Processing Done. Dec 12 23:05:23.173861 update_engine[1263]: I1212 23:05:23.173812 1263 update_attempter.cc:306] Error event sent. Dec 12 23:05:31.383675 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:50960). Dec 12 23:05:31.428760 sshd[1297]: Accepted publickey for core from 10.0.0.1 port 50960 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:31.431975 kernel: kauditd_printk_skb: 287 callbacks suppressed Dec 12 23:05:31.432057 kernel: audit: type=1006 audit(1765580731.428:359): pid=1297 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 23:05:31.432504 sshd[1297]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:31.435518 systemd-logind[910]: New session 26 of user core. Dec 12 23:05:31.443210 systemd[1]: Started Session 26 of User core. Dec 12 23:05:31.504895 sshd[1297]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:31.519833 systemd[1]: sshd@25-10.0.0.6:22-10.0.0.1:50960.service: Deactivated successfully. Dec 12 23:05:31.520703 systemd[1]: session-26.scope: Deactivated successfully. Dec 12 23:05:31.521316 systemd-logind[910]: Session 26 logged out. Waiting for processes to exit. Dec 12 23:05:31.523186 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:50976). Dec 12 23:05:31.523849 systemd-logind[910]: Removed session 26. Dec 12 23:05:31.564288 sshd[1304]: Accepted publickey for core from 10.0.0.1 port 50976 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:31.565396 sshd[1304]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:31.567037 kernel: audit: type=1006 audit(1765580731.564:360): pid=1304 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 23:05:31.569097 systemd-logind[910]: New session 27 of user core. Dec 12 23:05:31.577211 systemd[1]: Started Session 27 of User core. Dec 12 23:05:31.632288 sshd[1304]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:31.644167 systemd[1]: sshd@26-10.0.0.6:22-10.0.0.1:50976.service: Deactivated successfully. Dec 12 23:05:31.644931 systemd[1]: session-27.scope: Deactivated successfully. Dec 12 23:05:31.645645 systemd-logind[910]: Session 27 logged out. Waiting for processes to exit. Dec 12 23:05:31.646647 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:50982). Dec 12 23:05:31.647342 systemd-logind[910]: Removed session 27. Dec 12 23:05:31.689290 sshd[1312]: Accepted publickey for core from 10.0.0.1 port 50982 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:31.690345 sshd[1312]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:31.692046 kernel: audit: type=1006 audit(1765580731.688:361): pid=1312 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 23:05:31.693836 systemd-logind[910]: New session 28 of user core. Dec 12 23:05:31.712230 systemd[1]: Started Session 28 of User core. Dec 12 23:05:31.799083 sshd[1312]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:31.813857 systemd[1]: sshd@27-10.0.0.6:22-10.0.0.1:50982.service: Deactivated successfully. Dec 12 23:05:31.815320 systemd[1]: session-28.scope: Deactivated successfully. Dec 12 23:05:31.816218 systemd-logind[910]: Session 28 logged out. Waiting for processes to exit. Dec 12 23:05:31.822071 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:50998). Dec 12 23:05:31.823646 systemd-logind[910]: Removed session 28. Dec 12 23:05:31.863072 sshd[1318]: Accepted publickey for core from 10.0.0.1 port 50998 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:31.864517 sshd[1318]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:31.867028 kernel: audit: type=1006 audit(1765580731.863:362): pid=1318 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 23:05:31.871111 systemd-logind[910]: New session 29 of user core. Dec 12 23:05:31.887227 systemd[1]: Started Session 29 of User core. Dec 12 23:05:31.940609 sshd[1318]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:31.953815 systemd[1]: sshd@28-10.0.0.6:22-10.0.0.1:50998.service: Deactivated successfully. Dec 12 23:05:31.954407 systemd[1]: session-29.scope: Deactivated successfully. Dec 12 23:05:31.955195 systemd-logind[910]: Session 29 logged out. Waiting for processes to exit. Dec 12 23:05:31.969801 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:51010). Dec 12 23:05:31.970592 systemd-logind[910]: Removed session 29. Dec 12 23:05:32.024706 sshd[1324]: Accepted publickey for core from 10.0.0.1 port 51010 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:32.026360 sshd[1324]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:32.027048 kernel: audit: type=1006 audit(1765580732.024:363): pid=1324 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 23:05:32.030427 systemd-logind[910]: New session 30 of user core. Dec 12 23:05:32.039217 systemd[1]: Started Session 30 of User core. Dec 12 23:05:32.091447 sudo[1328]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Dec 12 23:05:32.091683 sudo[1328]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 23:05:32.097743 systemd[1]: sshd.socket: Deactivated successfully. Dec 12 23:05:32.098177 systemd[1]: Closed OpenSSH Server Socket. Dec 12 23:05:32.099249 sudo[1328]: pam_unix(sudo:session): session closed for user root Dec 12 23:05:32.102831 sudo[1327]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Dec 12 23:05:32.103055 sudo[1327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 23:05:32.129292 sshd[945]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:32.130053 systemd[1]: Stopping Session 1 of User core... Dec 12 23:05:32.132241 systemd[1]: Stopping Session 30 of User core... Dec 12 23:05:32.133277 systemd[1]: Removed slice Slice /system/addon-config. Dec 12 23:05:32.134735 sshd[1324]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:32.135306 sudo[1327]: pam_unix(sudo:session): session closed for user root Dec 12 23:05:32.135350 systemd[1]: Removed slice Slice /system/addon-run. Dec 12 23:05:32.137350 systemd[1]: Removed slice Slice /system/modprobe. Dec 12 23:05:32.138434 systemd[1]: Removed slice Slice /system/system-cloudinit. Dec 12 23:05:32.139438 systemd[1]: Stopped target Multi-User System. Dec 12 23:05:32.140214 systemd[1]: Stopped target Login Prompts. Dec 12 23:05:32.140904 systemd[1]: Stopped target Containers. Dec 12 23:05:32.141640 systemd[1]: Stopped target Host and Network Name Lookups. Dec 12 23:05:32.142512 systemd[1]: Stopped target Remote Encrypted Volumes. Dec 12 23:05:32.143751 systemd[1]: Stopped target Timer Units. Dec 12 23:05:32.144580 systemd[1]: logrotate.timer: Deactivated successfully. Dec 12 23:05:32.144678 systemd[1]: Stopped Daily Log Rotation. Dec 12 23:05:32.145500 systemd[1]: mdadm.timer: Deactivated successfully. Dec 12 23:05:32.145563 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Dec 12 23:05:32.146661 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Dec 12 23:05:32.146702 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Dec 12 23:05:32.147839 systemd[1]: Stopped target System Time Set. Dec 12 23:05:32.148641 systemd[1]: Stopped target Load user-provided cloud configs. Dec 12 23:05:32.149556 systemd[1]: Stopped target Load system-provided cloud configs. Dec 12 23:05:32.150517 systemd[1]: systemd-coredump.socket: Deactivated successfully. Dec 12 23:05:32.150672 systemd[1]: Closed Process Core Dump Socket. Dec 12 23:05:32.158472 systemd[1]: Unmounting Boot partition... Dec 12 23:05:32.159399 systemd[1]: Stopping Getty on tty1... Dec 12 23:05:32.160231 systemd[1]: Stopping Serial Getty on ttyAMA0... Dec 12 23:05:32.161118 systemd[1]: Stopping OpenSSH per-connection server daemon... Dec 12 23:05:32.161900 sshd[1324]: pam_systemd(sshd:session): Failed to release session: Interrupted system call Dec 12 23:05:32.164576 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:51010)... Dec 12 23:05:32.165392 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Dec 12 23:05:32.165524 systemd[1]: Stopped Commit a transient machine-id on disk. Dec 12 23:05:32.166497 systemd[1]: Stopped target First Boot Complete. Dec 12 23:05:32.168419 systemd[1]: Stopping Load/Save Random Seed... Dec 12 23:05:32.169754 systemd[1]: Stopping Update Engine... Dec 12 23:05:32.173053 systemd[1]: getty@tty1.service: Deactivated successfully. Dec 12 23:05:32.173249 systemd[1]: Stopped Getty on tty1. Dec 12 23:05:32.174337 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Dec 12 23:05:32.174528 systemd[1]: Stopped Serial Getty on ttyAMA0. Dec 12 23:05:32.175848 systemd[1]: sshd@0-10.0.0.6:22-10.0.0.1:51504.service: Deactivated successfully. Dec 12 23:05:32.176114 systemd[1]: Stopped OpenSSH per-connection server daemon. Dec 12 23:05:32.178029 systemd[1]: sshd@29-10.0.0.6:22-10.0.0.1:51010.service: Deactivated successfully. Dec 12 23:05:32.178209 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:51010). Dec 12 23:05:32.190444 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Dec 12 23:05:32.190517 systemd[1]: update-engine.service: Failed with result 'exit-code'. Dec 12 23:05:32.190788 systemd[1]: Stopped Update Engine. Dec 12 23:05:32.191461 systemd[1]: update-engine.service: Consumed 2.291s CPU time. Dec 12 23:05:32.191967 systemd[1]: systemd-random-seed.service: Deactivated successfully. Dec 12 23:05:32.192190 systemd[1]: Stopped Load/Save Random Seed. Dec 12 23:05:32.193102 systemd[1]: session-30.scope: Deactivated successfully. Dec 12 23:05:32.193332 systemd[1]: Stopped Session 30 of User core. Dec 12 23:05:32.194211 systemd[1]: session-1.scope: Deactivated successfully. Dec 12 23:05:32.194449 systemd[1]: Stopped Session 1 of User core. Dec 12 23:05:32.195836 systemd-logind[910]: Session 1 logged out. Waiting for processes to exit. Dec 12 23:05:32.196522 systemd-logind[910]: Session 30 logged out. Waiting for processes to exit. Dec 12 23:05:32.196724 systemd[1]: Removed slice Slice /system/getty. Dec 12 23:05:32.197738 systemd[1]: Removed slice Slice /system/serial-getty. Dec 12 23:05:32.198995 systemd[1]: Removed slice Slice /system/sshd. Dec 12 23:05:32.199695 systemd[1]: sshd-keygen.service: Deactivated successfully. Dec 12 23:05:32.199804 systemd[1]: Stopped Generate sshd host keys. Dec 12 23:05:32.200691 systemd[1]: Stopping User Login Management... Dec 12 23:05:32.201338 systemd[1]: Stopping User Manager for UID 500... Dec 12 23:05:32.204933 systemd-logind[910]: Removed session 30. Dec 12 23:05:32.205833 systemd[948]: Stopped target Main User Target. Dec 12 23:05:32.205852 systemd[948]: Stopped target Basic System. Dec 12 23:05:32.205862 systemd[948]: Stopped target Paths. Dec 12 23:05:32.205870 systemd[948]: Stopped target Sockets. Dec 12 23:05:32.205885 systemd[948]: Reached target Shutdown. Dec 12 23:05:32.205892 systemd[948]: Stopped target Timers. Dec 12 23:05:32.206004 systemd[948]: Finished Exit the Session. Dec 12 23:05:32.206079 systemd[948]: Reached target Exit the Session. Dec 12 23:05:32.209926 systemd[1]: boot.mount: Deactivated successfully. Dec 12 23:05:32.210213 systemd[1]: Unmounted Boot partition. Dec 12 23:05:32.211076 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Dec 12 23:05:32.211143 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Dec 12 23:05:32.213222 systemd[1]: user@500.service: Deactivated successfully. Dec 12 23:05:32.213539 systemd[1]: Stopped User Manager for UID 500. Dec 12 23:05:32.215126 systemd[1]: Stopping User Runtime Directory /run/user/500... Dec 12 23:05:32.222481 systemd[1]: run-user-500.mount: Deactivated successfully. Dec 12 23:05:32.222555 systemd[1]: Unmounted /run/user/500. Dec 12 23:05:32.223807 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Dec 12 23:05:32.224038 systemd[1]: Stopped User Runtime Directory /run/user/500. Dec 12 23:05:32.225310 systemd[1]: Removed slice User Slice of UID 500. Dec 12 23:05:32.226850 systemd[1]: Stopping D-Bus System Message Bus... Dec 12 23:05:32.228426 systemd[1]: Stopping Permit User Sessions... Dec 12 23:05:32.229538 systemd[1]: systemd-logind.service: Deactivated successfully. Dec 12 23:05:32.229811 systemd[1]: Stopped User Login Management. Dec 12 23:05:32.230971 systemd[1]: dbus.service: Deactivated successfully. Dec 12 23:05:32.231227 systemd[1]: Stopped D-Bus System Message Bus. Dec 12 23:05:32.232000 audit: BPF prog-id=59 op=UNLOAD Dec 12 23:05:32.234063 kernel: audit: type=1334 audit(1765580732.232:364): prog-id=59 op=UNLOAD Dec 12 23:05:32.234763 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Dec 12 23:05:32.234977 systemd[1]: Stopped Permit User Sessions. Dec 12 23:05:32.236035 systemd[1]: Stopped target Basic System. Dec 12 23:05:32.236635 systemd[1]: Stopped target Network. Dec 12 23:05:32.237189 systemd[1]: Stopped target Path Units. Dec 12 23:05:32.237742 systemd[1]: motdgen.path: Deactivated successfully. Dec 12 23:05:32.242097 systemd[1]: Stopped Watch for update engine configuration changes. Dec 12 23:05:32.242924 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Dec 12 23:05:32.244078 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 12 23:05:32.245008 systemd[1]: Stopped target Remote File Systems. Dec 12 23:05:32.245759 systemd[1]: Stopped target Slice Units. Dec 12 23:05:32.246787 systemd[1]: Removed slice User and Session Slice. Dec 12 23:05:32.247920 systemd[1]: Stopped target Socket Units. Dec 12 23:05:32.248668 systemd[1]: dbus.socket: Deactivated successfully. Dec 12 23:05:32.248796 systemd[1]: Closed D-Bus System Message Bus Socket. Dec 12 23:05:32.249717 systemd[1]: docker.socket: Deactivated successfully. Dec 12 23:05:32.250059 systemd[1]: Closed Docker Socket for the API. Dec 12 23:05:32.250811 systemd[1]: Stopped target System Initialization. Dec 12 23:05:32.251806 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Dec 12 23:05:32.252048 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Dec 12 23:05:32.252954 systemd[1]: Stopped target Local Verity Protected Volumes. Dec 12 23:05:32.254966 systemd[1]: Stopping Load Security Auditing Rules... Dec 12 23:05:32.256249 systemd[1]: Stopping Network Name Resolution... Dec 12 23:05:32.256975 auditctl[1343]: No rules Dec 12 23:05:32.257448 systemd[1]: Stopping Network Time Synchronization... Dec 12 23:05:32.258252 systemd[1]: systemd-update-done.service: Deactivated successfully. Dec 12 23:05:32.258393 systemd[1]: Stopped Update is Completed. Dec 12 23:05:32.259099 systemd[1]: ldconfig.service: Deactivated successfully. Dec 12 23:05:32.259224 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Dec 12 23:05:32.259954 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Dec 12 23:05:32.260101 systemd[1]: Stopped Rebuild Hardware Database. Dec 12 23:05:32.261007 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Dec 12 23:05:32.261236 systemd[1]: Stopped Rebuild Journal Catalog. Dec 12 23:05:32.262987 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Dec 12 23:05:32.265525 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 12 23:05:32.265889 systemd[1]: Stopped Network Name Resolution. Dec 12 23:05:32.266995 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Dec 12 23:05:32.267346 systemd[1]: Stopped Network Time Synchronization. Dec 12 23:05:32.268508 systemd[1]: audit-rules.service: Deactivated successfully. Dec 12 23:05:32.268811 systemd[1]: Stopped Load Security Auditing Rules. Dec 12 23:05:32.268000 audit: BPF prog-id=57 op=UNLOAD Dec 12 23:05:32.271041 kernel: audit: type=1334 audit(1765580732.268:365): prog-id=57 op=UNLOAD Dec 12 23:05:32.271411 systemd[1]: Stopping Network Configuration... Dec 12 23:05:32.272336 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Dec 12 23:05:32.272641 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Dec 12 23:05:32.272000 audit: BPF prog-id=53 op=UNLOAD Dec 12 23:05:32.274871 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Dec 12 23:05:32.275050 kernel: audit: type=1334 audit(1765580732.272:366): prog-id=53 op=UNLOAD Dec 12 23:05:32.275106 systemd[1]: Stopped Create Volatile Files and Directories. Dec 12 23:05:32.275931 systemd[1]: Stopped target Local File Systems. Dec 12 23:05:32.276080 systemd-networkd[836]: eth0: DHCPv6 lease lost Dec 12 23:05:32.277955 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Dec 12 23:05:32.279410 systemd[1]: Unmounting External Media Directory... Dec 12 23:05:32.280905 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Dec 12 23:05:32.282794 systemd[1]: Unmounting /run/torcx/unpack... Dec 12 23:05:32.283935 systemd[1]: Unmounting Temporary Directory /tmp... Dec 12 23:05:32.285247 systemd[1]: Unmounting /usr/share/oem... Dec 12 23:05:32.287113 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Dec 12 23:05:32.290553 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 12 23:05:32.290824 systemd[1]: Stopped Network Configuration. Dec 12 23:05:32.291736 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Dec 12 23:05:32.291978 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Dec 12 23:05:32.293240 systemd[1]: media.mount: Deactivated successfully. Dec 12 23:05:32.293498 systemd[1]: Unmounted External Media Directory. Dec 12 23:05:32.306280 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Dec 12 23:05:32.306571 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Dec 12 23:05:32.307871 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Dec 12 23:05:32.308145 systemd[1]: Unmounted /run/torcx/unpack. Dec 12 23:05:32.309314 systemd[1]: tmp.mount: Deactivated successfully. Dec 12 23:05:32.309591 systemd[1]: Unmounted Temporary Directory /tmp. Dec 12 23:05:32.310444 systemd[1]: usr-share-oem.mount: Deactivated successfully. Dec 12 23:05:32.310723 systemd[1]: Unmounted /usr/share/oem. Dec 12 23:05:32.311552 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Dec 12 23:05:32.311816 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Dec 12 23:05:32.312000 audit: BPF prog-id=58 op=UNLOAD Dec 12 23:05:32.313201 systemd[1]: Stopped target Swaps. Dec 12 23:05:32.314038 kernel: audit: type=1334 audit(1765580732.312:367): prog-id=58 op=UNLOAD Dec 12 23:05:32.314493 systemd[1]: Reached target Unmount All Filesystems. Dec 12 23:05:32.315256 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 12 23:05:32.315321 systemd[1]: Closed Network Service Netlink Socket. Dec 12 23:05:32.316058 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Dec 12 23:05:32.316125 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Dec 12 23:05:32.317225 systemd[1]: Removed slice Slice /system/systemd-fsck. Dec 12 23:05:32.317958 systemd[1]: Stopped target Preparation for Local File Systems. Dec 12 23:05:32.319192 systemd[1]: lvm2-activation.service: Deactivated successfully. Dec 12 23:05:32.319261 systemd[1]: Stopped Activation of LVM2 logical volumes. Dec 12 23:05:32.320026 systemd[1]: Stopped target Local Encrypted Volumes. Dec 12 23:05:32.320727 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 12 23:05:32.320810 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Dec 12 23:05:32.321757 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Dec 12 23:05:32.326210 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Dec 12 23:05:32.327156 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Dec 12 23:05:32.327234 systemd[1]: Stopped Activation of LVM2 logical volumes. Dec 12 23:05:32.328006 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 12 23:05:32.328078 systemd[1]: Stopped Apply Kernel Variables. Dec 12 23:05:32.328784 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 12 23:05:32.328841 systemd[1]: Stopped Create Static Device Nodes in /dev. Dec 12 23:05:32.329704 systemd[1]: systemd-sysusers.service: Deactivated successfully. Dec 12 23:05:32.329765 systemd[1]: Stopped Create System Users. Dec 12 23:05:32.330463 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Dec 12 23:05:32.330516 systemd[1]: Stopped Remount Root and Kernel File Systems. Dec 12 23:05:32.331527 systemd[1]: Reached target System Shutdown. Dec 12 23:05:32.332180 systemd[1]: Reached target Late Shutdown Services. Dec 12 23:05:32.332927 systemd[1]: systemd-reboot.service: Deactivated successfully. Dec 12 23:05:32.332965 systemd[1]: Finished System Reboot. Dec 12 23:05:32.333668 systemd[1]: Reached target System Reboot. Dec 12 23:05:32.334308 systemd[1]: Shutting down. Dec 12 23:05:32.334000 audit: BPF prog-id=56 op=UNLOAD Dec 12 23:05:32.334000 audit: BPF prog-id=55 op=UNLOAD Dec 12 23:05:32.334000 audit: BPF prog-id=54 op=UNLOAD Dec 12 23:05:32.337040 kernel: audit: type=1334 audit(1765580732.334:368): prog-id=56 op=UNLOAD Dec 12 23:05:32.337000 audit: BPF prog-id=61 op=UNLOAD Dec 12 23:05:32.337000 audit: BPF prog-id=60 op=UNLOAD Dec 12 23:05:32.339000 audit: BPF prog-id=64 op=UNLOAD Dec 12 23:05:32.339000 audit: BPF prog-id=63 op=UNLOAD Dec 12 23:05:32.339000 audit: BPF prog-id=62 op=UNLOAD Dec 12 23:05:32.381066 systemd-shutdown[1]: Syncing filesystems and block devices. Dec 12 23:05:32.387823 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Dec 12 23:05:32.387899 systemd-journald[799]: Journal stopped -- Reboot -- Dec 12 23:05:39.664873 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Dec 12 23:05:39.664889 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 23:05:39.664897 kernel: efi: EFI v2.70 by EDK II Dec 12 23:05:39.664902 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Dec 12 23:05:39.664907 kernel: efi: seeding entropy pool Dec 12 23:05:39.664912 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Dec 12 23:05:39.664918 kernel: ACPI: Early table checksum verification disabled Dec 12 23:05:39.664923 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Dec 12 23:05:39.664928 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Dec 12 23:05:39.664933 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:39.664939 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:39.664944 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:39.664949 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:39.664954 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:39.664960 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:39.664965 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:39.664971 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:39.664977 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Dec 12 23:05:39.664982 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Dec 12 23:05:39.664987 kernel: ACPI: NUMA: Failed to initialise from firmware Dec 12 23:05:39.664993 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 23:05:39.664998 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Dec 12 23:05:39.665003 kernel: Zone ranges: Dec 12 23:05:39.665008 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 23:05:39.665013 kernel: DMA32 empty Dec 12 23:05:39.665018 kernel: Normal empty Dec 12 23:05:39.665023 kernel: Movable zone start for each node Dec 12 23:05:39.665030 kernel: Early memory node ranges Dec 12 23:05:39.665035 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Dec 12 23:05:39.665040 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Dec 12 23:05:39.665045 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Dec 12 23:05:39.665051 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Dec 12 23:05:39.665056 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Dec 12 23:05:39.665061 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Dec 12 23:05:39.665066 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Dec 12 23:05:39.665071 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Dec 12 23:05:39.665076 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Dec 12 23:05:39.665081 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Dec 12 23:05:39.665087 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Dec 12 23:05:39.665092 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Dec 12 23:05:39.665100 kernel: On node 0 totalpages: 643072 Dec 12 23:05:39.665106 kernel: DMA zone: 10048 pages used for memmap Dec 12 23:05:39.665112 kernel: DMA zone: 0 pages reserved Dec 12 23:05:39.665117 kernel: DMA zone: 643072 pages, LIFO batch:63 Dec 12 23:05:39.665135 kernel: psci: probing for conduit method from ACPI. Dec 12 23:05:39.665140 kernel: psci: PSCIv1.1 detected in firmware. Dec 12 23:05:39.665146 kernel: psci: Using standard PSCI v0.2 function IDs Dec 12 23:05:39.665151 kernel: psci: Trusted OS migration not required Dec 12 23:05:39.665159 kernel: psci: SMC Calling Convention v1.1 Dec 12 23:05:39.665164 kernel: ACPI: SRAT not present Dec 12 23:05:39.665170 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Dec 12 23:05:39.665175 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Dec 12 23:05:39.665181 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 12 23:05:39.665186 kernel: Detected PIPT I-cache on CPU0 Dec 12 23:05:39.665192 kernel: CPU features: detected: GIC system register CPU interface Dec 12 23:05:39.665197 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 12 23:05:39.665203 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 12 23:05:39.665208 kernel: CPU features: detected: Hardware dirty bit management Dec 12 23:05:39.665213 kernel: CPU features: detected: Spectre-v4 Dec 12 23:05:39.665220 kernel: CPU features: detected: ARM erratum 1418040 Dec 12 23:05:39.665226 kernel: CPU features: detected: Spectre-BHB Dec 12 23:05:39.665231 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Dec 12 23:05:39.665236 kernel: Policy zone: DMA Dec 12 23:05:39.665243 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 23:05:39.665249 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 12 23:05:39.665254 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 12 23:05:39.665260 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 12 23:05:39.665266 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Dec 12 23:05:39.665271 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Dec 12 23:05:39.665277 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 12 23:05:39.665283 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 12 23:05:39.665289 kernel: rcu: RCU event tracing is enabled. Dec 12 23:05:39.665295 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Dec 12 23:05:39.665300 kernel: Trampoline variant of Tasks RCU enabled. Dec 12 23:05:39.665306 kernel: Tracing variant of Tasks RCU enabled. Dec 12 23:05:39.665312 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 12 23:05:39.665317 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 12 23:05:39.665323 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 12 23:05:39.665328 kernel: GICv3: 256 SPIs implemented Dec 12 23:05:39.665334 kernel: GICv3: 0 Extended SPIs implemented Dec 12 23:05:39.665340 kernel: GICv3: Distributor has no Range Selector support Dec 12 23:05:39.665345 kernel: GICv3: 16 PPIs implemented Dec 12 23:05:39.665352 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Dec 12 23:05:39.665357 kernel: ACPI: SRAT not present Dec 12 23:05:39.665362 kernel: ITS [mem 0x08080000-0x0809ffff] Dec 12 23:05:39.665368 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Dec 12 23:05:39.665374 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Dec 12 23:05:39.665379 kernel: GICv3: using LPI property table @0x00000000400d0000 Dec 12 23:05:39.665385 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Dec 12 23:05:39.665390 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 23:05:39.665397 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Dec 12 23:05:39.665402 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Dec 12 23:05:39.665408 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Dec 12 23:05:39.665414 kernel: arm-pv: using stolen time PV Dec 12 23:05:39.665421 kernel: Console: colour dummy device 80x25 Dec 12 23:05:39.665426 kernel: ACPI: Core revision 20200925 Dec 12 23:05:39.665432 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Dec 12 23:05:39.665438 kernel: pid_max: default: 32768 minimum: 301 Dec 12 23:05:39.665444 kernel: LSM: Security Framework initializing Dec 12 23:05:39.665449 kernel: SELinux: Initializing. Dec 12 23:05:39.665455 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 12 23:05:39.665461 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 12 23:05:39.665467 kernel: rcu: Hierarchical SRCU implementation. Dec 12 23:05:39.665478 kernel: Platform MSI: ITS@0x8080000 domain created Dec 12 23:05:39.665485 kernel: PCI/MSI: ITS@0x8080000 domain created Dec 12 23:05:39.665491 kernel: Remapping and enabling EFI services. Dec 12 23:05:39.665496 kernel: smp: Bringing up secondary CPUs ... Dec 12 23:05:39.665502 kernel: Detected PIPT I-cache on CPU1 Dec 12 23:05:39.665508 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Dec 12 23:05:39.665514 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Dec 12 23:05:39.665520 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 23:05:39.665525 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Dec 12 23:05:39.665531 kernel: Detected PIPT I-cache on CPU2 Dec 12 23:05:39.665539 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Dec 12 23:05:39.665545 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Dec 12 23:05:39.665550 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 23:05:39.665556 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Dec 12 23:05:39.665562 kernel: Detected PIPT I-cache on CPU3 Dec 12 23:05:39.665572 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Dec 12 23:05:39.665578 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Dec 12 23:05:39.665585 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 12 23:05:39.665591 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Dec 12 23:05:39.665597 kernel: smp: Brought up 1 node, 4 CPUs Dec 12 23:05:39.665603 kernel: SMP: Total of 4 processors activated. Dec 12 23:05:39.665609 kernel: CPU features: detected: Privileged Access Never Dec 12 23:05:39.665615 kernel: CPU features: detected: LSE atomic instructions Dec 12 23:05:39.665621 kernel: CPU features: detected: User Access Override Dec 12 23:05:39.665627 kernel: CPU features: detected: 32-bit EL0 Support Dec 12 23:05:39.665633 kernel: CPU features: detected: Common not Private translations Dec 12 23:05:39.665639 kernel: CPU features: detected: RAS Extension Support Dec 12 23:05:39.665646 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 12 23:05:39.665652 kernel: CPU features: detected: CRC32 instructions Dec 12 23:05:39.665658 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 12 23:05:39.665664 kernel: CPU: All CPU(s) started at EL1 Dec 12 23:05:39.665671 kernel: alternatives: patching kernel code Dec 12 23:05:39.665678 kernel: devtmpfs: initialized Dec 12 23:05:39.665684 kernel: KASLR enabled Dec 12 23:05:39.665690 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 12 23:05:39.665696 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 12 23:05:39.665702 kernel: pinctrl core: initialized pinctrl subsystem Dec 12 23:05:39.665708 kernel: SMBIOS 3.0.0 present. Dec 12 23:05:39.665714 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Dec 12 23:05:39.665720 kernel: NET: Registered protocol family 16 Dec 12 23:05:39.665727 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 12 23:05:39.665733 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 12 23:05:39.665744 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 12 23:05:39.665751 kernel: audit: initializing netlink subsys (disabled) Dec 12 23:05:39.665757 kernel: audit: type=2000 audit(0.031:1): state=initialized audit_enabled=0 res=1 Dec 12 23:05:39.665763 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 12 23:05:39.665769 kernel: cpuidle: using governor menu Dec 12 23:05:39.665775 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 12 23:05:39.665781 kernel: ASID allocator initialised with 32768 entries Dec 12 23:05:39.665787 kernel: ACPI: bus type PCI registered Dec 12 23:05:39.665793 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 12 23:05:39.665800 kernel: Serial: AMBA PL011 UART driver Dec 12 23:05:39.665807 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Dec 12 23:05:39.665813 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Dec 12 23:05:39.665818 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Dec 12 23:05:39.665824 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Dec 12 23:05:39.665830 kernel: cryptd: max_cpu_qlen set to 1000 Dec 12 23:05:39.665836 kernel: ACPI: Added _OSI(Module Device) Dec 12 23:05:39.665842 kernel: ACPI: Added _OSI(Processor Device) Dec 12 23:05:39.665848 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Dec 12 23:05:39.665855 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 12 23:05:39.665861 kernel: ACPI: Added _OSI(Linux-Dell-Video) Dec 12 23:05:39.665867 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Dec 12 23:05:39.665873 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Dec 12 23:05:39.665879 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 12 23:05:39.665885 kernel: ACPI: Interpreter enabled Dec 12 23:05:39.665892 kernel: ACPI: Using GIC for interrupt routing Dec 12 23:05:39.665897 kernel: ACPI: MCFG table detected, 1 entries Dec 12 23:05:39.665903 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Dec 12 23:05:39.665909 kernel: printk: console [ttyAMA0] enabled Dec 12 23:05:39.665917 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Dec 12 23:05:39.666029 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 12 23:05:39.666090 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 12 23:05:39.666156 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 12 23:05:39.666215 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Dec 12 23:05:39.666273 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Dec 12 23:05:39.666282 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Dec 12 23:05:39.666292 kernel: PCI host bridge to bus 0000:00 Dec 12 23:05:39.666361 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Dec 12 23:05:39.666434 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 12 23:05:39.666492 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Dec 12 23:05:39.666543 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 12 23:05:39.666610 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Dec 12 23:05:39.666673 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Dec 12 23:05:39.666735 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Dec 12 23:05:39.666792 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Dec 12 23:05:39.666849 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Dec 12 23:05:39.666906 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Dec 12 23:05:39.666962 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Dec 12 23:05:39.667018 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Dec 12 23:05:39.667069 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Dec 12 23:05:39.667131 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 12 23:05:39.667188 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Dec 12 23:05:39.667196 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Dec 12 23:05:39.667214 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Dec 12 23:05:39.667221 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Dec 12 23:05:39.667227 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Dec 12 23:05:39.667235 kernel: vgaarb: loaded Dec 12 23:05:39.667248 kernel: Registered efivars operations Dec 12 23:05:39.667257 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 12 23:05:39.667265 kernel: VFS: Disk quotas dquot_6.6.0 Dec 12 23:05:39.667271 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 12 23:05:39.667277 kernel: pnp: PnP ACPI init Dec 12 23:05:39.667336 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Dec 12 23:05:39.667418 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Dec 12 23:05:39.667428 kernel: pnp: PnP ACPI: found 1 devices Dec 12 23:05:39.667434 kernel: NET: Registered protocol family 2 Dec 12 23:05:39.667440 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 12 23:05:39.667449 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 12 23:05:39.667455 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 12 23:05:39.667461 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Dec 12 23:05:39.667467 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 12 23:05:39.667479 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 12 23:05:39.667486 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 12 23:05:39.667492 kernel: NET: Registered protocol family 1 Dec 12 23:05:39.667498 kernel: PCI: CLS 0 bytes, default 64 Dec 12 23:05:39.667505 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Dec 12 23:05:39.667512 kernel: kvm [1]: HYP mode not available Dec 12 23:05:39.667518 kernel: Initialise system trusted keyrings Dec 12 23:05:39.667524 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 12 23:05:39.667530 kernel: Key type asymmetric registered Dec 12 23:05:39.667536 kernel: Asymmetric key parser 'x509' registered Dec 12 23:05:39.667542 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Dec 12 23:05:39.667548 kernel: io scheduler mq-deadline registered Dec 12 23:05:39.667554 kernel: io scheduler kyber registered Dec 12 23:05:39.667560 kernel: io scheduler bfq registered Dec 12 23:05:39.667568 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 12 23:05:39.667574 kernel: ACPI: Power Button [PWRB] Dec 12 23:05:39.667581 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Dec 12 23:05:39.667642 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Dec 12 23:05:39.667651 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 12 23:05:39.667657 kernel: msm_serial: driver initialized Dec 12 23:05:39.667663 kernel: random: fast init done Dec 12 23:05:39.667669 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Dec 12 23:05:39.667675 kernel: random: crng init done Dec 12 23:05:39.667681 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Dec 12 23:05:39.667689 kernel: thunder_xcv, ver 1.0 Dec 12 23:05:39.667695 kernel: thunder_bgx, ver 1.0 Dec 12 23:05:39.667701 kernel: nicpf, ver 1.0 Dec 12 23:05:39.667707 kernel: nicvf, ver 1.0 Dec 12 23:05:39.667773 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 12 23:05:39.667826 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-12-12T23:05:39 UTC (1765580739) Dec 12 23:05:39.667835 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 12 23:05:39.667841 kernel: NET: Registered protocol family 10 Dec 12 23:05:39.667849 kernel: Segment Routing with IPv6 Dec 12 23:05:39.667855 kernel: NET: Registered protocol family 17 Dec 12 23:05:39.667861 kernel: Key type dns_resolver registered Dec 12 23:05:39.667866 kernel: registered taskstats version 1 Dec 12 23:05:39.667872 kernel: Loading compiled-in X.509 certificates Dec 12 23:05:39.667879 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Dec 12 23:05:39.667885 kernel: Key type ._fscrypt registered Dec 12 23:05:39.667891 kernel: Key type .fscrypt registered Dec 12 23:05:39.667897 kernel: Key type fscrypt-provisioning registered Dec 12 23:05:39.667904 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 12 23:05:39.667910 kernel: ima: Allocated hash algorithm: sha1 Dec 12 23:05:39.667916 kernel: ima: No architecture policies found Dec 12 23:05:39.667922 kernel: Freeing unused kernel memory: 34240K Dec 12 23:05:39.667928 kernel: Run /init as init process Dec 12 23:05:39.667934 kernel: with arguments: Dec 12 23:05:39.667939 kernel: /init Dec 12 23:05:39.667945 kernel: with environment: Dec 12 23:05:39.667951 kernel: HOME=/ Dec 12 23:05:39.667957 kernel: TERM=linux Dec 12 23:05:39.667964 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Dec 12 23:05:39.667972 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 23:05:39.667980 systemd[1]: Detected virtualization kvm. Dec 12 23:05:39.667987 systemd[1]: Detected architecture arm64. Dec 12 23:05:39.667993 systemd[1]: Running in initial RAM disk. Dec 12 23:05:39.668000 systemd[1]: No hostname configured, using default hostname. Dec 12 23:05:39.668006 systemd[1]: Hostname set to . Dec 12 23:05:39.668014 systemd[1]: Initializing machine ID from VM UUID. Dec 12 23:05:39.668020 systemd[1]: Queued start job for default target Initrd Default Target. Dec 12 23:05:39.668027 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Dec 12 23:05:39.668033 systemd[1]: Reached target Local Encrypted Volumes. Dec 12 23:05:39.668039 systemd[1]: Reached target Path Units. Dec 12 23:05:39.668046 systemd[1]: Reached target Slice Units. Dec 12 23:05:39.668052 systemd[1]: Reached target Swaps. Dec 12 23:05:39.668058 systemd[1]: Reached target Timer Units. Dec 12 23:05:39.668066 systemd[1]: Listening on Open-iSCSI iscsid Socket. Dec 12 23:05:39.668073 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Dec 12 23:05:39.668079 systemd[1]: Listening on Journal Audit Socket. Dec 12 23:05:39.668086 systemd[1]: Listening on Journal Socket (/dev/log). Dec 12 23:05:39.668092 systemd[1]: Listening on Journal Socket. Dec 12 23:05:39.668098 systemd[1]: Listening on udev Control Socket. Dec 12 23:05:39.668105 systemd[1]: Listening on udev Kernel Socket. Dec 12 23:05:39.668111 systemd[1]: Reached target Socket Units. Dec 12 23:05:39.668118 systemd[1]: Starting iSCSI UserSpace I/O driver... Dec 12 23:05:39.668152 systemd[1]: Starting Create List of Static Device Nodes... Dec 12 23:05:39.668159 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Dec 12 23:05:39.668165 systemd[1]: Starting Journal Service... Dec 12 23:05:39.668172 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Dec 12 23:05:39.668195 systemd[1]: Starting Apply Kernel Variables... Dec 12 23:05:39.668202 systemd[1]: Starting Setup Virtual Console... Dec 12 23:05:39.668209 systemd[1]: Started iSCSI UserSpace I/O driver. Dec 12 23:05:39.668215 systemd[1]: Finished Create List of Static Device Nodes. Dec 12 23:05:39.668221 kernel: SCSI subsystem initialized Dec 12 23:05:39.668227 kernel: Loading iSCSI transport class v2.0-870. Dec 12 23:05:39.668235 systemd[1]: Finished Apply Kernel Variables. Dec 12 23:05:39.668244 systemd-journald[270]: Journal started Dec 12 23:05:39.668284 systemd-journald[270]: Runtime Journal (/run/log/journal/c312ca44bdae4a0f8fd7bebfcc5a72b7) is 6.0M, max 48.5M, 42.4M free. Dec 12 23:05:39.669518 systemd[1]: Finished Setup Virtual Console. Dec 12 23:05:39.670137 systemd[1]: Started Journal Service. Dec 12 23:05:39.671465 systemd[1]: Starting dracut ask for additional cmdline parameters... Dec 12 23:05:39.672788 systemd[1]: Starting Create Static Device Nodes in /dev... Dec 12 23:05:39.676075 systemd[1]: Finished Create Static Device Nodes in /dev. Dec 12 23:05:39.687489 systemd[1]: Finished dracut ask for additional cmdline parameters. Dec 12 23:05:39.688918 systemd[1]: Starting dracut cmdline hook... Dec 12 23:05:39.697377 dracut-cmdline[289]: dracut-dracut-053 Dec 12 23:05:39.699678 dracut-cmdline[289]: 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 23:05:39.757145 kernel: iscsi: registered transport (tcp) Dec 12 23:05:39.768377 kernel: iscsi: registered transport (qla4xxx) Dec 12 23:05:39.768403 kernel: QLogic iSCSI HBA Driver Dec 12 23:05:39.778553 systemd[1]: Finished dracut cmdline hook. Dec 12 23:05:39.779938 systemd[1]: Starting dracut pre-udev hook... Dec 12 23:05:39.781155 systemd[1]: Starting Open-iSCSI... Dec 12 23:05:39.783467 iscsid[374]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Dec 12 23:05:39.783467 iscsid[374]: 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 23:05:39.783467 iscsid[374]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Dec 12 23:05:39.783467 iscsid[374]: If using hardware iscsi like qla4xxx this message can be ignored. Dec 12 23:05:39.783467 iscsid[374]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Dec 12 23:05:39.792013 iscsid[374]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Dec 12 23:05:39.786952 systemd[1]: Started Open-iSCSI. Dec 12 23:05:39.795075 kernel: device-mapper: uevent: version 1.0.3 Dec 12 23:05:39.795092 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Dec 12 23:05:39.829143 kernel: raid6: neonx8 gen() 13700 MB/s Dec 12 23:05:39.846135 kernel: raid6: neonx8 xor() 10753 MB/s Dec 12 23:05:39.863145 kernel: raid6: neonx4 gen() 13621 MB/s Dec 12 23:05:39.880146 kernel: raid6: neonx4 xor() 11592 MB/s Dec 12 23:05:39.897156 kernel: raid6: neonx2 gen() 13035 MB/s Dec 12 23:05:39.914169 kernel: raid6: neonx2 xor() 9874 MB/s Dec 12 23:05:39.931168 kernel: raid6: neonx1 gen() 10958 MB/s Dec 12 23:05:39.948156 kernel: raid6: neonx1 xor() 8820 MB/s Dec 12 23:05:39.965178 kernel: raid6: int64x8 gen() 6808 MB/s Dec 12 23:05:39.982145 kernel: raid6: int64x8 xor() 3780 MB/s Dec 12 23:05:39.999163 kernel: raid6: int64x4 gen() 6884 MB/s Dec 12 23:05:40.016148 kernel: raid6: int64x4 xor() 3812 MB/s Dec 12 23:05:40.033140 kernel: raid6: int64x2 gen() 6184 MB/s Dec 12 23:05:40.050164 kernel: raid6: int64x2 xor() 3301 MB/s Dec 12 23:05:40.067161 kernel: raid6: int64x1 gen() 4981 MB/s Dec 12 23:05:40.084521 kernel: raid6: int64x1 xor() 2595 MB/s Dec 12 23:05:40.084553 kernel: raid6: using algorithm neonx8 gen() 13700 MB/s Dec 12 23:05:40.084562 kernel: raid6: .... xor() 10753 MB/s, rmw enabled Dec 12 23:05:40.084570 kernel: raid6: using neon recovery algorithm Dec 12 23:05:40.095153 kernel: xor: measuring software checksum speed Dec 12 23:05:40.095177 kernel: 8regs : 17152 MB/sec Dec 12 23:05:40.096140 kernel: 32regs : 20760 MB/sec Dec 12 23:05:40.097362 kernel: arm64_neon : 29059 MB/sec Dec 12 23:05:40.097373 kernel: xor: using function: arm64_neon (29059 MB/sec) Dec 12 23:05:40.142176 kernel: Btrfs loaded, crc32c=crc32c-generic Dec 12 23:05:40.152790 systemd[1]: Finished dracut pre-udev hook. Dec 12 23:05:40.153000 audit: BPF prog-id=6 op=LOAD Dec 12 23:05:40.154000 audit: BPF prog-id=7 op=LOAD Dec 12 23:05:40.155467 kernel: audit: type=1334 audit(1765580740.153:2): prog-id=6 op=LOAD Dec 12 23:05:40.155496 kernel: audit: type=1334 audit(1765580740.154:3): prog-id=7 op=LOAD Dec 12 23:05:40.155505 kernel: audit: type=1334 audit(1765580740.155:4): prog-id=8 op=LOAD Dec 12 23:05:40.155000 audit: BPF prog-id=8 op=LOAD Dec 12 23:05:40.156009 systemd[1]: Starting Rule-based Manager for Device Events and Files... Dec 12 23:05:40.166875 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Dec 12 23:05:40.168578 systemd[1]: Started Rule-based Manager for Device Events and Files. Dec 12 23:05:40.171434 systemd[1]: Starting dracut pre-trigger hook... Dec 12 23:05:40.181966 dracut-pre-trigger[418]: rd.md=0: removing MD RAID activation Dec 12 23:05:40.206614 systemd[1]: Finished dracut pre-trigger hook. Dec 12 23:05:40.208024 systemd[1]: Starting Coldplug All udev Devices... Dec 12 23:05:40.218151 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Dec 12 23:05:40.239688 systemd[1]: Finished Coldplug All udev Devices. Dec 12 23:05:40.241222 systemd[1]: Starting dracut initqueue hook... Dec 12 23:05:40.256142 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Dec 12 23:05:40.256279 kernel: vda: detected capacity change from 0 to 4756340736 Dec 12 23:05:40.265137 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 12 23:05:40.271054 systemd-udevd[455]: Using default interface naming scheme 'v249'. Dec 12 23:05:40.284144 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (461) Dec 12 23:05:40.285664 systemd[1]: Found device /dev/disk/by-label/ROOT. Dec 12 23:05:40.291303 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Dec 12 23:05:40.292062 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Dec 12 23:05:40.297023 systemd[1]: Reached target Initrd Root Device. Dec 12 23:05:40.298454 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Dec 12 23:05:40.300236 systemd[1]: Finished dracut initqueue hook. Dec 12 23:05:40.301050 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 12 23:05:40.301182 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Dec 12 23:05:40.302397 systemd[1]: Reached target Preparation for Local File Systems. Dec 12 23:05:40.303787 systemd[1]: Reached target Preparation for Remote File Systems. Dec 12 23:05:40.305357 systemd[1]: Reached target Remote Encrypted Volumes. Dec 12 23:05:40.306789 systemd[1]: Reached target Remote File Systems. Dec 12 23:05:40.308740 systemd[1]: Starting dracut pre-mount hook... Dec 12 23:05:40.309947 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Dec 12 23:05:40.316368 systemd[1]: Finished dracut pre-mount hook. Dec 12 23:05:40.317644 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Dec 12 23:05:40.324139 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Dec 12 23:05:40.327452 systemd-fsck[500]: ROOT: clean, 640/553792 files, 39961/553472 blocks Dec 12 23:05:40.331590 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Dec 12 23:05:40.333205 systemd[1]: Mounting /sysroot... Dec 12 23:05:40.349956 systemd[1]: Found device /dev/mapper/usr. Dec 12 23:05:40.351400 systemd[1]: Starting File System Check on /dev/mapper/usr... Dec 12 23:05:40.353355 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Dec 12 23:05:40.361117 systemd-fsck[516]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Dec 12 23:05:40.361117 systemd-fsck[516]: You must have r/w access to the filesystem or be root Dec 12 23:05:40.363721 systemd-fsck[512]: fsck failed with exit status 8. Dec 12 23:05:40.363728 systemd-fsck[512]: Ignoring error. Dec 12 23:05:40.364458 systemd[1]: Finished File System Check on /dev/mapper/usr. Dec 12 23:05:40.366283 systemd[1]: Mounting /sysusr/usr... Dec 12 23:05:40.377791 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Dec 12 23:05:40.377829 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Dec 12 23:05:40.378305 systemd[1]: Mounted /sysroot. Dec 12 23:05:40.378952 systemd[1]: Reached target Initrd Root File System. Dec 12 23:05:40.380593 systemd[1]: Starting Reload Configuration from the Real Root... Dec 12 23:05:40.384895 systemd[1]: Reloading. Dec 12 23:05:40.387000 audit: BPF prog-id=6 op=UNLOAD Dec 12 23:05:40.387000 audit: BPF prog-id=3 op=UNLOAD Dec 12 23:05:40.388871 kernel: audit: type=1334 audit(1765580740.387:5): prog-id=6 op=UNLOAD Dec 12 23:05:40.388891 kernel: audit: type=1334 audit(1765580740.387:6): prog-id=3 op=UNLOAD Dec 12 23:05:40.396141 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Dec 12 23:05:40.467000 audit: BPF prog-id=9 op=LOAD Dec 12 23:05:40.467000 audit: BPF prog-id=10 op=LOAD Dec 12 23:05:40.468732 kernel: audit: type=1334 audit(1765580740.467:7): prog-id=9 op=LOAD Dec 12 23:05:40.468756 kernel: audit: type=1334 audit(1765580740.467:8): prog-id=10 op=LOAD Dec 12 23:05:40.468765 kernel: audit: type=1334 audit(1765580740.468:9): prog-id=11 op=LOAD Dec 12 23:05:40.468000 audit: BPF prog-id=11 op=LOAD Dec 12 23:05:40.469462 kernel: audit: type=1334 audit(1765580740.468:10): prog-id=7 op=UNLOAD Dec 12 23:05:40.468000 audit: BPF prog-id=7 op=UNLOAD Dec 12 23:05:40.468000 audit: BPF prog-id=8 op=UNLOAD Dec 12 23:05:40.469000 audit: BPF prog-id=12 op=LOAD Dec 12 23:05:40.470000 audit: BPF prog-id=13 op=LOAD Dec 12 23:05:40.470000 audit: BPF prog-id=14 op=LOAD Dec 12 23:05:40.470000 audit: BPF prog-id=4 op=UNLOAD Dec 12 23:05:40.470000 audit: BPF prog-id=5 op=UNLOAD Dec 12 23:05:40.471554 systemd[1]: Mounted /sysusr/usr. Dec 12 23:05:40.473587 systemd[1]: Reached target Local File Systems. Dec 12 23:05:40.474326 systemd[1]: Reached target System Initialization. Dec 12 23:05:40.475606 systemd[1]: Reached target Basic System. Dec 12 23:05:40.477781 systemd[1]: Mounting /sysroot/usr... Dec 12 23:05:40.480075 systemd[1]: Mounted /sysroot/usr. Dec 12 23:05:40.488429 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 12 23:05:40.488548 systemd[1]: Finished Reload Configuration from the Real Root. Dec 12 23:05:40.490042 systemd[1]: Reached target Initrd File Systems. Dec 12 23:05:40.491320 systemd[1]: Reached target Initrd Default Target. Dec 12 23:05:40.492533 systemd[1]: Condition check resulted in dracut mount hook being skipped. Dec 12 23:05:40.493148 systemd[1]: Starting dracut pre-pivot and cleanup hook... Dec 12 23:05:40.502976 systemd[1]: Finished dracut pre-pivot and cleanup hook. Dec 12 23:05:40.504518 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Dec 12 23:05:40.510103 systemd[1]: Stopped target Remote Encrypted Volumes. Dec 12 23:05:40.511015 systemd[1]: Stopped target Timer Units. Dec 12 23:05:40.512237 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 12 23:05:40.512353 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Dec 12 23:05:40.513664 systemd[1]: Stopped target Initrd Default Target. Dec 12 23:05:40.515064 systemd[1]: Stopped target Basic System. Dec 12 23:05:40.516344 systemd[1]: Stopped target Initrd Root Device. Dec 12 23:05:40.517692 systemd[1]: Stopped target Path Units. Dec 12 23:05:40.518757 systemd[1]: Stopped target Remote File Systems. Dec 12 23:05:40.519861 systemd[1]: Stopped target Preparation for Remote File Systems. Dec 12 23:05:40.521017 systemd[1]: Stopped target Slice Units. Dec 12 23:05:40.522106 systemd[1]: Stopped target Socket Units. Dec 12 23:05:40.523350 systemd[1]: Stopped target System Initialization. Dec 12 23:05:40.524405 systemd[1]: Stopped target Local File Systems. Dec 12 23:05:40.525502 systemd[1]: Stopped target Preparation for Local File Systems. Dec 12 23:05:40.526810 systemd[1]: Stopped target Swaps. Dec 12 23:05:40.527769 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 12 23:05:40.527872 systemd[1]: Stopped dracut pre-mount hook. Dec 12 23:05:40.529015 systemd[1]: Stopped target Local Encrypted Volumes. Dec 12 23:05:40.529960 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 12 23:05:40.533171 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Dec 12 23:05:40.534225 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 12 23:05:40.534323 systemd[1]: Stopped dracut initqueue hook. Dec 12 23:05:40.537164 iscsid[374]: iscsid shutting down. Dec 12 23:05:40.537417 systemd[1]: Stopping Open-iSCSI... Dec 12 23:05:40.538074 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 12 23:05:40.538212 systemd[1]: Stopped Apply Kernel Variables. Dec 12 23:05:40.539279 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 12 23:05:40.539366 systemd[1]: Stopped Coldplug All udev Devices. Dec 12 23:05:40.540633 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 12 23:05:40.540718 systemd[1]: Stopped dracut pre-trigger hook. Dec 12 23:05:40.541895 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Dec 12 23:05:40.546148 systemd[1]: iscsid.service: Deactivated successfully. Dec 12 23:05:40.546259 systemd[1]: Stopped Open-iSCSI. Dec 12 23:05:40.547334 systemd[1]: iscsid.socket: Deactivated successfully. Dec 12 23:05:40.547395 systemd[1]: Closed Open-iSCSI iscsid Socket. Dec 12 23:05:40.548214 systemd[1]: Stopping iSCSI UserSpace I/O driver... Dec 12 23:05:40.550968 systemd[1]: iscsiuio.service: Deactivated successfully. Dec 12 23:05:40.551099 systemd[1]: Stopped iSCSI UserSpace I/O driver. Dec 12 23:05:40.552194 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 12 23:05:40.552303 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Dec 12 23:05:40.553560 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 12 23:05:40.553663 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Dec 12 23:05:40.555373 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 12 23:05:40.555422 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Dec 12 23:05:40.556661 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 12 23:05:40.556701 systemd[1]: Closed udev Control Socket. Dec 12 23:05:40.557832 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 12 23:05:40.569000 audit: BPF prog-id=9 op=UNLOAD Dec 12 23:05:40.557868 systemd[1]: Closed udev Kernel Socket. Dec 12 23:05:40.558913 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 12 23:05:40.558955 systemd[1]: Stopped dracut pre-udev hook. Dec 12 23:05:40.560155 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 12 23:05:40.560201 systemd[1]: Stopped dracut cmdline hook. Dec 12 23:05:40.561591 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 12 23:05:40.561630 systemd[1]: Stopped dracut ask for additional cmdline parameters. Dec 12 23:05:40.563662 systemd[1]: Starting Cleanup udev Database... Dec 12 23:05:40.564415 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Dec 12 23:05:40.565492 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 12 23:05:40.565544 systemd[1]: Stopped Create Static Device Nodes in /dev. Dec 12 23:05:40.580000 audit: BPF prog-id=12 op=UNLOAD Dec 12 23:05:40.566727 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 12 23:05:40.566765 systemd[1]: Stopped Create List of Static Device Nodes. Dec 12 23:05:40.568143 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 12 23:05:40.568183 systemd[1]: Stopped Setup Virtual Console. Dec 12 23:05:40.569654 systemd[1]: rngd.service: Deactivated successfully. Dec 12 23:05:40.569759 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Dec 12 23:05:40.571136 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 12 23:05:40.571231 systemd[1]: Finished Cleanup udev Database. Dec 12 23:05:40.572201 systemd[1]: Reached target Switch Root. Dec 12 23:05:40.574048 systemd[1]: Starting Switch Root... Dec 12 23:05:40.579701 systemd[1]: Switching root. Dec 12 23:05:40.595401 systemd-journald[270]: Journal stopped Dec 12 23:05:42.627152 systemd-journald[270]: Received SIGTERM from PID 1 (systemd). Dec 12 23:05:42.627201 kernel: SELinux: policy capability network_peer_controls=1 Dec 12 23:05:42.627214 kernel: SELinux: policy capability open_perms=1 Dec 12 23:05:42.627227 kernel: SELinux: policy capability extended_socket_class=1 Dec 12 23:05:42.627237 kernel: SELinux: policy capability always_check_network=0 Dec 12 23:05:42.627246 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 12 23:05:42.627255 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 12 23:05:42.627264 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 12 23:05:42.627274 systemd[1]: Successfully loaded SELinux policy in 30.297ms. Dec 12 23:05:42.627289 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.418ms. Dec 12 23:05:42.627301 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 23:05:42.627311 systemd[1]: Detected virtualization kvm. Dec 12 23:05:42.627322 systemd[1]: Detected architecture arm64. Dec 12 23:05:42.627334 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 23:05:42.627346 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Dec 12 23:05:42.627357 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 12 23:05:42.627367 systemd[1]: Stopped Switch Root. Dec 12 23:05:42.627385 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 12 23:05:42.627395 systemd[1]: Created slice Slice /system/addon-config. Dec 12 23:05:42.627405 systemd[1]: Created slice Slice /system/addon-run. Dec 12 23:05:42.627416 systemd[1]: Created slice Slice /system/getty. Dec 12 23:05:42.627425 systemd[1]: Created slice Slice /system/modprobe. Dec 12 23:05:42.627435 systemd[1]: Created slice Slice /system/serial-getty. Dec 12 23:05:42.627445 systemd[1]: Created slice Slice /system/system-cloudinit. Dec 12 23:05:42.627454 systemd[1]: Created slice Slice /system/systemd-fsck. Dec 12 23:05:42.627472 systemd[1]: Created slice User and Session Slice. Dec 12 23:05:42.627482 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Dec 12 23:05:42.627492 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Dec 12 23:05:42.627502 systemd[1]: Set up automount Boot partition Automount Point. Dec 12 23:05:42.627514 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Dec 12 23:05:42.627525 systemd[1]: Stopped target Switch Root. Dec 12 23:05:42.627534 systemd[1]: Stopped target Initrd File Systems. Dec 12 23:05:42.627548 systemd[1]: Stopped target Initrd Root File System. Dec 12 23:05:42.627558 systemd[1]: Reached target Remote Encrypted Volumes. Dec 12 23:05:42.627569 systemd[1]: Reached target Remote File Systems. Dec 12 23:05:42.627580 systemd[1]: Reached target Slice Units. Dec 12 23:05:42.627589 systemd[1]: Reached target Swaps. Dec 12 23:05:42.627600 systemd[1]: Reached target Verify torcx succeeded. Dec 12 23:05:42.627609 systemd[1]: Reached target Local Verity Protected Volumes. Dec 12 23:05:42.627620 systemd[1]: Listening on Process Core Dump Socket. Dec 12 23:05:42.627630 systemd[1]: Listening on initctl Compatibility Named Pipe. Dec 12 23:05:42.627640 systemd[1]: Listening on Network Service Netlink Socket. Dec 12 23:05:42.627649 systemd[1]: Listening on udev Control Socket. Dec 12 23:05:42.627659 systemd[1]: Listening on udev Kernel Socket. Dec 12 23:05:42.627669 systemd[1]: Mounting Huge Pages File System... Dec 12 23:05:42.627679 systemd[1]: Mounting POSIX Message Queue File System... Dec 12 23:05:42.627689 systemd[1]: Mounting External Media Directory... Dec 12 23:05:42.627698 systemd[1]: Mounting Kernel Debug File System... Dec 12 23:05:42.627709 systemd[1]: Mounting Kernel Trace File System... Dec 12 23:05:42.627719 systemd[1]: Mounting Temporary Directory /tmp... Dec 12 23:05:42.627729 systemd[1]: Starting Create missing system files... Dec 12 23:05:42.627739 systemd[1]: Starting Create List of Static Device Nodes... Dec 12 23:05:42.627748 systemd[1]: Starting Load Kernel Module configfs... Dec 12 23:05:42.627758 systemd[1]: Starting Load Kernel Module drm... Dec 12 23:05:42.627768 systemd[1]: Starting Load Kernel Module fuse... Dec 12 23:05:42.627778 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Dec 12 23:05:42.627788 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 12 23:05:42.627799 systemd[1]: Stopped File System Check on Root Device. Dec 12 23:05:42.627810 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 12 23:05:42.627819 systemd[1]: Stopped systemd-fsck-usr.service. Dec 12 23:05:42.627829 systemd[1]: Stopped Journal Service. Dec 12 23:05:42.627839 kernel: fuse: init (API version 7.32) Dec 12 23:05:42.627848 systemd[1]: Starting Journal Service... Dec 12 23:05:42.627858 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Dec 12 23:05:42.627867 systemd[1]: Starting Remount Root and Kernel File Systems... Dec 12 23:05:42.627877 systemd[1]: Starting Apply Kernel Variables... Dec 12 23:05:42.627886 systemd[1]: Starting Coldplug All udev Devices... Dec 12 23:05:42.627896 systemd[1]: verity-setup.service: Deactivated successfully. Dec 12 23:05:42.627906 systemd[1]: Stopped verity-setup.service. Dec 12 23:05:42.627917 systemd-journald[692]: Journal started Dec 12 23:05:42.627954 systemd-journald[692]: Runtime Journal (/run/log/journal/c312ca44bdae4a0f8fd7bebfcc5a72b7) is 6.0M, max 48.5M, 42.4M free. Dec 12 23:05:40.667000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 12 23:05:40.694000 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 23:05:40.694000 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 23:05:40.694000 audit: BPF prog-id=15 op=LOAD Dec 12 23:05:40.694000 audit: BPF prog-id=15 op=UNLOAD Dec 12 23:05:40.694000 audit: BPF prog-id=16 op=LOAD Dec 12 23:05:40.694000 audit: BPF prog-id=16 op=UNLOAD Dec 12 23:05:40.727000 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 23:05:42.514000 audit: BPF prog-id=17 op=LOAD Dec 12 23:05:42.514000 audit: BPF prog-id=18 op=LOAD Dec 12 23:05:42.515000 audit: BPF prog-id=19 op=LOAD Dec 12 23:05:42.515000 audit: BPF prog-id=13 op=UNLOAD Dec 12 23:05:42.515000 audit: BPF prog-id=14 op=UNLOAD Dec 12 23:05:42.524000 audit: BPF prog-id=20 op=LOAD Dec 12 23:05:42.524000 audit: BPF prog-id=17 op=UNLOAD Dec 12 23:05:42.524000 audit: BPF prog-id=21 op=LOAD Dec 12 23:05:42.524000 audit: BPF prog-id=22 op=LOAD Dec 12 23:05:42.524000 audit: BPF prog-id=18 op=UNLOAD Dec 12 23:05:42.524000 audit: BPF prog-id=19 op=UNLOAD Dec 12 23:05:42.536000 audit: BPF prog-id=20 op=UNLOAD Dec 12 23:05:42.614000 audit: BPF prog-id=23 op=LOAD Dec 12 23:05:42.614000 audit: BPF prog-id=24 op=LOAD Dec 12 23:05:42.614000 audit: BPF prog-id=25 op=LOAD Dec 12 23:05:42.614000 audit: BPF prog-id=21 op=UNLOAD Dec 12 23:05:42.614000 audit: BPF prog-id=22 op=UNLOAD Dec 12 23:05:42.625000 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 23:05:42.514156 systemd[1]: Queued start job for default target Multi-User System. Dec 12 23:05:40.725616 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" 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 23:05:42.524858 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 12 23:05:40.725868 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 12 23:05:40.725886 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 12 23:05:40.726163 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Dec 12 23:05:40.726174 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" level=debug msg="skipped missing lower profile" missing profile=oem Dec 12 23:05:40.726206 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Dec 12 23:05:40.726219 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Dec 12 23:05:42.629175 systemd[1]: Started Journal Service. Dec 12 23:05:40.726533 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Dec 12 23:05:40.726570 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 12 23:05:40.726586 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 12 23:05:40.726938 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" 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 23:05:40.726968 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" 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 23:05:40.726986 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" 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 23:05:40.727003 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" 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 23:05:42.629626 systemd[1]: Mounted Huge Pages File System. Dec 12 23:05:40.727111 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" 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 23:05:40.727137 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:40Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Dec 12 23:05:42.418900 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:42Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 12 23:05:42.419195 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:42Z" 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 23:05:42.419297 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:42Z" 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 23:05:42.419420 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:42Z" 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 23:05:42.419527 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:42Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Dec 12 23:05:42.419585 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-12-12T23:05:42Z" 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 23:05:42.630443 systemd[1]: Mounted POSIX Message Queue File System. Dec 12 23:05:42.631273 systemd[1]: Mounted External Media Directory. Dec 12 23:05:42.632010 systemd[1]: Mounted Kernel Debug File System. Dec 12 23:05:42.632825 systemd[1]: Mounted Kernel Trace File System. Dec 12 23:05:42.633597 systemd[1]: Mounted Temporary Directory /tmp. Dec 12 23:05:42.634588 systemd[1]: Finished Create missing system files. Dec 12 23:05:42.635617 systemd[1]: Finished Create List of Static Device Nodes. Dec 12 23:05:42.636608 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 12 23:05:42.636802 systemd[1]: Finished Load Kernel Module configfs. Dec 12 23:05:42.637761 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 12 23:05:42.637943 systemd[1]: Finished Load Kernel Module drm. Dec 12 23:05:42.638885 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 12 23:05:42.639066 systemd[1]: Finished Load Kernel Module fuse. Dec 12 23:05:42.640060 systemd[1]: Finished Remount Root and Kernel File Systems. Dec 12 23:05:42.641202 systemd[1]: Finished Apply Kernel Variables. Dec 12 23:05:42.652954 systemd[1]: Mounting FUSE Control File System... Dec 12 23:05:42.654661 systemd[1]: Mounting Kernel Configuration File System... Dec 12 23:05:42.655371 systemd[1]: Condition check resulted in Remount Root File System being skipped. Dec 12 23:05:42.656333 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Dec 12 23:05:42.657282 systemd[1]: Starting Flush Journal to Persistent Storage... Dec 12 23:05:42.658100 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Dec 12 23:05:42.659380 systemd[1]: Starting Load/Save Random Seed... Dec 12 23:05:42.660139 systemd[1]: Condition check resulted in Create System Users being skipped. Dec 12 23:05:42.661775 systemd-journald[692]: Time spent on flushing to /var/log/journal/c312ca44bdae4a0f8fd7bebfcc5a72b7 is 10.202ms for 661 entries. Dec 12 23:05:42.661775 systemd-journald[692]: System Journal (/var/log/journal/c312ca44bdae4a0f8fd7bebfcc5a72b7) is 8.0M, max 203.0M, 195.0M free. Dec 12 23:05:42.661187 systemd[1]: Starting Create Static Device Nodes in /dev... Dec 12 23:05:42.664246 systemd[1]: Mounted FUSE Control File System. Dec 12 23:05:42.665248 systemd[1]: Mounted Kernel Configuration File System. Dec 12 23:05:42.667439 systemd[1]: Finished Load/Save Random Seed. Dec 12 23:05:42.668295 systemd[1]: Condition check resulted in First Boot Complete being skipped. Dec 12 23:05:42.683492 systemd[1]: Finished Coldplug All udev Devices. Dec 12 23:05:42.684505 systemd[1]: Finished Create Static Device Nodes in /dev. Dec 12 23:05:42.686398 systemd[1]: Starting Wait for udev To Complete Device Initialization... Dec 12 23:05:42.687000 audit: BPF prog-id=26 op=LOAD Dec 12 23:05:42.687000 audit: BPF prog-id=27 op=LOAD Dec 12 23:05:42.687000 audit: BPF prog-id=28 op=LOAD Dec 12 23:05:42.687000 audit: BPF prog-id=10 op=UNLOAD Dec 12 23:05:42.687000 audit: BPF prog-id=11 op=UNLOAD Dec 12 23:05:42.688497 systemd[1]: Starting Rule-based Manager for Device Events and Files... Dec 12 23:05:42.689757 systemd[1]: Finished Flush Journal to Persistent Storage. Dec 12 23:05:42.710981 systemd[1]: Started Rule-based Manager for Device Events and Files. Dec 12 23:05:42.720000 audit: BPF prog-id=29 op=LOAD Dec 12 23:05:42.721358 systemd[1]: Starting Network Configuration... Dec 12 23:05:42.742876 systemd-udevd[708]: Using default interface naming scheme 'v249'. Dec 12 23:05:42.750238 systemd-networkd[725]: lo: Link UP Dec 12 23:05:42.750244 systemd-networkd[725]: lo: Gained carrier Dec 12 23:05:42.750621 systemd-networkd[725]: Enumeration completed Dec 12 23:05:42.750794 systemd[1]: Started Network Configuration. Dec 12 23:05:42.752893 systemd-networkd[725]: eth0: Link UP Dec 12 23:05:42.758173 systemd-networkd[725]: eth0: Gained carrier Dec 12 23:05:42.770302 systemd-networkd[725]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Dec 12 23:05:42.776879 udevadm[705]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Dec 12 23:05:42.806402 systemd[1]: Finished Wait for udev To Complete Device Initialization. Dec 12 23:05:42.817027 systemd[1]: Starting Activation of LVM2 logical volumes... Dec 12 23:05:42.824969 lvm[733]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 12 23:05:42.850346 systemd[1]: Finished Activation of LVM2 logical volumes. Dec 12 23:05:42.851257 systemd[1]: Reached target Local Encrypted Volumes. Dec 12 23:05:42.864111 systemd[1]: Starting Activation of LVM2 logical volumes... Dec 12 23:05:42.867298 lvm[734]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 12 23:05:42.903224 systemd[1]: Finished Activation of LVM2 logical volumes. Dec 12 23:05:42.904067 systemd[1]: Reached target Preparation for Local File Systems. Dec 12 23:05:42.904968 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Dec 12 23:05:42.904994 systemd[1]: Reached target Containers. Dec 12 23:05:42.915395 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Dec 12 23:05:42.927506 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Dec 12 23:05:42.929391 systemd[1]: Mounting /usr/share/oem... Dec 12 23:05:42.935139 kernel: BTRFS info (device vda6): disk space caching is enabled Dec 12 23:05:42.935192 kernel: BTRFS info (device vda6): has skinny extents Dec 12 23:05:42.937070 systemd[1]: Mounted /usr/share/oem. Dec 12 23:05:42.937782 systemd[1]: Reached target Local File Systems. Dec 12 23:05:42.938534 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Dec 12 23:05:42.938869 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Dec 12 23:05:42.938906 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Dec 12 23:05:42.938935 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Dec 12 23:05:42.939809 systemd[1]: Starting Create Volatile Files and Directories... Dec 12 23:05:42.945414 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Dec 12 23:05:42.946441 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Dec 12 23:05:42.973784 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Dec 12 23:05:42.973797 systemd-tmpfiles[758]: Skipping /boot Dec 12 23:05:42.979536 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Dec 12 23:05:42.979548 systemd-tmpfiles[758]: Skipping /boot Dec 12 23:05:43.008516 systemd[1]: Finished Create Volatile Files and Directories. Dec 12 23:05:43.021984 systemd[1]: Starting Load Security Auditing Rules... Dec 12 23:05:43.023659 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Dec 12 23:05:43.024562 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Dec 12 23:05:43.025000 audit: BPF prog-id=30 op=LOAD Dec 12 23:05:43.026150 systemd[1]: Starting Network Name Resolution... Dec 12 23:05:43.027000 audit: BPF prog-id=31 op=LOAD Dec 12 23:05:43.028487 systemd[1]: Starting Network Time Synchronization... Dec 12 23:05:43.029416 systemd[1]: Condition check resulted in Update is Completed being skipped. Dec 12 23:05:43.030392 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Dec 12 23:05:43.031676 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Dec 12 23:05:43.032753 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Dec 12 23:05:43.038107 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Dec 12 23:05:43.045000 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 23:05:43.046321 augenrules[779]: No rules Dec 12 23:05:43.047186 systemd[1]: Finished Load Security Auditing Rules. Dec 12 23:05:43.064486 systemd-timesyncd[768]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Dec 12 23:05:43.065265 systemd[1]: Started Network Time Synchronization. Dec 12 23:05:43.066151 systemd[1]: Reached target System Initialization. Dec 12 23:05:43.066898 systemd[1]: Started Watch for update engine configuration changes. Dec 12 23:05:43.067885 systemd-resolved[762]: Positive Trust Anchors: Dec 12 23:05:43.067898 systemd-resolved[762]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 12 23:05:43.067898 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 12 23:05:43.067925 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 23:05:43.068936 systemd[1]: Started Daily Cleanup of Temporary Directories. Dec 12 23:05:43.069857 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Dec 12 23:05:43.069909 systemd[1]: Reached target Path Units. Dec 12 23:05:43.070042 systemd-resolved[762]: Defaulting to hostname 'linux'. Dec 12 23:05:43.070532 systemd[1]: Reached target System Time Set. Dec 12 23:05:43.071356 systemd[1]: Started Daily Log Rotation. Dec 12 23:05:43.072077 systemd[1]: Started Weekly check for MD array's redundancy information.. Dec 12 23:05:43.073047 systemd[1]: Reached target Timer Units. Dec 12 23:05:43.074050 systemd[1]: Listening on D-Bus System Message Bus Socket. Dec 12 23:05:43.084731 systemd[1]: Starting Docker Socket for the API... Dec 12 23:05:43.087782 systemd[1]: Listening on OpenSSH Server Socket. Dec 12 23:05:43.088883 systemd[1]: Started Network Name Resolution. Dec 12 23:05:43.089706 systemd[1]: Listening on Docker Socket for the API. Dec 12 23:05:43.090494 systemd[1]: Reached target Network. Dec 12 23:05:43.091046 systemd[1]: Reached target Host and Network Name Lookups. Dec 12 23:05:43.091845 systemd[1]: Reached target Socket Units. Dec 12 23:05:43.092480 systemd[1]: Reached target Basic System. Dec 12 23:05:43.093097 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Dec 12 23:05:43.093143 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Dec 12 23:05:43.094078 systemd[1]: Started D-Bus System Message Bus. Dec 12 23:05:43.097423 systemd[1]: Starting Extend Filesystems... Dec 12 23:05:43.098197 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Dec 12 23:05:43.099259 systemd[1]: Starting Generate /run/flatcar/motd... Dec 12 23:05:43.101205 systemd[1]: Starting Install an ssh key from /proc/cmdline... Dec 12 23:05:43.103666 systemd[1]: Starting Generate sshd host keys... Dec 12 23:05:43.107539 extend-filesystems[788]: Found vda Dec 12 23:05:43.107539 extend-filesystems[788]: Found vda1 Dec 12 23:05:43.107539 extend-filesystems[788]: Found vda2 Dec 12 23:05:43.107539 extend-filesystems[788]: Found vda3 Dec 12 23:05:43.107539 extend-filesystems[788]: Found usr Dec 12 23:05:43.107539 extend-filesystems[788]: Found vda4 Dec 12 23:05:43.107539 extend-filesystems[788]: Found vda6 Dec 12 23:05:43.107539 extend-filesystems[788]: Found vda7 Dec 12 23:05:43.107539 extend-filesystems[788]: Found vda9 Dec 12 23:05:43.107539 extend-filesystems[788]: Checking size of /dev/vda9 Dec 12 23:05:43.107281 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Dec 12 23:05:43.107310 systemd[1]: Reached target Load system-provided cloud configs. Dec 12 23:05:43.110796 systemd[1]: Starting User Login Management... Dec 12 23:05:43.112269 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 12 23:05:43.113077 systemd[1]: Starting Update Engine... Dec 12 23:05:43.114271 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Dec 12 23:05:43.114304 systemd[1]: Reached target Load user-provided cloud configs. Dec 12 23:05:43.120644 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 12 23:05:43.120961 systemd[1]: Finished Install an ssh key from /proc/cmdline. Dec 12 23:05:43.124017 extend-filesystems[788]: Old size kept for /dev/vda9 Dec 12 23:05:43.124083 systemd[1]: motdgen.service: Deactivated successfully. Dec 12 23:05:43.124305 systemd[1]: Finished Generate /run/flatcar/motd. Dec 12 23:05:43.126231 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 12 23:05:43.126594 systemd[1]: Finished Extend Filesystems. Dec 12 23:05:43.151842 update_engine[804]: I1212 23:05:43.151607 804 main.cc:89] Flatcar Update Engine starting Dec 12 23:05:43.152647 update_engine[804]: I1212 23:05:43.152630 804 payload_state.cc:360] Current Response Signature = Dec 12 23:05:43.152647 update_engine[804]: NumURLs = 1 Dec 12 23:05:43.152647 update_engine[804]: Url0 = http://10.0.0.5:34567/packages/update.gz Dec 12 23:05:43.152647 update_engine[804]: Payload Size = 404125651 Dec 12 23:05:43.152647 update_engine[804]: Payload Sha256 Hash = 4hfcTZDmcDqsO9HQem8/SEl+FfeTS7xMT8GNrEcoLTM= Dec 12 23:05:43.152647 update_engine[804]: Is Delta Payload = 0 Dec 12 23:05:43.152647 update_engine[804]: Max Failure Count Per Url = 10 Dec 12 23:05:43.152647 update_engine[804]: Disable Payload Backoff = 1 Dec 12 23:05:43.153046 update_engine[804]: I1212 23:05:43.153019 804 payload_state.cc:381] Payload Attempt Number = 0 Dec 12 23:05:43.153280 update_engine[804]: I1212 23:05:43.153265 804 payload_state.cc:404] Current URL Index = 0 Dec 12 23:05:43.153508 update_engine[804]: I1212 23:05:43.153496 804 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Dec 12 23:05:43.153737 update_engine[804]: I1212 23:05:43.153712 804 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Dec 12 23:05:43.155071 systemd-logind[803]: Watching system buttons on /dev/input/event0 (Power Button) Dec 12 23:05:43.155291 systemd-logind[803]: New seat seat0. Dec 12 23:05:43.157108 systemd[1]: Started Update Engine. Dec 12 23:05:43.157851 update_engine[804]: I1212 23:05:43.157809 804 update_check_scheduler.cc:74] Next update check in 10m39s Dec 12 23:05:43.159959 systemd[1]: Started User Login Management. Dec 12 23:05:43.163670 systemd[1]: Finished Generate sshd host keys. Dec 12 23:05:43.176164 systemd[1]: Starting Generate /run/issue... Dec 12 23:05:43.180256 systemd[1]: issuegen.service: Deactivated successfully. Dec 12 23:05:43.180469 systemd[1]: Finished Generate /run/issue. Dec 12 23:05:43.182280 systemd[1]: Starting Permit User Sessions... Dec 12 23:05:43.186660 systemd[1]: Finished Permit User Sessions. Dec 12 23:05:43.188488 systemd[1]: Started Getty on tty1. Dec 12 23:05:43.190252 systemd[1]: Started Serial Getty on ttyAMA0. Dec 12 23:05:43.191061 systemd[1]: Reached target Login Prompts. Dec 12 23:05:43.191869 systemd[1]: Reached target Multi-User System. Dec 12 23:05:43.193617 systemd[1]: Starting Record Runlevel Change in UTMP... Dec 12 23:05:43.198373 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Dec 12 23:05:43.198581 systemd[1]: Finished Record Runlevel Change in UTMP. Dec 12 23:05:43.199445 systemd[1]: Startup finished in 678ms (kernel) + 1.079s (initrd) + 2.564s (userspace) = 4.322s. Dec 12 23:05:44.355918 systemd-networkd[725]: eth0: Gained IPv6LL Dec 12 23:05:53.158086 systemd[1]: Created slice Slice /system/sshd. Dec 12 23:05:53.159041 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55958). Dec 12 23:05:53.203733 sshd[828]: Accepted publickey for core from 10.0.0.1 port 55958 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:53.205281 sshd[828]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:53.221627 systemd[1]: Created slice User Slice of UID 500. Dec 12 23:05:53.222665 systemd[1]: Starting User Runtime Directory /run/user/500... Dec 12 23:05:53.224174 systemd-logind[803]: New session 1 of user core. Dec 12 23:05:53.228857 systemd[1]: Finished User Runtime Directory /run/user/500. Dec 12 23:05:53.230207 systemd[1]: Starting User Manager for UID 500... Dec 12 23:05:53.232639 systemd[831]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:53.280400 systemd[831]: Queued start job for default target Main User Target. Dec 12 23:05:53.280557 systemd[831]: Reached target Paths. Dec 12 23:05:53.280571 systemd[831]: Reached target Sockets. Dec 12 23:05:53.280582 systemd[831]: Reached target Timers. Dec 12 23:05:53.280592 systemd[831]: Reached target Basic System. Dec 12 23:05:53.280633 systemd[831]: Reached target Main User Target. Dec 12 23:05:53.280645 systemd[831]: Startup finished in 44ms. Dec 12 23:05:53.280723 systemd[1]: Started User Manager for UID 500. Dec 12 23:05:53.289309 systemd[1]: Started Session 1 of User core. Dec 12 23:05:53.347535 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55966). Dec 12 23:05:53.388183 sshd[840]: Accepted publickey for core from 10.0.0.1 port 55966 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:53.389485 sshd[840]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:53.392705 systemd-logind[803]: New session 2 of user core. Dec 12 23:05:53.404336 systemd[1]: Started Session 2 of User core. Dec 12 23:05:53.456680 sshd[840]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:53.464708 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:55966.service: Deactivated successfully. Dec 12 23:05:53.465291 systemd[1]: session-2.scope: Deactivated successfully. Dec 12 23:05:53.465854 systemd-logind[803]: Session 2 logged out. Waiting for processes to exit. Dec 12 23:05:53.466848 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55978). Dec 12 23:05:53.467452 systemd-logind[803]: Removed session 2. Dec 12 23:05:53.508011 sshd[846]: Accepted publickey for core from 10.0.0.1 port 55978 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:53.509125 sshd[846]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:53.511965 systemd-logind[803]: New session 3 of user core. Dec 12 23:05:53.522329 systemd[1]: Started Session 3 of User core. Dec 12 23:05:53.570684 sshd[846]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:53.590864 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:55978.service: Deactivated successfully. Dec 12 23:05:53.591441 systemd[1]: session-3.scope: Deactivated successfully. Dec 12 23:05:53.592044 systemd-logind[803]: Session 3 logged out. Waiting for processes to exit. Dec 12 23:05:53.593042 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55980). Dec 12 23:05:53.593659 systemd-logind[803]: Removed session 3. Dec 12 23:05:53.633949 sshd[852]: Accepted publickey for core from 10.0.0.1 port 55980 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:53.635069 sshd[852]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:53.637585 systemd-logind[803]: New session 4 of user core. Dec 12 23:05:53.648293 systemd[1]: Started Session 4 of User core. Dec 12 23:05:53.699639 sshd[852]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:53.707987 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:55980.service: Deactivated successfully. Dec 12 23:05:53.708776 systemd[1]: session-4.scope: Deactivated successfully. Dec 12 23:05:53.709536 systemd-logind[803]: Session 4 logged out. Waiting for processes to exit. Dec 12 23:05:53.710894 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55986). Dec 12 23:05:53.712020 systemd-logind[803]: Removed session 4. Dec 12 23:05:53.751599 sshd[859]: Accepted publickey for core from 10.0.0.1 port 55986 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:53.752973 sshd[859]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:53.755647 systemd-logind[803]: New session 5 of user core. Dec 12 23:05:53.765481 systemd[1]: Started Session 5 of User core. Dec 12 23:05:53.821631 sudo[862]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Dec 12 23:05:53.821837 sudo[862]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 23:05:53.834610 sudo[862]: pam_unix(sudo:session): session closed for user root Dec 12 23:05:53.836395 sshd[859]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:53.850805 dbus-daemon[787]: [system] Reloaded configuration Dec 12 23:05:53.851255 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55996). Dec 12 23:05:53.853272 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:55986.service: Deactivated successfully. Dec 12 23:05:53.853951 systemd[1]: session-5.scope: Deactivated successfully. Dec 12 23:05:53.854566 systemd-logind[803]: Session 5 logged out. Waiting for processes to exit. Dec 12 23:05:53.855248 systemd-logind[803]: Removed session 5. Dec 12 23:05:53.892451 sshd[865]: Accepted publickey for core from 10.0.0.1 port 55996 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:53.893574 sshd[865]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:53.896200 systemd-logind[803]: New session 6 of user core. Dec 12 23:05:53.904285 systemd[1]: Started Session 6 of User core. Dec 12 23:05:53.954974 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 23:05:53.955209 sudo[870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 23:05:53.957523 sudo[870]: pam_unix(sudo:session): session closed for user root Dec 12 23:05:53.961495 sudo[869]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Dec 12 23:05:53.961718 sudo[869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 12 23:05:53.977153 systemd[1]: Stopping Load Security Auditing Rules... Dec 12 23:05:53.977000 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 23:05:53.978371 auditctl[873]: No rules Dec 12 23:05:53.978604 systemd[1]: audit-rules.service: Deactivated successfully. Dec 12 23:05:53.978845 systemd[1]: Stopped Load Security Auditing Rules. Dec 12 23:05:53.980146 kernel: kauditd_printk_skb: 43 callbacks suppressed Dec 12 23:05:53.980193 kernel: audit: type=1305 audit(1765580753.977:54): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Dec 12 23:05:53.980237 systemd[1]: Starting Load Security Auditing Rules... Dec 12 23:05:53.995705 augenrules[890]: No rules Dec 12 23:05:53.996449 systemd[1]: Finished Load Security Auditing Rules. Dec 12 23:05:53.997343 sudo[869]: pam_unix(sudo:session): session closed for user root Dec 12 23:05:53.998517 sshd[865]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:54.013294 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:55996.service: Deactivated successfully. Dec 12 23:05:54.013930 systemd[1]: session-6.scope: Deactivated successfully. Dec 12 23:05:54.014589 systemd-logind[803]: Session 6 logged out. Waiting for processes to exit. Dec 12 23:05:54.015817 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56000). Dec 12 23:05:54.016844 systemd-logind[803]: Removed session 6. Dec 12 23:05:54.056922 sshd[896]: Accepted publickey for core from 10.0.0.1 port 56000 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:54.057967 sshd[896]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:54.060165 kernel: audit: type=1006 audit(1765580754.056:55): 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 23:05:54.060661 systemd-logind[803]: New session 7 of user core. Dec 12 23:05:54.069304 systemd[1]: Started Session 7 of User core. Dec 12 23:05:54.118168 sshd[896]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:54.129064 systemd[1]: sshd@6-10.0.0.6:22-10.0.0.1:56000.service: Deactivated successfully. Dec 12 23:05:54.129835 systemd[1]: session-7.scope: Deactivated successfully. Dec 12 23:05:54.130548 systemd-logind[803]: Session 7 logged out. Waiting for processes to exit. Dec 12 23:05:54.131829 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56012). Dec 12 23:05:54.132539 systemd-logind[803]: Removed session 7. Dec 12 23:05:54.172240 sshd[902]: Accepted publickey for core from 10.0.0.1 port 56012 ssh2: RSA SHA256:Z2Elt5tlwvhwThzscxG5xrExUvfwzviejvSi8S7HEPw Dec 12 23:05:54.174832 sshd[902]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 12 23:05:54.175149 kernel: audit: type=1006 audit(1765580754.171:56): 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 23:05:54.177652 systemd-logind[803]: New session 8 of user core. Dec 12 23:05:54.187303 systemd[1]: Started Session 8 of User core. Dec 12 23:05:54.235817 sshd[902]: pam_unix(sshd:session): session closed for user core Dec 12 23:05:54.238152 systemd[1]: session-8.scope: Deactivated successfully. Dec 12 23:05:54.238788 systemd-logind[803]: Session 8 logged out. Waiting for processes to exit. Dec 12 23:05:54.238932 systemd[1]: sshd@7-10.0.0.6:22-10.0.0.1:56012.service: Deactivated successfully. Dec 12 23:05:54.239829 systemd-logind[803]: Removed session 8.