Oct 30 05:24:44.678179 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 30 05:24:44.678195 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 Oct 30 05:24:44.678203 kernel: efi: EFI v2.70 by EDK II Oct 30 05:24:44.678208 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 30 05:24:44.678213 kernel: efi: seeding entropy pool Oct 30 05:24:44.678217 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 30 05:24:44.678224 kernel: ACPI: Early table checksum verification disabled Oct 30 05:24:44.678228 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 30 05:24:44.678233 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 30 05:24:44.678238 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:24:44.678244 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:24:44.678249 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:24:44.678254 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:24:44.678259 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:24:44.678265 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:24:44.678270 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:24:44.678277 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:24:44.678282 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:24:44.678288 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 30 05:24:44.678293 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 30 05:24:44.678298 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:24:44.678303 kernel: NUMA: NODE_DATA [mem 0xdc959900-0xdc95efff] Oct 30 05:24:44.678308 kernel: Zone ranges: Oct 30 05:24:44.678313 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:24:44.678318 kernel: DMA32 empty Oct 30 05:24:44.678323 kernel: Normal empty Oct 30 05:24:44.678328 kernel: Movable zone start for each node Oct 30 05:24:44.678334 kernel: Early memory node ranges Oct 30 05:24:44.678339 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 30 05:24:44.678345 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 30 05:24:44.678350 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 30 05:24:44.678361 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 30 05:24:44.678366 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 30 05:24:44.678372 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 30 05:24:44.678377 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 30 05:24:44.678382 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 30 05:24:44.678387 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 30 05:24:44.678392 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 30 05:24:44.678397 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 30 05:24:44.678403 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:24:44.678411 kernel: On node 0 totalpages: 643072 Oct 30 05:24:44.678417 kernel: DMA zone: 10048 pages used for memmap Oct 30 05:24:44.678422 kernel: DMA zone: 0 pages reserved Oct 30 05:24:44.678427 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 30 05:24:44.678433 kernel: psci: probing for conduit method from ACPI. Oct 30 05:24:44.678438 kernel: psci: PSCIv1.1 detected in firmware. Oct 30 05:24:44.678443 kernel: psci: Using standard PSCI v0.2 function IDs Oct 30 05:24:44.678449 kernel: psci: Trusted OS migration not required Oct 30 05:24:44.678455 kernel: psci: SMC Calling Convention v1.1 Oct 30 05:24:44.678460 kernel: ACPI: SRAT not present Oct 30 05:24:44.678466 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 30 05:24:44.678472 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 30 05:24:44.678477 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 30 05:24:44.678482 kernel: Detected PIPT I-cache on CPU0 Oct 30 05:24:44.678488 kernel: CPU features: detected: GIC system register CPU interface Oct 30 05:24:44.678493 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 30 05:24:44.678499 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 30 05:24:44.678504 kernel: CPU features: detected: Hardware dirty bit management Oct 30 05:24:44.678510 kernel: CPU features: detected: Spectre-v4 Oct 30 05:24:44.678516 kernel: CPU features: detected: ARM erratum 1418040 Oct 30 05:24:44.678521 kernel: CPU features: detected: Spectre-BHB Oct 30 05:24:44.678526 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 30 05:24:44.678532 kernel: Policy zone: DMA Oct 30 05:24:44.678538 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 Oct 30 05:24:44.678544 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 30 05:24:44.678550 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 30 05:24:44.678555 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 30 05:24:44.678561 kernel: Memory: 2452096K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120192K reserved, 0K cma-reserved) Oct 30 05:24:44.678567 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 30 05:24:44.678572 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 30 05:24:44.678578 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 30 05:24:44.678584 kernel: rcu: RCU event tracing is enabled. Oct 30 05:24:44.678590 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 30 05:24:44.678595 kernel: Trampoline variant of Tasks RCU enabled. Oct 30 05:24:44.678601 kernel: Tracing variant of Tasks RCU enabled. Oct 30 05:24:44.678606 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 30 05:24:44.678612 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 30 05:24:44.678617 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 30 05:24:44.678631 kernel: GICv3: 256 SPIs implemented Oct 30 05:24:44.678636 kernel: GICv3: 0 Extended SPIs implemented Oct 30 05:24:44.678642 kernel: GICv3: Distributor has no Range Selector support Oct 30 05:24:44.678647 kernel: GICv3: 16 PPIs implemented Oct 30 05:24:44.678655 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 30 05:24:44.678660 kernel: ACPI: SRAT not present Oct 30 05:24:44.678665 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 30 05:24:44.678671 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 30 05:24:44.678677 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 30 05:24:44.678682 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 30 05:24:44.678688 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 30 05:24:44.678693 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:24:44.678699 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 30 05:24:44.678704 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 30 05:24:44.678710 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 30 05:24:44.678716 kernel: arm-pv: using stolen time PV Oct 30 05:24:44.678723 kernel: Console: colour dummy device 80x25 Oct 30 05:24:44.678729 kernel: ACPI: Core revision 20200925 Oct 30 05:24:44.678734 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 30 05:24:44.678740 kernel: pid_max: default: 32768 minimum: 301 Oct 30 05:24:44.678746 kernel: LSM: Security Framework initializing Oct 30 05:24:44.678752 kernel: SELinux: Initializing. Oct 30 05:24:44.678758 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 30 05:24:44.678763 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 30 05:24:44.678769 kernel: rcu: Hierarchical SRCU implementation. Oct 30 05:24:44.678776 kernel: Platform MSI: ITS@0x8080000 domain created Oct 30 05:24:44.678781 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 30 05:24:44.678787 kernel: Remapping and enabling EFI services. Oct 30 05:24:44.678792 kernel: smp: Bringing up secondary CPUs ... Oct 30 05:24:44.678798 kernel: Detected PIPT I-cache on CPU1 Oct 30 05:24:44.678804 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 30 05:24:44.678810 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 30 05:24:44.678815 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:24:44.678821 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 30 05:24:44.678827 kernel: Detected PIPT I-cache on CPU2 Oct 30 05:24:44.678834 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 30 05:24:44.678839 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 30 05:24:44.678845 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:24:44.678851 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 30 05:24:44.678857 kernel: Detected PIPT I-cache on CPU3 Oct 30 05:24:44.678866 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 30 05:24:44.678872 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 30 05:24:44.678879 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:24:44.678885 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 30 05:24:44.678891 kernel: smp: Brought up 1 node, 4 CPUs Oct 30 05:24:44.678897 kernel: SMP: Total of 4 processors activated. Oct 30 05:24:44.678903 kernel: CPU features: detected: Privileged Access Never Oct 30 05:24:44.678909 kernel: CPU features: detected: LSE atomic instructions Oct 30 05:24:44.678915 kernel: CPU features: detected: User Access Override Oct 30 05:24:44.678921 kernel: CPU features: detected: 32-bit EL0 Support Oct 30 05:24:44.678926 kernel: CPU features: detected: Common not Private translations Oct 30 05:24:44.678932 kernel: CPU features: detected: RAS Extension Support Oct 30 05:24:44.678939 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 30 05:24:44.678945 kernel: CPU features: detected: CRC32 instructions Oct 30 05:24:44.678951 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 30 05:24:44.678957 kernel: CPU: All CPU(s) started at EL1 Oct 30 05:24:44.678963 kernel: alternatives: patching kernel code Oct 30 05:24:44.678970 kernel: devtmpfs: initialized Oct 30 05:24:44.678976 kernel: KASLR enabled Oct 30 05:24:44.678982 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 30 05:24:44.678988 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 30 05:24:44.678994 kernel: pinctrl core: initialized pinctrl subsystem Oct 30 05:24:44.679000 kernel: SMBIOS 3.0.0 present. Oct 30 05:24:44.679006 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 30 05:24:44.679012 kernel: NET: Registered protocol family 16 Oct 30 05:24:44.679018 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 30 05:24:44.679024 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 30 05:24:44.679031 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 30 05:24:44.679037 kernel: audit: initializing netlink subsys (disabled) Oct 30 05:24:44.679043 kernel: audit: type=2000 audit(0.029:1): state=initialized audit_enabled=0 res=1 Oct 30 05:24:44.679049 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 30 05:24:44.679055 kernel: cpuidle: using governor menu Oct 30 05:24:44.679061 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 30 05:24:44.679067 kernel: ASID allocator initialised with 32768 entries Oct 30 05:24:44.679073 kernel: ACPI: bus type PCI registered Oct 30 05:24:44.679079 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 30 05:24:44.679086 kernel: Serial: AMBA PL011 UART driver Oct 30 05:24:44.679092 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 30 05:24:44.679098 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 30 05:24:44.679104 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 30 05:24:44.679110 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 30 05:24:44.679116 kernel: cryptd: max_cpu_qlen set to 1000 Oct 30 05:24:44.679122 kernel: ACPI: Added _OSI(Module Device) Oct 30 05:24:44.679128 kernel: ACPI: Added _OSI(Processor Device) Oct 30 05:24:44.679134 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 30 05:24:44.679141 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 30 05:24:44.679147 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 30 05:24:44.679153 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 30 05:24:44.679160 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 30 05:24:44.679166 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 30 05:24:44.679172 kernel: ACPI: Interpreter enabled Oct 30 05:24:44.679178 kernel: ACPI: Using GIC for interrupt routing Oct 30 05:24:44.679184 kernel: ACPI: MCFG table detected, 1 entries Oct 30 05:24:44.679190 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 30 05:24:44.679196 kernel: printk: console [ttyAMA0] enabled Oct 30 05:24:44.679203 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 30 05:24:44.679321 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 30 05:24:44.679389 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 30 05:24:44.679442 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 30 05:24:44.679493 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 30 05:24:44.679545 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 30 05:24:44.679553 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 30 05:24:44.679562 kernel: PCI host bridge to bus 0000:00 Oct 30 05:24:44.679627 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 30 05:24:44.679680 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 30 05:24:44.679727 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 30 05:24:44.679773 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 30 05:24:44.679837 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 30 05:24:44.679898 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 30 05:24:44.679955 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 30 05:24:44.680009 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 30 05:24:44.680062 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 30 05:24:44.680116 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 30 05:24:44.680169 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 30 05:24:44.680223 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 30 05:24:44.680271 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 30 05:24:44.680319 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 30 05:24:44.680375 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 30 05:24:44.680384 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 30 05:24:44.680390 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 30 05:24:44.680396 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 30 05:24:44.680402 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 30 05:24:44.680408 kernel: vgaarb: loaded Oct 30 05:24:44.680414 kernel: Registered efivars operations Oct 30 05:24:44.680420 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 30 05:24:44.680428 kernel: VFS: Disk quotas dquot_6.6.0 Oct 30 05:24:44.680434 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 30 05:24:44.680440 kernel: pnp: PnP ACPI init Oct 30 05:24:44.680503 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 30 05:24:44.680553 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 30 05:24:44.680561 kernel: pnp: PnP ACPI: found 1 devices Oct 30 05:24:44.680566 kernel: NET: Registered protocol family 2 Oct 30 05:24:44.680573 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 30 05:24:44.680580 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 30 05:24:44.680586 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 30 05:24:44.680593 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 30 05:24:44.680599 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 30 05:24:44.680605 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 30 05:24:44.680611 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 30 05:24:44.680616 kernel: NET: Registered protocol family 1 Oct 30 05:24:44.680644 kernel: PCI: CLS 0 bytes, default 64 Oct 30 05:24:44.680651 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 30 05:24:44.680659 kernel: kvm [1]: HYP mode not available Oct 30 05:24:44.680664 kernel: Initialise system trusted keyrings Oct 30 05:24:44.680670 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 30 05:24:44.680676 kernel: Key type asymmetric registered Oct 30 05:24:44.680682 kernel: Asymmetric key parser 'x509' registered Oct 30 05:24:44.680688 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 30 05:24:44.680694 kernel: io scheduler mq-deadline registered Oct 30 05:24:44.680700 kernel: io scheduler kyber registered Oct 30 05:24:44.680706 kernel: io scheduler bfq registered Oct 30 05:24:44.680714 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 30 05:24:44.680720 kernel: ACPI: Power Button [PWRB] Oct 30 05:24:44.680725 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 30 05:24:44.680783 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 30 05:24:44.680792 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 30 05:24:44.680798 kernel: msm_serial: driver initialized Oct 30 05:24:44.680804 kernel: random: fast init done Oct 30 05:24:44.680809 kernel: random: crng init done Oct 30 05:24:44.680815 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 30 05:24:44.680822 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 30 05:24:44.680829 kernel: thunder_xcv, ver 1.0 Oct 30 05:24:44.680835 kernel: thunder_bgx, ver 1.0 Oct 30 05:24:44.680841 kernel: nicpf, ver 1.0 Oct 30 05:24:44.680847 kernel: nicvf, ver 1.0 Oct 30 05:24:44.680905 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 30 05:24:44.680955 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-30T05:24:44 UTC (1761801884) Oct 30 05:24:44.680963 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 30 05:24:44.680969 kernel: NET: Registered protocol family 10 Oct 30 05:24:44.680976 kernel: Segment Routing with IPv6 Oct 30 05:24:44.680982 kernel: NET: Registered protocol family 17 Oct 30 05:24:44.680988 kernel: Key type dns_resolver registered Oct 30 05:24:44.680994 kernel: registered taskstats version 1 Oct 30 05:24:44.681000 kernel: Loading compiled-in X.509 certificates Oct 30 05:24:44.681006 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 30 05:24:44.681012 kernel: Key type ._fscrypt registered Oct 30 05:24:44.681018 kernel: Key type .fscrypt registered Oct 30 05:24:44.681024 kernel: Key type fscrypt-provisioning registered Oct 30 05:24:44.681031 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 30 05:24:44.681037 kernel: ima: Allocated hash algorithm: sha1 Oct 30 05:24:44.681043 kernel: ima: No architecture policies found Oct 30 05:24:44.681049 kernel: Freeing unused kernel memory: 34240K Oct 30 05:24:44.681055 kernel: Run /init as init process Oct 30 05:24:44.681060 kernel: with arguments: Oct 30 05:24:44.681066 kernel: /init Oct 30 05:24:44.681072 kernel: with environment: Oct 30 05:24:44.681078 kernel: HOME=/ Oct 30 05:24:44.681084 kernel: TERM=linux Oct 30 05:24:44.681091 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 30 05:24:44.681099 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) Oct 30 05:24:44.681107 systemd[1]: Detected virtualization kvm. Oct 30 05:24:44.681113 systemd[1]: Detected architecture arm64. Oct 30 05:24:44.681120 systemd[1]: Running in initial RAM disk. Oct 30 05:24:44.681126 systemd[1]: No hostname configured, using default hostname. Oct 30 05:24:44.681132 systemd[1]: Hostname set to . Oct 30 05:24:44.681140 systemd[1]: Initializing machine ID from VM UUID. Oct 30 05:24:44.681147 systemd[1]: Queued start job for default target Initrd Default Target. Oct 30 05:24:44.681153 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 30 05:24:44.681159 systemd[1]: Reached target Local Encrypted Volumes. Oct 30 05:24:44.681165 systemd[1]: Reached target Path Units. Oct 30 05:24:44.681172 systemd[1]: Reached target Slice Units. Oct 30 05:24:44.681178 systemd[1]: Reached target Swaps. Oct 30 05:24:44.681184 systemd[1]: Reached target Timer Units. Oct 30 05:24:44.681192 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 30 05:24:44.681199 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 30 05:24:44.681205 systemd[1]: Listening on Journal Audit Socket. Oct 30 05:24:44.681211 systemd[1]: Listening on Journal Socket (/dev/log). Oct 30 05:24:44.681218 systemd[1]: Listening on Journal Socket. Oct 30 05:24:44.681224 systemd[1]: Listening on Network Service Netlink Socket. Oct 30 05:24:44.681230 systemd[1]: Listening on udev Control Socket. Oct 30 05:24:44.681237 systemd[1]: Listening on udev Kernel Socket. Oct 30 05:24:44.681243 systemd[1]: Reached target Socket Units. Oct 30 05:24:44.681251 systemd[1]: Starting Create List of Static Device Nodes... Oct 30 05:24:44.681257 systemd[1]: Finished Network Cleanup. Oct 30 05:24:44.681263 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 30 05:24:44.681270 systemd[1]: Starting Journal Service... Oct 30 05:24:44.681276 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 30 05:24:44.681283 systemd[1]: Starting Apply Kernel Variables... Oct 30 05:24:44.681289 systemd[1]: Starting Setup Virtual Console... Oct 30 05:24:44.681295 systemd[1]: Finished Create List of Static Device Nodes. Oct 30 05:24:44.681302 systemd[1]: Finished Apply Kernel Variables. Oct 30 05:24:44.681309 systemd[1]: Finished Setup Virtual Console. Oct 30 05:24:44.681315 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 30 05:24:44.681324 systemd-journald[279]: Journal started Oct 30 05:24:44.681363 systemd-journald[279]: Runtime Journal (/run/log/journal/405d5b88619e4982ab91f873a02d04cf) is 6.0M, max 48.5M, 42.4M free. Oct 30 05:24:44.683259 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 30 05:24:44.684650 systemd[1]: Started Journal Service. Oct 30 05:24:44.685001 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 30 05:24:44.696312 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 30 05:24:44.697953 systemd[1]: Starting dracut cmdline hook... Oct 30 05:24:44.706226 dracut-cmdline[296]: dracut-dracut-053 Oct 30 05:24:44.708351 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 Oct 30 05:24:44.763640 kernel: SCSI subsystem initialized Oct 30 05:24:44.766638 kernel: Loading iSCSI transport class v2.0-870. Oct 30 05:24:44.772676 kernel: iscsi: registered transport (tcp) Oct 30 05:24:44.783851 kernel: iscsi: registered transport (qla4xxx) Oct 30 05:24:44.783868 kernel: QLogic iSCSI HBA Driver Oct 30 05:24:44.793038 systemd[1]: Finished dracut cmdline hook. Oct 30 05:24:44.794408 systemd[1]: Starting dracut pre-udev hook... Oct 30 05:24:44.807251 kernel: device-mapper: uevent: version 1.0.3 Oct 30 05:24:44.807277 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 30 05:24:44.841646 kernel: raid6: neonx8 gen() 13766 MB/s Oct 30 05:24:44.858644 kernel: raid6: neonx8 xor() 10732 MB/s Oct 30 05:24:44.875639 kernel: raid6: neonx4 gen() 13593 MB/s Oct 30 05:24:44.892643 kernel: raid6: neonx4 xor() 11556 MB/s Oct 30 05:24:44.909641 kernel: raid6: neonx2 gen() 12993 MB/s Oct 30 05:24:44.926637 kernel: raid6: neonx2 xor() 9867 MB/s Oct 30 05:24:44.944674 kernel: raid6: neonx1 gen() 10951 MB/s Oct 30 05:24:44.960664 kernel: raid6: neonx1 xor() 8840 MB/s Oct 30 05:24:44.977659 kernel: raid6: int64x8 gen() 6821 MB/s Oct 30 05:24:44.994653 kernel: raid6: int64x8 xor() 3796 MB/s Oct 30 05:24:45.011645 kernel: raid6: int64x4 gen() 6915 MB/s Oct 30 05:24:45.028652 kernel: raid6: int64x4 xor() 3838 MB/s Oct 30 05:24:45.045652 kernel: raid6: int64x2 gen() 6162 MB/s Oct 30 05:24:45.062650 kernel: raid6: int64x2 xor() 3317 MB/s Oct 30 05:24:45.079652 kernel: raid6: int64x1 gen() 5009 MB/s Oct 30 05:24:45.096757 kernel: raid6: int64x1 xor() 2598 MB/s Oct 30 05:24:45.096776 kernel: raid6: using algorithm neonx8 gen() 13766 MB/s Oct 30 05:24:45.096791 kernel: raid6: .... xor() 10732 MB/s, rmw enabled Oct 30 05:24:45.097797 kernel: raid6: using neon recovery algorithm Oct 30 05:24:45.108047 kernel: xor: measuring software checksum speed Oct 30 05:24:45.108061 kernel: 8regs : 17145 MB/sec Oct 30 05:24:45.109072 kernel: 32regs : 20760 MB/sec Oct 30 05:24:45.109948 kernel: arm64_neon : 29163 MB/sec Oct 30 05:24:45.109959 kernel: xor: using function: arm64_neon (29163 MB/sec) Oct 30 05:24:45.154647 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 30 05:24:45.164216 systemd[1]: Finished dracut pre-udev hook. Oct 30 05:24:45.164000 audit: BPF prog-id=6 op=LOAD Oct 30 05:24:45.166000 audit: BPF prog-id=7 op=LOAD Oct 30 05:24:45.167323 kernel: audit: type=1334 audit(1761801885.164:2): prog-id=6 op=LOAD Oct 30 05:24:45.167343 kernel: audit: type=1334 audit(1761801885.166:3): prog-id=7 op=LOAD Oct 30 05:24:45.167351 kernel: audit: type=1334 audit(1761801885.167:4): prog-id=8 op=LOAD Oct 30 05:24:45.167000 audit: BPF prog-id=8 op=LOAD Oct 30 05:24:45.167645 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 30 05:24:45.179237 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 30 05:24:45.180914 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 30 05:24:45.183685 systemd[1]: Starting dracut pre-trigger hook... Oct 30 05:24:45.186853 systemd[1]: Starting Network Configuration... Oct 30 05:24:45.185000 audit: BPF prog-id=9 op=LOAD Oct 30 05:24:45.189649 kernel: audit: type=1334 audit(1761801885.185:5): prog-id=9 op=LOAD Oct 30 05:24:45.195781 dracut-pre-trigger[425]: rd.md=0: removing MD RAID activation Oct 30 05:24:45.204851 systemd-networkd[428]: lo: Link UP Oct 30 05:24:45.204857 systemd-networkd[428]: lo: Gained carrier Oct 30 05:24:45.205120 systemd-networkd[428]: Enumeration completed Oct 30 05:24:45.210844 kernel: audit: type=1334 audit(1761801885.206:6): prog-id=10 op=LOAD Oct 30 05:24:45.206000 audit: BPF prog-id=10 op=LOAD Oct 30 05:24:45.205183 systemd[1]: Started Network Configuration. Oct 30 05:24:45.207818 systemd[1]: Starting Network Name Resolution... Oct 30 05:24:45.221584 systemd[1]: Finished dracut pre-trigger hook. Oct 30 05:24:45.223013 systemd[1]: Starting Coldplug All udev Devices... Oct 30 05:24:45.232169 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 30 05:24:45.235058 systemd-resolved[447]: Positive Trust Anchors: Oct 30 05:24:45.235074 systemd-resolved[447]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 30 05:24:45.235102 systemd-resolved[447]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Oct 30 05:24:45.235375 systemd-resolved[447]: Defaulting to hostname 'linux'. Oct 30 05:24:45.235975 systemd[1]: Started Network Name Resolution. Oct 30 05:24:45.253674 iscsid[471]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 30 05:24:45.253674 iscsid[471]: 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 Oct 30 05:24:45.253674 iscsid[471]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Oct 30 05:24:45.253674 iscsid[471]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 30 05:24:45.253674 iscsid[471]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 30 05:24:45.253674 iscsid[471]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 30 05:24:45.253674 iscsid[471]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 30 05:24:45.236820 systemd[1]: Reached target Network. Oct 30 05:24:45.237480 systemd[1]: Reached target Host and Network Name Lookups. Oct 30 05:24:45.239677 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 30 05:24:45.245463 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 30 05:24:45.247049 systemd[1]: Starting Open-iSCSI... Oct 30 05:24:45.255661 systemd[1]: Started Open-iSCSI. Oct 30 05:24:45.259545 systemd[1]: Finished Coldplug All udev Devices. Oct 30 05:24:45.262959 systemd[1]: Starting dracut initqueue hook... Oct 30 05:24:45.286421 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 30 05:24:45.286533 kernel: vda: detected capacity change from 0 to 4756340736 Oct 30 05:24:45.293641 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 30 05:24:45.294026 systemd-udevd[477]: Using default interface naming scheme 'v249'. Oct 30 05:24:45.298996 systemd-networkd[428]: eth0: Link UP Oct 30 05:24:45.310648 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (466) Oct 30 05:24:45.311997 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 30 05:24:45.314236 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 30 05:24:45.315336 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 30 05:24:45.320569 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Oct 30 05:24:45.324777 systemd[1]: Found device /dev/disk/by-label/OEM. Oct 30 05:24:45.325611 systemd[1]: Reached target Initrd Root Device. Oct 30 05:24:45.327686 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 30 05:24:45.329771 systemd[1]: Finished dracut initqueue hook. Oct 30 05:24:45.330636 systemd[1]: Reached target Preparation for Remote File Systems. Oct 30 05:24:45.332562 systemd[1]: Reached target Remote Encrypted Volumes. Oct 30 05:24:45.334306 systemd[1]: Reached target Remote File Systems. Oct 30 05:24:45.338021 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 30 05:24:45.337594 systemd[1]: Starting dracut pre-mount hook... Oct 30 05:24:45.345044 systemd[1]: Finished dracut pre-mount hook. Oct 30 05:24:46.338769 systemd-networkd[428]: eth0: Gained carrier Oct 30 05:24:46.340219 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 30 05:24:46.344649 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 30 05:24:46.344678 disk-uuid[501]: The operation has completed successfully. Oct 30 05:24:46.347709 systemd-networkd[428]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 30 05:24:46.365749 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 30 05:24:46.365866 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 30 05:24:46.367652 systemd[1]: Starting Ignition (setup)... Oct 30 05:24:46.375215 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 30 05:24:46.375242 kernel: BTRFS info (device vda6): has skinny extents Oct 30 05:24:46.380835 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 30 05:24:46.385196 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 30 05:24:46.385313 systemd[1]: Finished Ignition (setup). Oct 30 05:24:46.387423 systemd[1]: Starting Ignition (disks)... Oct 30 05:24:46.396841 ignition[538]: Ignition v0.36.1-15-gde4e6cc9 Oct 30 05:24:46.396856 ignition[538]: Stage: disks Oct 30 05:24:46.396865 ignition[538]: reading system config file "/usr/lib/ignition/base.ign" Oct 30 05:24:46.396874 ignition[538]: no config at "/usr/lib/ignition/base.ign" Oct 30 05:24:46.396913 ignition[538]: parsed url from cmdline: "" Oct 30 05:24:46.396917 ignition[538]: no config URL provided Oct 30 05:24:46.396921 ignition[538]: reading system config file "/usr/lib/ignition/user.ign" Oct 30 05:24:46.396927 ignition[538]: no config at "/usr/lib/ignition/user.ign" Oct 30 05:24:46.396944 ignition[538]: op(1): [started] loading QEMU firmware config module Oct 30 05:24:46.396949 ignition[538]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 30 05:24:46.397677 ignition[538]: op(1): [finished] loading QEMU firmware config module Oct 30 05:24:46.411032 ignition[538]: parsing config with SHA512: caf899d4a2e64318217927a753fc6adfa1867be0bfe10a32913949ac37e38aa966318ba87cb7eaf0027e3fad3e13eb49f23c24a1e886ffdda7a2761e2ce52343 Oct 30 05:24:46.412915 ignition[538]: disks: disks passed Oct 30 05:24:46.412925 ignition[538]: Ignition finished successfully Oct 30 05:24:46.413742 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 30 05:24:46.413841 systemd[1]: Finished Ignition (disks). Oct 30 05:24:46.415056 systemd[1]: Reached target Preparation for Local File Systems. Oct 30 05:24:46.417192 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 30 05:24:46.418733 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 30 05:24:46.426366 systemd-fsck[551]: ROOT: clean, 528/553792 files, 37752/553472 blocks Oct 30 05:24:46.431158 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 30 05:24:46.432876 systemd[1]: Mounting /sysroot... Oct 30 05:24:46.435323 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 30 05:24:46.454305 systemd[1]: Found device /dev/mapper/usr. Oct 30 05:24:46.456318 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 30 05:24:46.458600 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 30 05:24:46.465491 systemd-fsck[566]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 30 05:24:46.465491 systemd-fsck[566]: You must have r/w access to the filesystem or be root Oct 30 05:24:46.466251 systemd-fsck[563]: fsck failed with exit status 8. Oct 30 05:24:46.466255 systemd-fsck[563]: Ignoring error. Oct 30 05:24:46.475249 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 30 05:24:46.475269 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 30 05:24:46.467930 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 30 05:24:46.470754 systemd[1]: Mounting /sysusr/usr... Oct 30 05:24:46.479334 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 30 05:24:46.474011 systemd[1]: Mounted /sysroot. Oct 30 05:24:46.475927 systemd[1]: Reached target Initrd Root File System. Oct 30 05:24:46.479248 systemd[1]: Mounted /sysusr/usr. Oct 30 05:24:46.480105 systemd[1]: Reached target Local File Systems. Oct 30 05:24:46.481183 systemd[1]: Reached target System Initialization. Oct 30 05:24:46.482616 systemd[1]: Reached target Basic System. Oct 30 05:24:46.484855 systemd[1]: Mounting /sysroot/usr... Oct 30 05:24:46.486771 systemd[1]: Mounted /sysroot/usr. Oct 30 05:24:46.488459 systemd[1]: Starting Root filesystem setup... Oct 30 05:24:46.510103 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 30 05:24:46.510226 systemd[1]: Finished Root filesystem setup. Oct 30 05:24:46.512417 systemd[1]: Starting Ignition (files)... Oct 30 05:24:46.513647 systemd[1]: Starting /sysroot/boot... Oct 30 05:24:46.514814 ignition[582]: Ignition v0.36.1-15-gde4e6cc9 Oct 30 05:24:46.514821 ignition[582]: Stage: files Oct 30 05:24:46.514830 ignition[582]: reading system config file "/usr/lib/ignition/base.ign" Oct 30 05:24:46.514854 ignition[582]: no config at "/usr/lib/ignition/base.ign" Oct 30 05:24:46.515319 ignition[582]: files: compiled without relabeling support, skipping Oct 30 05:24:46.529263 ignition[582]: files: createUsers: op(1): [started] creating or modifying user "core" Oct 30 05:24:46.529278 ignition[582]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Oct 30 05:24:46.531153 ignition[582]: files: createUsers: op(1): [finished] creating or modifying user "core" Oct 30 05:24:46.531168 ignition[582]: files: createUsers: op(2): [started] adding ssh keys to user "core" Oct 30 05:24:46.531601 systemd[1]: Finished /sysroot/boot. Oct 30 05:24:46.534008 ignition[582]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Oct 30 05:24:46.535529 systemd[1]: ignition-files.service: Deactivated successfully. Oct 30 05:24:46.534029 ignition[582]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Oct 30 05:24:46.535670 systemd[1]: Finished Ignition (files). Oct 30 05:24:46.534267 ignition[582]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Oct 30 05:24:46.537439 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Oct 30 05:24:46.534274 ignition[582]: files: op(4): [started] processing unit "coreos-metadata.service" Oct 30 05:24:46.548264 kernel: audit: type=1334 audit(1761801886.545:7): prog-id=6 op=UNLOAD Oct 30 05:24:46.548283 kernel: audit: type=1334 audit(1761801886.546:8): prog-id=3 op=UNLOAD Oct 30 05:24:46.548292 kernel: audit: type=1334 audit(1761801886.547:9): prog-id=10 op=UNLOAD Oct 30 05:24:46.545000 audit: BPF prog-id=6 op=UNLOAD Oct 30 05:24:46.546000 audit: BPF prog-id=3 op=UNLOAD Oct 30 05:24:46.547000 audit: BPF prog-id=10 op=UNLOAD Oct 30 05:24:46.538023 systemd[1]: Starting Ignition (record completion)... Oct 30 05:24:46.553341 kernel: audit: type=1334 audit(1761801886.547:10): prog-id=9 op=UNLOAD Oct 30 05:24:46.547000 audit: BPF prog-id=9 op=UNLOAD Oct 30 05:24:46.534372 ignition[582]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 30 05:24:46.539457 systemd[1]: Starting Reload Configuration from the Real Root... Oct 30 05:24:46.534726 ignition[582]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 30 05:24:46.541453 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 30 05:24:46.534731 ignition[582]: files: op(4): [finished] processing unit "coreos-metadata.service" Oct 30 05:24:46.541557 systemd[1]: Finished Ignition (record completion). Oct 30 05:24:46.534735 ignition[582]: files: files passed Oct 30 05:24:46.543939 systemd[1]: Reloading. Oct 30 05:24:46.534738 ignition[582]: Ignition finished successfully Oct 30 05:24:46.624000 audit: BPF prog-id=11 op=LOAD Oct 30 05:24:46.624000 audit: BPF prog-id=12 op=LOAD Oct 30 05:24:46.624000 audit: BPF prog-id=13 op=LOAD Oct 30 05:24:46.624000 audit: BPF prog-id=7 op=UNLOAD Oct 30 05:24:46.624000 audit: BPF prog-id=8 op=UNLOAD Oct 30 05:24:46.625000 audit: BPF prog-id=14 op=LOAD Oct 30 05:24:46.625000 audit: BPF prog-id=15 op=LOAD Oct 30 05:24:46.625000 audit: BPF prog-id=16 op=LOAD Oct 30 05:24:46.625000 audit: BPF prog-id=4 op=UNLOAD Oct 30 05:24:46.625000 audit: BPF prog-id=5 op=UNLOAD Oct 30 05:24:46.625000 audit: BPF prog-id=17 op=LOAD Oct 30 05:24:46.626000 audit: BPF prog-id=18 op=LOAD Oct 30 05:24:46.639324 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 30 05:24:46.639436 systemd[1]: Finished Reload Configuration from the Real Root. Oct 30 05:24:46.641342 systemd[1]: Reached target Initrd File Systems. Oct 30 05:24:46.642864 systemd[1]: Reached target Initrd Default Target. Oct 30 05:24:46.644337 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 30 05:24:46.644938 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 30 05:24:46.654465 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 30 05:24:46.656020 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 30 05:24:46.661571 systemd[1]: Stopped target Host and Network Name Lookups. Oct 30 05:24:46.662667 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 30 05:24:46.664314 systemd[1]: Stopped target Timer Units. Oct 30 05:24:46.665667 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 30 05:24:46.665771 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 30 05:24:46.667150 systemd[1]: Stopped target Initrd Default Target. Oct 30 05:24:46.668751 systemd[1]: Stopped target Basic System. Oct 30 05:24:46.670154 systemd[1]: Stopped target Initrd Root Device. Oct 30 05:24:46.671577 systemd[1]: Stopped target Path Units. Oct 30 05:24:46.672861 systemd[1]: Stopped target Remote File Systems. Oct 30 05:24:46.674278 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 30 05:24:46.675703 systemd[1]: Stopped target Slice Units. Oct 30 05:24:46.677056 systemd[1]: Stopped target Socket Units. Oct 30 05:24:46.678523 systemd[1]: Stopped target System Initialization. Oct 30 05:24:46.679862 systemd[1]: Stopped target Local File Systems. Oct 30 05:24:46.681169 systemd[1]: Stopped target Preparation for Local File Systems. Oct 30 05:24:46.682738 systemd[1]: Stopped target Swaps. Oct 30 05:24:46.684004 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 30 05:24:46.684102 systemd[1]: Stopped dracut pre-mount hook. Oct 30 05:24:46.685524 systemd[1]: Stopped target Local Encrypted Volumes. Oct 30 05:24:46.686766 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 30 05:24:46.690659 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 30 05:24:46.691751 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 30 05:24:46.691842 systemd[1]: Stopped dracut initqueue hook. Oct 30 05:24:46.695418 iscsid[471]: iscsid shutting down. Oct 30 05:24:46.693572 systemd[1]: Stopping Open-iSCSI... Oct 30 05:24:46.695363 systemd[1]: Stopping /sysroot/boot... Oct 30 05:24:46.696011 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 30 05:24:46.696131 systemd[1]: Stopped Coldplug All udev Devices. Oct 30 05:24:46.697446 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 30 05:24:46.697519 systemd[1]: Stopped dracut pre-trigger hook. Oct 30 05:24:46.699523 systemd[1]: iscsid.service: Deactivated successfully. Oct 30 05:24:46.699656 systemd[1]: Stopped Open-iSCSI. Oct 30 05:24:46.701370 systemd[1]: iscsid.socket: Deactivated successfully. Oct 30 05:24:46.701430 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 30 05:24:46.703022 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 30 05:24:46.704482 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 30 05:24:46.704578 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 30 05:24:46.706054 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 30 05:24:46.706150 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 30 05:24:46.707549 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 30 05:24:46.707664 systemd[1]: Stopped /sysroot/boot. Oct 30 05:24:46.709141 systemd[1]: Stopped target Network. Oct 30 05:24:46.709933 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 30 05:24:46.709989 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 30 05:24:46.711392 systemd[1]: Stopping Network Name Resolution... Oct 30 05:24:46.718641 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 30 05:24:46.718742 systemd[1]: Stopped Network Name Resolution. Oct 30 05:24:46.720331 systemd[1]: Stopping Network Configuration... Oct 30 05:24:46.725755 systemd-networkd[428]: eth0: DHCP lease lost Oct 30 05:24:46.726000 audit: BPF prog-id=17 op=UNLOAD Oct 30 05:24:46.732667 systemd-networkd[428]: eth0: DHCPv6 lease lost Oct 30 05:24:46.733591 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 30 05:24:46.733707 systemd[1]: Stopped Network Configuration. Oct 30 05:24:46.735563 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 30 05:24:46.735590 systemd[1]: Closed Network Service Netlink Socket. Oct 30 05:24:46.737422 systemd[1]: Stopping Network Cleanup... Oct 30 05:24:46.738292 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 30 05:24:46.738365 systemd[1]: Stopped Apply Kernel Variables. Oct 30 05:24:46.744000 audit: BPF prog-id=18 op=UNLOAD Oct 30 05:24:46.741559 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 30 05:24:46.745175 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 30 05:24:46.745285 systemd[1]: Stopped Network Cleanup. Oct 30 05:24:46.747689 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 30 05:24:46.747809 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 30 05:24:46.749383 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 30 05:24:46.752000 audit: BPF prog-id=11 op=UNLOAD Oct 30 05:24:46.749422 systemd[1]: Closed udev Control Socket. Oct 30 05:24:46.750810 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 30 05:24:46.750841 systemd[1]: Closed udev Kernel Socket. Oct 30 05:24:46.752398 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 30 05:24:46.752439 systemd[1]: Stopped dracut pre-udev hook. Oct 30 05:24:46.754134 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 30 05:24:46.754173 systemd[1]: Stopped dracut cmdline hook. Oct 30 05:24:46.755463 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 30 05:24:46.755502 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 30 05:24:46.757894 systemd[1]: Starting Cleanup udev Database... Oct 30 05:24:46.758657 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 30 05:24:46.760286 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 30 05:24:46.760340 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 30 05:24:46.761728 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 30 05:24:46.761769 systemd[1]: Stopped Create List of Static Device Nodes. Oct 30 05:24:46.763371 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 30 05:24:46.763415 systemd[1]: Stopped Setup Virtual Console. Oct 30 05:24:46.764865 systemd[1]: rngd.service: Deactivated successfully. Oct 30 05:24:46.764972 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 30 05:24:46.776000 audit: BPF prog-id=14 op=UNLOAD Oct 30 05:24:46.766586 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 30 05:24:46.766699 systemd[1]: Finished Cleanup udev Database. Oct 30 05:24:46.768157 systemd[1]: Reached target Switch Root. Oct 30 05:24:46.769920 systemd[1]: Starting Switch Root... Oct 30 05:24:46.774499 systemd[1]: Switching root. Oct 30 05:24:46.797120 systemd-journald[279]: Journal stopped Oct 30 05:24:48.932036 systemd-journald[279]: Received SIGTERM from PID 1 (systemd). Oct 30 05:24:48.932083 kernel: SELinux: policy capability network_peer_controls=1 Oct 30 05:24:48.932098 kernel: SELinux: policy capability open_perms=1 Oct 30 05:24:48.932108 kernel: SELinux: policy capability extended_socket_class=1 Oct 30 05:24:48.932118 kernel: SELinux: policy capability always_check_network=0 Oct 30 05:24:48.932127 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 30 05:24:48.932136 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 30 05:24:48.932148 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 30 05:24:48.932157 systemd[1]: Successfully loaded SELinux policy in 35.870ms. Oct 30 05:24:48.932172 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.232ms. Oct 30 05:24:48.932183 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) Oct 30 05:24:48.932193 systemd[1]: Detected virtualization kvm. Oct 30 05:24:48.932203 systemd[1]: Detected architecture arm64. Oct 30 05:24:48.932213 systemd[1]: Detected first boot. Oct 30 05:24:48.932223 systemd[1]: Initializing machine ID from VM UUID. Oct 30 05:24:48.932238 systemd[1]: Populated /etc with preset unit settings. Oct 30 05:24:48.932250 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. Oct 30 05:24:48.932260 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 30 05:24:48.932270 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 30 05:24:48.932280 systemd[1]: Stopped Switch Root. Oct 30 05:24:48.932289 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 30 05:24:48.932299 systemd[1]: Created slice Slice /system/addon-config. Oct 30 05:24:48.932309 systemd[1]: Created slice Slice /system/addon-run. Oct 30 05:24:48.932319 systemd[1]: Created slice Slice /system/getty. Oct 30 05:24:48.932329 systemd[1]: Created slice Slice /system/modprobe. Oct 30 05:24:48.932350 systemd[1]: Created slice Slice /system/serial-getty. Oct 30 05:24:48.932362 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 30 05:24:48.932372 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 30 05:24:48.932381 systemd[1]: Created slice User and Session Slice. Oct 30 05:24:48.932391 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 30 05:24:48.932401 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 30 05:24:48.932410 systemd[1]: Set up automount Boot partition Automount Point. Oct 30 05:24:48.932419 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 30 05:24:48.932430 systemd[1]: Stopped target Switch Root. Oct 30 05:24:48.932440 systemd[1]: Stopped target Initrd File Systems. Oct 30 05:24:48.932449 systemd[1]: Stopped target Initrd Root File System. Oct 30 05:24:48.932459 systemd[1]: Reached target Remote Encrypted Volumes. Oct 30 05:24:48.932468 systemd[1]: Reached target Remote File Systems. Oct 30 05:24:48.932477 systemd[1]: Reached target Slice Units. Oct 30 05:24:48.932487 systemd[1]: Reached target Swaps. Oct 30 05:24:48.932496 systemd[1]: Reached target Verify torcx succeeded. Oct 30 05:24:48.932505 systemd[1]: Reached target Local Verity Protected Volumes. Oct 30 05:24:48.932514 systemd[1]: Listening on Process Core Dump Socket. Oct 30 05:24:48.932526 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 30 05:24:48.932536 systemd[1]: Listening on Network Service Netlink Socket. Oct 30 05:24:48.932545 systemd[1]: Listening on udev Control Socket. Oct 30 05:24:48.932555 systemd[1]: Listening on udev Kernel Socket. Oct 30 05:24:48.932564 systemd[1]: Mounting Huge Pages File System... Oct 30 05:24:48.932573 systemd[1]: Mounting POSIX Message Queue File System... Oct 30 05:24:48.932582 systemd[1]: Mounting External Media Directory... Oct 30 05:24:48.932592 systemd[1]: Mounting Kernel Debug File System... Oct 30 05:24:48.932601 systemd[1]: Mounting Kernel Trace File System... Oct 30 05:24:48.932610 systemd[1]: Mounting Temporary Directory /tmp... Oct 30 05:24:48.932629 systemd[1]: Starting Create missing system files... Oct 30 05:24:48.932642 systemd[1]: Starting Create List of Static Device Nodes... Oct 30 05:24:48.932652 systemd[1]: Starting Load Kernel Module configfs... Oct 30 05:24:48.932661 systemd[1]: Starting Load Kernel Module drm... Oct 30 05:24:48.932671 systemd[1]: Starting Load Kernel Module fuse... Oct 30 05:24:48.932680 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 30 05:24:48.932690 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 30 05:24:48.932700 systemd[1]: Stopped File System Check on Root Device. Oct 30 05:24:48.932709 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 30 05:24:48.932720 systemd[1]: Stopped systemd-fsck-usr.service. Oct 30 05:24:48.932730 kernel: fuse: init (API version 7.32) Oct 30 05:24:48.932739 systemd[1]: Stopped Journal Service. Oct 30 05:24:48.932748 kernel: kauditd_printk_skb: 36 callbacks suppressed Oct 30 05:24:48.932757 kernel: audit: type=1334 audit(1761801888.915:47): prog-id=27 op=LOAD Oct 30 05:24:48.932766 kernel: audit: type=1334 audit(1761801888.916:48): prog-id=28 op=LOAD Oct 30 05:24:48.932775 systemd[1]: Starting Journal Service... Oct 30 05:24:48.932785 kernel: audit: type=1334 audit(1761801888.917:49): prog-id=29 op=LOAD Oct 30 05:24:48.932797 kernel: audit: type=1334 audit(1761801888.917:50): prog-id=25 op=UNLOAD Oct 30 05:24:48.932807 kernel: audit: type=1334 audit(1761801888.917:51): prog-id=26 op=UNLOAD Oct 30 05:24:48.932816 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 30 05:24:48.932852 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 30 05:24:48.932863 systemd[1]: Starting Apply Kernel Variables... Oct 30 05:24:48.932875 systemd[1]: Starting Coldplug All udev Devices... Oct 30 05:24:48.932885 kernel: audit: type=1305 audit(1761801888.930:52): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 30 05:24:48.932895 systemd-journald[798]: Journal started Oct 30 05:24:48.932928 systemd-journald[798]: Runtime Journal (/run/log/journal/405d5b88619e4982ab91f873a02d04cf) is 6.0M, max 48.5M, 42.4M free. Oct 30 05:24:46.864000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 30 05:24:46.893000 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 Oct 30 05:24:46.893000 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 Oct 30 05:24:46.893000 audit: BPF prog-id=19 op=LOAD Oct 30 05:24:46.893000 audit: BPF prog-id=19 op=UNLOAD Oct 30 05:24:46.893000 audit: BPF prog-id=20 op=LOAD Oct 30 05:24:46.893000 audit: BPF prog-id=20 op=UNLOAD Oct 30 05:24:46.923000 audit[748]: AVC avc: denied { associate } for pid=748 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 Oct 30 05:24:48.804000 audit: BPF prog-id=21 op=LOAD Oct 30 05:24:48.804000 audit: BPF prog-id=22 op=LOAD Oct 30 05:24:48.804000 audit: BPF prog-id=23 op=LOAD Oct 30 05:24:48.804000 audit: BPF prog-id=15 op=UNLOAD Oct 30 05:24:48.804000 audit: BPF prog-id=16 op=UNLOAD Oct 30 05:24:48.804000 audit: BPF prog-id=24 op=LOAD Oct 30 05:24:48.804000 audit: BPF prog-id=21 op=UNLOAD Oct 30 05:24:48.804000 audit: BPF prog-id=25 op=LOAD Oct 30 05:24:48.804000 audit: BPF prog-id=26 op=LOAD Oct 30 05:24:48.804000 audit: BPF prog-id=22 op=UNLOAD Oct 30 05:24:48.804000 audit: BPF prog-id=23 op=UNLOAD Oct 30 05:24:48.825000 audit: BPF prog-id=24 op=UNLOAD Oct 30 05:24:48.915000 audit: BPF prog-id=27 op=LOAD Oct 30 05:24:48.916000 audit: BPF prog-id=28 op=LOAD Oct 30 05:24:48.917000 audit: BPF prog-id=29 op=LOAD Oct 30 05:24:48.917000 audit: BPF prog-id=25 op=UNLOAD Oct 30 05:24:48.917000 audit: BPF prog-id=26 op=UNLOAD Oct 30 05:24:48.930000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 30 05:24:48.794827 systemd[1]: Queued start job for default target Multi-User System. Oct 30 05:24:46.922558 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" 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]" Oct 30 05:24:48.933646 systemd[1]: verity-setup.service: Deactivated successfully. Oct 30 05:24:48.805865 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 30 05:24:46.922828 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 30 05:24:46.922847 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 30 05:24:46.922950 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 30 05:24:46.922960 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 30 05:24:46.922988 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 30 05:24:46.923000 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 30 05:24:46.923176 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 30 05:24:46.923207 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 30 05:24:46.923221 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 30 05:24:46.923588 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" 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 Oct 30 05:24:46.923637 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" 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 Oct 30 05:24:46.923659 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" 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 Oct 30 05:24:46.923673 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 30 05:24:46.923691 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" 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 Oct 30 05:24:46.923704 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:46Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 30 05:24:48.630542 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:48Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 30 05:24:48.630828 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:48Z" 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 Oct 30 05:24:48.630930 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:48Z" 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 Oct 30 05:24:48.631045 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:48Z" 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 Oct 30 05:24:48.631098 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:48Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 30 05:24:48.631154 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-30T05:24:48Z" 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 Oct 30 05:24:48.936138 systemd[1]: Stopped verity-setup.service. Oct 30 05:24:48.938679 systemd[1]: Started Journal Service. Oct 30 05:24:48.939117 systemd[1]: Mounted Huge Pages File System. Oct 30 05:24:48.940016 systemd[1]: Mounted POSIX Message Queue File System. Oct 30 05:24:48.941003 systemd[1]: Mounted External Media Directory. Oct 30 05:24:48.941902 systemd[1]: Mounted Kernel Debug File System. Oct 30 05:24:48.942779 systemd[1]: Mounted Kernel Trace File System. Oct 30 05:24:48.943688 systemd[1]: Mounted Temporary Directory /tmp. Oct 30 05:24:48.944774 systemd[1]: Finished Create missing system files. Oct 30 05:24:48.945887 systemd[1]: Finished Create List of Static Device Nodes. Oct 30 05:24:48.947005 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 30 05:24:48.947180 systemd[1]: Finished Load Kernel Module configfs. Oct 30 05:24:48.948199 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 30 05:24:48.948384 systemd[1]: Finished Load Kernel Module drm. Oct 30 05:24:48.949390 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 30 05:24:48.949550 systemd[1]: Finished Load Kernel Module fuse. Oct 30 05:24:48.950760 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 30 05:24:48.959183 systemd[1]: Finished Apply Kernel Variables. Oct 30 05:24:48.961848 systemd[1]: Mounting FUSE Control File System... Oct 30 05:24:48.963530 systemd[1]: Mounting Kernel Configuration File System... Oct 30 05:24:48.964434 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 30 05:24:48.965839 systemd[1]: Starting Rebuild Hardware Database... Oct 30 05:24:48.967520 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 30 05:24:48.968541 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 30 05:24:48.969452 systemd[1]: Starting Load/Save Random Seed... Oct 30 05:24:48.971392 systemd-journald[798]: Time spent on flushing to /var/log/journal/405d5b88619e4982ab91f873a02d04cf is 8.418ms for 774 entries. Oct 30 05:24:48.971392 systemd-journald[798]: System Journal (/var/log/journal/405d5b88619e4982ab91f873a02d04cf) is 8.0M, max 203.0M, 195.0M free. Oct 30 05:24:48.972004 systemd[1]: Starting Create System Users... Oct 30 05:24:48.976483 systemd[1]: Mounted FUSE Control File System. Oct 30 05:24:48.977785 systemd[1]: Mounted Kernel Configuration File System. Oct 30 05:24:48.979041 systemd[1]: Finished Coldplug All udev Devices. Oct 30 05:24:48.984419 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 30 05:24:48.985787 systemd[1]: Finished Load/Save Random Seed. Oct 30 05:24:48.986830 systemd[1]: Reached target First Boot Complete. Oct 30 05:24:48.989984 systemd-sysusers[809]: Creating group sgx with gid 999. Oct 30 05:24:48.990708 systemd-sysusers[809]: Creating group systemd-oom with gid 998. Oct 30 05:24:48.991070 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 30 05:24:48.992610 systemd-sysusers[809]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Oct 30 05:24:48.993185 systemd-sysusers[809]: Creating group systemd-timesync with gid 997. Oct 30 05:24:48.993617 systemd-sysusers[809]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Oct 30 05:24:48.994151 systemd-sysusers[809]: Creating group systemd-coredump with gid 996. Oct 30 05:24:48.994587 systemd-sysusers[809]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Oct 30 05:24:49.002404 systemd[1]: Finished Create System Users. Oct 30 05:24:49.004210 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 30 05:24:49.016088 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 30 05:24:49.200648 systemd[1]: Finished Rebuild Hardware Database. Oct 30 05:24:49.211000 audit: BPF prog-id=30 op=LOAD Oct 30 05:24:49.213000 audit: BPF prog-id=31 op=LOAD Oct 30 05:24:49.214862 kernel: audit: type=1334 audit(1761801889.211:53): prog-id=30 op=LOAD Oct 30 05:24:49.214903 kernel: audit: type=1334 audit(1761801889.213:54): prog-id=31 op=LOAD Oct 30 05:24:49.214924 kernel: audit: type=1334 audit(1761801889.214:55): prog-id=32 op=LOAD Oct 30 05:24:49.214000 audit: BPF prog-id=32 op=LOAD Oct 30 05:24:49.215473 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 30 05:24:49.215746 kernel: audit: type=1334 audit(1761801889.214:56): prog-id=12 op=UNLOAD Oct 30 05:24:49.214000 audit: BPF prog-id=12 op=UNLOAD Oct 30 05:24:49.214000 audit: BPF prog-id=13 op=UNLOAD Oct 30 05:24:49.237819 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 30 05:24:49.244000 audit: BPF prog-id=33 op=LOAD Oct 30 05:24:49.245713 systemd[1]: Starting Network Configuration... Oct 30 05:24:49.269507 systemd-udevd[819]: Using default interface naming scheme 'v249'. Oct 30 05:24:49.274095 systemd-networkd[833]: lo: Link UP Oct 30 05:24:49.274288 systemd-networkd[833]: lo: Gained carrier Oct 30 05:24:49.274668 systemd-networkd[833]: Enumeration completed Oct 30 05:24:49.274812 systemd[1]: Started Network Configuration. Oct 30 05:24:49.275962 systemd-networkd[833]: eth0: Link UP Oct 30 05:24:49.284683 systemd-networkd[833]: eth0: Gained carrier Oct 30 05:24:49.290742 systemd-networkd[833]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 30 05:24:49.295821 udevadm[811]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 30 05:24:49.318914 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 30 05:24:49.327420 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 30 05:24:49.335520 lvm[842]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 30 05:24:49.363429 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 30 05:24:49.364934 systemd[1]: Reached target Local Encrypted Volumes. Oct 30 05:24:49.376331 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 30 05:24:49.380329 lvm[843]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 30 05:24:49.416499 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 30 05:24:49.417984 systemd[1]: Reached target Preparation for Local File Systems. Oct 30 05:24:49.419236 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 30 05:24:49.419269 systemd[1]: Reached target Containers. Oct 30 05:24:49.442028 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 30 05:24:49.452918 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 30 05:24:49.454905 systemd[1]: Mounting /usr/share/oem... Oct 30 05:24:49.460638 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 30 05:24:49.460680 kernel: BTRFS info (device vda6): has skinny extents Oct 30 05:24:49.462576 systemd[1]: Mounted /usr/share/oem. Oct 30 05:24:49.463424 systemd[1]: Reached target Local File Systems. Oct 30 05:24:49.472349 systemd[1]: Starting Rebuild Dynamic Linker Cache... Oct 30 05:24:49.473591 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 30 05:24:49.473647 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 30 05:24:49.474958 systemd[1]: Starting Commit a transient machine-id on disk... Oct 30 05:24:49.476823 systemd[1]: Starting Create Volatile Files and Directories... Oct 30 05:24:49.485645 systemd-tmpfiles[868]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 30 05:24:49.488367 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 30 05:24:49.488566 systemd-tmpfiles[868]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 30 05:24:49.489243 systemd[1]: Finished Commit a transient machine-id on disk. Oct 30 05:24:49.525024 systemd-tmpfiles[868]: Detected autofs mount point /boot during canonicalization of /boot. Oct 30 05:24:49.525034 systemd-tmpfiles[868]: Skipping /boot Oct 30 05:24:49.531867 systemd-tmpfiles[868]: Detected autofs mount point /boot during canonicalization of /boot. Oct 30 05:24:49.531881 systemd-tmpfiles[868]: Skipping /boot Oct 30 05:24:49.549651 systemd[1]: Finished Rebuild Dynamic Linker Cache. Oct 30 05:24:49.564270 systemd[1]: Finished Create Volatile Files and Directories. Oct 30 05:24:49.566453 systemd[1]: Starting Load Security Auditing Rules... Oct 30 05:24:49.568383 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 30 05:24:49.570705 systemd[1]: Starting Rebuild Journal Catalog... Oct 30 05:24:49.571000 audit: BPF prog-id=34 op=LOAD Oct 30 05:24:49.573381 systemd[1]: Starting Network Name Resolution... Oct 30 05:24:49.574000 audit: BPF prog-id=35 op=LOAD Oct 30 05:24:49.576320 systemd[1]: Starting Network Time Synchronization... Oct 30 05:24:49.578379 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 30 05:24:49.579950 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 30 05:24:49.581249 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 30 05:24:49.585164 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 30 05:24:49.587786 systemd[1]: Finished Rebuild Journal Catalog. Oct 30 05:24:49.589786 systemd[1]: Starting Update is Completed... Oct 30 05:24:49.590000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 30 05:24:49.591729 augenrules[889]: No rules Oct 30 05:24:49.593198 systemd[1]: Finished Load Security Auditing Rules. Oct 30 05:24:49.594578 systemd[1]: Finished Update is Completed. Oct 30 05:24:49.615591 systemd-resolved[878]: Positive Trust Anchors: Oct 30 05:24:49.615602 systemd-resolved[878]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 30 05:24:49.615665 systemd-resolved[878]: 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 Oct 30 05:24:49.616329 systemd-resolved[878]: Defaulting to hostname 'linux'. Oct 30 05:24:49.617863 systemd[1]: Started Network Name Resolution. Oct 30 05:24:49.618705 systemd[1]: Reached target Network. Oct 30 05:24:49.619401 systemd[1]: Reached target Host and Network Name Lookups. Oct 30 05:24:49.620780 systemd[1]: Started Network Time Synchronization. Oct 30 05:24:49.621409 systemd-timesyncd[879]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 30 05:24:49.621903 systemd[1]: Reached target System Initialization. Oct 30 05:24:49.622803 systemd[1]: Started Watch for update engine configuration changes. Oct 30 05:24:49.623861 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 30 05:24:49.624947 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 30 05:24:49.625892 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 30 05:24:49.625921 systemd[1]: Reached target Path Units. Oct 30 05:24:49.626615 systemd[1]: Reached target System Time Set. Oct 30 05:24:49.627511 systemd[1]: Started Daily Log Rotation. Oct 30 05:24:49.628401 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 30 05:24:49.629551 systemd[1]: Reached target Timer Units. Oct 30 05:24:49.630651 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 30 05:24:49.649618 systemd[1]: Starting Docker Socket for the API... Oct 30 05:24:49.652478 systemd[1]: Listening on OpenSSH Server Socket. Oct 30 05:24:49.653748 systemd[1]: Listening on Docker Socket for the API. Oct 30 05:24:49.654616 systemd[1]: Reached target Socket Units. Oct 30 05:24:49.655384 systemd[1]: Reached target Basic System. Oct 30 05:24:49.656195 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 30 05:24:49.656226 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 30 05:24:49.657151 systemd[1]: Started D-Bus System Message Bus. Oct 30 05:24:49.660193 systemd[1]: Starting Extend Filesystems... Oct 30 05:24:49.661023 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 30 05:24:49.661911 systemd[1]: Starting Generate /run/flatcar/motd... Oct 30 05:24:49.663579 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 30 05:24:49.665613 systemd[1]: Starting Generate sshd host keys... Oct 30 05:24:49.666870 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 30 05:24:49.666899 systemd[1]: Reached target Load system-provided cloud configs. Oct 30 05:24:49.669946 extend-filesystems[899]: Found vda Oct 30 05:24:49.674916 extend-filesystems[899]: Found vda1 Oct 30 05:24:49.674916 extend-filesystems[899]: Found vda2 Oct 30 05:24:49.674916 extend-filesystems[899]: Found vda3 Oct 30 05:24:49.674916 extend-filesystems[899]: Found usr Oct 30 05:24:49.674916 extend-filesystems[899]: Found vda4 Oct 30 05:24:49.674916 extend-filesystems[899]: Found vda6 Oct 30 05:24:49.674916 extend-filesystems[899]: Found vda7 Oct 30 05:24:49.674916 extend-filesystems[899]: Found vda9 Oct 30 05:24:49.674916 extend-filesystems[899]: Checking size of /dev/vda9 Oct 30 05:24:49.675571 systemd[1]: Starting User Login Management... Oct 30 05:24:49.693728 extend-filesystems[899]: Old size kept for /dev/vda9 Oct 30 05:24:49.677147 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 30 05:24:49.677702 systemd[1]: Starting Update Engine... Oct 30 05:24:49.678922 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 30 05:24:49.678945 systemd[1]: Reached target Load user-provided cloud configs. Oct 30 05:24:49.681123 systemd[1]: motdgen.service: Deactivated successfully. Oct 30 05:24:49.681367 systemd[1]: Finished Generate /run/flatcar/motd. Oct 30 05:24:49.682550 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 30 05:24:49.682785 systemd[1]: Finished Extend Filesystems. Oct 30 05:24:49.687998 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 30 05:24:49.688300 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 30 05:24:49.706999 systemd-logind[916]: Watching system buttons on /dev/input/event0 (Power Button) Oct 30 05:24:49.707481 systemd-logind[916]: New seat seat0. Oct 30 05:24:49.710290 systemd[1]: Started User Login Management. Oct 30 05:24:49.712677 update_engine[917]: I1030 05:24:49.712399 917 main.cc:89] Flatcar Update Engine starting Oct 30 05:24:49.714642 systemd[1]: Started Update Engine. Oct 30 05:24:49.715472 update_engine[917]: I1030 05:24:49.715440 917 update_check_scheduler.cc:74] Next update check in 11m50s Oct 30 05:24:49.730773 systemd[1]: Started Cluster reboot manager. Oct 30 05:24:49.755427 locksmithd[922]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 30 05:24:50.232746 sshd_keygen[915]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Oct 30 05:24:50.249577 systemd[1]: Finished Generate sshd host keys. Oct 30 05:24:50.264611 systemd[1]: Starting Generate /run/issue... Oct 30 05:24:50.269568 systemd[1]: issuegen.service: Deactivated successfully. Oct 30 05:24:50.269779 systemd[1]: Finished Generate /run/issue. Oct 30 05:24:50.271699 systemd[1]: Starting Permit User Sessions... Oct 30 05:24:50.275841 systemd[1]: Finished Permit User Sessions. Oct 30 05:24:50.277650 systemd[1]: Started Getty on tty1. Oct 30 05:24:50.279264 systemd[1]: Started Serial Getty on ttyAMA0. Oct 30 05:24:50.280190 systemd[1]: Reached target Login Prompts. Oct 30 05:24:50.281072 systemd[1]: Reached target Multi-User System. Oct 30 05:24:50.282793 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 30 05:24:50.287192 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 30 05:24:50.287387 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 30 05:24:50.288375 systemd[1]: Startup finished in 684ms (kernel) + 2.266s (initrd) + 3.462s (userspace) = 6.413s. Oct 30 05:24:50.562099 systemd-networkd[833]: eth0: Gained IPv6LL Oct 30 05:24:56.272515 systemd[1]: Created slice Slice /system/sshd. Oct 30 05:24:56.274150 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37390). Oct 30 05:24:56.313946 sshd[944]: Accepted publickey for core from 10.0.0.1 port 37390 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:24:56.315735 sshd[944]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:24:56.329012 systemd[1]: Created slice User Slice of UID 500. Oct 30 05:24:56.330096 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 30 05:24:56.331477 systemd-logind[916]: New session 1 of user core. Oct 30 05:24:56.335570 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 30 05:24:56.336732 systemd[1]: Starting User Manager for UID 500... Oct 30 05:24:56.338779 systemd[947]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:24:56.383052 systemd[947]: Queued start job for default target Main User Target. Oct 30 05:24:56.383180 systemd[947]: Reached target Paths. Oct 30 05:24:56.383193 systemd[947]: Reached target Sockets. Oct 30 05:24:56.383203 systemd[947]: Reached target Timers. Oct 30 05:24:56.383214 systemd[947]: Reached target Basic System. Oct 30 05:24:56.383249 systemd[947]: Reached target Main User Target. Oct 30 05:24:56.383260 systemd[947]: Startup finished in 41ms. Oct 30 05:24:56.383701 systemd[1]: Started User Manager for UID 500. Oct 30 05:24:56.395715 systemd[1]: Started Session 1 of User core. Oct 30 05:24:56.457996 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37400). Oct 30 05:24:56.491603 sshd[956]: Accepted publickey for core from 10.0.0.1 port 37400 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:24:56.492880 sshd[956]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:24:56.495362 systemd-logind[916]: New session 2 of user core. Oct 30 05:24:56.504799 systemd[1]: Started Session 2 of User core. Oct 30 05:24:56.556839 sshd[956]: pam_unix(sshd:session): session closed for user core Oct 30 05:24:56.566833 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37410). Oct 30 05:24:56.567245 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:37400.service: Deactivated successfully. Oct 30 05:24:56.567811 systemd[1]: session-2.scope: Deactivated successfully. Oct 30 05:24:56.568412 systemd-logind[916]: Session 2 logged out. Waiting for processes to exit. Oct 30 05:24:56.569188 systemd-logind[916]: Removed session 2. Oct 30 05:24:56.605070 sshd[961]: Accepted publickey for core from 10.0.0.1 port 37410 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:24:56.606175 sshd[961]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:24:56.608930 systemd-logind[916]: New session 3 of user core. Oct 30 05:24:56.617744 systemd[1]: Started Session 3 of User core. Oct 30 05:24:56.666538 sshd[961]: pam_unix(sshd:session): session closed for user core Oct 30 05:24:56.678167 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:37410.service: Deactivated successfully. Oct 30 05:24:56.678848 systemd[1]: session-3.scope: Deactivated successfully. Oct 30 05:24:56.680576 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37424). Oct 30 05:24:56.680833 systemd-logind[916]: Session 3 logged out. Waiting for processes to exit. Oct 30 05:24:56.681552 systemd-logind[916]: Removed session 3. Oct 30 05:24:56.714919 sshd[968]: Accepted publickey for core from 10.0.0.1 port 37424 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:24:56.716098 sshd[968]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:24:56.718484 systemd-logind[916]: New session 4 of user core. Oct 30 05:24:56.726906 systemd[1]: Started Session 4 of User core. Oct 30 05:24:56.781416 sshd[968]: pam_unix(sshd:session): session closed for user core Oct 30 05:24:56.796280 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:37424.service: Deactivated successfully. Oct 30 05:24:56.796896 systemd[1]: session-4.scope: Deactivated successfully. Oct 30 05:24:56.797459 systemd-logind[916]: Session 4 logged out. Waiting for processes to exit. Oct 30 05:24:56.798470 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37428). Oct 30 05:24:56.799154 systemd-logind[916]: Removed session 4. Oct 30 05:24:56.831486 sshd[975]: Accepted publickey for core from 10.0.0.1 port 37428 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:24:56.832858 sshd[975]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:24:56.835291 systemd-logind[916]: New session 5 of user core. Oct 30 05:24:56.847816 systemd[1]: Started Session 5 of User core. Oct 30 05:24:56.901530 sudo[978]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 30 05:24:56.901948 sudo[978]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:24:56.918141 sudo[978]: pam_unix(sudo:session): session closed for user root Oct 30 05:24:56.920820 sshd[975]: pam_unix(sshd:session): session closed for user core Oct 30 05:24:56.942337 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37432). Oct 30 05:24:56.943592 dbus-daemon[898]: [system] Reloaded configuration Oct 30 05:24:56.945968 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:37428.service: Deactivated successfully. Oct 30 05:24:56.946579 systemd[1]: session-5.scope: Deactivated successfully. Oct 30 05:24:56.947166 systemd-logind[916]: Session 5 logged out. Waiting for processes to exit. Oct 30 05:24:56.947748 systemd-logind[916]: Removed session 5. Oct 30 05:24:56.975490 sshd[981]: Accepted publickey for core from 10.0.0.1 port 37432 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:24:56.976366 sshd[981]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:24:56.978535 systemd-logind[916]: New session 6 of user core. Oct 30 05:24:56.990736 systemd[1]: Started Session 6 of User core. Oct 30 05:24:57.040325 sudo[986]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 30 05:24:57.040757 sudo[986]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:24:57.043123 sudo[986]: pam_unix(sudo:session): session closed for user root Oct 30 05:24:57.046482 sudo[985]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 30 05:24:57.046701 sudo[985]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:24:57.075035 systemd[1]: Stopping Load Security Auditing Rules... Oct 30 05:24:57.074000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 30 05:24:57.076386 auditctl[989]: No rules Oct 30 05:24:57.076682 systemd[1]: audit-rules.service: Deactivated successfully. Oct 30 05:24:57.076936 systemd[1]: Stopped Load Security Auditing Rules. Oct 30 05:24:57.077061 kernel: kauditd_printk_skb: 5 callbacks suppressed Oct 30 05:24:57.077106 kernel: audit: type=1305 audit(1761801897.074:62): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 30 05:24:57.078284 systemd[1]: Starting Load Security Auditing Rules... Oct 30 05:24:57.091756 augenrules[1006]: No rules Oct 30 05:24:57.092848 systemd[1]: Finished Load Security Auditing Rules. Oct 30 05:24:57.093767 sudo[985]: pam_unix(sudo:session): session closed for user root Oct 30 05:24:57.094815 sshd[981]: pam_unix(sshd:session): session closed for user core Oct 30 05:24:57.105684 systemd-logind[916]: Session 6 logged out. Waiting for processes to exit. Oct 30 05:24:57.105771 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:37432.service: Deactivated successfully. Oct 30 05:24:57.106254 systemd[1]: session-6.scope: Deactivated successfully. Oct 30 05:24:57.107524 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37444). Oct 30 05:24:57.107979 systemd-logind[916]: Removed session 6. Oct 30 05:24:57.139841 sshd[1012]: Accepted publickey for core from 10.0.0.1 port 37444 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:24:57.140879 sshd[1012]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:24:57.142643 kernel: audit: type=1006 audit(1761801897.138:63): pid=1012 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Oct 30 05:24:57.143375 systemd-logind[916]: New session 7 of user core. Oct 30 05:24:57.154783 systemd[1]: Started Session 7 of User core. Oct 30 05:24:57.206910 sudo[1015]: 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 < Oct 30 05:25:00.055121 update_engine[1263]: Oct 30 05:25:00.055121 update_engine[1263]: Oct 30 05:25:00.055121 update_engine[1263]: Oct 30 05:25:00.055121 update_engine[1263]: Oct 30 05:25:00.055121 update_engine[1263]: Oct 30 05:25:00.055121 update_engine[1263]: Oct 30 05:25:00.055121 update_engine[1263]: Oct 30 05:25:00.055121 update_engine[1263]: Oct 30 05:25:00.055121 update_engine[1263]: I1030 05:25:00.055049 1263 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 30 05:25:00.057784 systemd-logind[916]: New session 25 of user core. Oct 30 05:25:00.059038 update_engine[1263]: I1030 05:25:00.058779 1263 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 30 05:25:00.059038 update_engine[1263]: I1030 05:25:00.059000 1263 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 30 05:25:00.060253 update_engine[1263]: I1030 05:25:00.060040 1263 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 30 05:25:00.060253 update_engine[1263]: I1030 05:25:00.060118 1263 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Oct 30 05:25:00.060253 update_engine[1263]: I1030 05:25:00.060127 1263 omaha_request_action.cc:619] Omaha request response: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.060253 update_engine[1263]: Oct 30 05:25:00.062296 update_engine[1263]: I1030 05:25:00.062273 1263 omaha_request_action.cc:447] Omaha Response manifest version = Oct 30 05:25:00.062392 update_engine[1263]: I1030 05:25:00.062381 1263 omaha_request_action.cc:470] Found 1 url(s) Oct 30 05:25:00.062448 update_engine[1263]: I1030 05:25:00.062438 1263 omaha_request_action.cc:506] Processing first of 1 package(s) Oct 30 05:25:00.062494 update_engine[1263]: I1030 05:25:00.062485 1263 omaha_request_action.cc:513] Omaha Response package name = update.gz Oct 30 05:25:00.062543 update_engine[1263]: I1030 05:25:00.062531 1263 omaha_request_action.cc:529] Url0: http://10.0.0.5:34567/packages/update.gz Oct 30 05:25:00.062599 update_engine[1263]: I1030 05:25:00.062588 1263 omaha_request_action.cc:541] Payload size = 439617737 bytes Oct 30 05:25:00.062773 systemd[1]: Started Session 25 of User core. Oct 30 05:25:00.063707 update_engine[1263]: I1030 05:25:00.063678 1263 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Oct 30 05:25:00.063739 update_engine[1263]: I1030 05:25:00.063714 1263 payload_state.cc:51] Resetting all persisted state as this is a new response Oct 30 05:25:00.063739 update_engine[1263]: I1030 05:25:00.063720 1263 payload_state.cc:360] Current Response Signature = Oct 30 05:25:00.063739 update_engine[1263]: NumURLs = 1 Oct 30 05:25:00.063739 update_engine[1263]: Url0 = http://10.0.0.5:34567/packages/update.gz Oct 30 05:25:00.063739 update_engine[1263]: Payload Size = 439617737 Oct 30 05:25:00.063739 update_engine[1263]: Payload Sha256 Hash = hKuDazTd3yRvZZ+1GzVZ5iDGEt/oXMhd+zKPhlhnEaA= Oct 30 05:25:00.063739 update_engine[1263]: Is Delta Payload = 0 Oct 30 05:25:00.063739 update_engine[1263]: Max Failure Count Per Url = 10 Oct 30 05:25:00.063739 update_engine[1263]: Disable Payload Backoff = 1 Oct 30 05:25:00.063888 update_engine[1263]: I1030 05:25:00.063810 1263 payload_state.cc:381] Payload Attempt Number = 0 Oct 30 05:25:00.063888 update_engine[1263]: I1030 05:25:00.063848 1263 payload_state.cc:404] Current URL Index = 0 Oct 30 05:25:00.063888 update_engine[1263]: I1030 05:25:00.063876 1263 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Oct 30 05:25:00.063943 update_engine[1263]: I1030 05:25:00.063911 1263 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Oct 30 05:25:00.063943 update_engine[1263]: I1030 05:25:00.063916 1263 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 30 05:25:00.063979 update_engine[1263]: I1030 05:25:00.063947 1263 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Oct 30 05:25:00.063979 update_engine[1263]: I1030 05:25:00.063967 1263 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Oct 30 05:25:00.063979 update_engine[1263]: I1030 05:25:00.063970 1263 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Oct 30 05:25:00.064028 update_engine[1263]: I1030 05:25:00.063984 1263 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Oct 30 05:25:00.064028 update_engine[1263]: E1030 05:25:00.063989 1263 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Oct 30 05:25:00.064449 update_engine[1263]: I1030 05:25:00.064409 1263 omaha_response_handler_action.cc:85] Using this install plan: Oct 30 05:25:00.064449 update_engine[1263]: I1030 05:25:00.064424 1263 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.5:34567/packages/update.gz, payload size: 439617737, payload hash: hKuDazTd3yRvZZ+1GzVZ5iDGEt/oXMhd+zKPhlhnEaA=, 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 Oct 30 05:25:00.064513 update_engine[1263]: I1030 05:25:00.064500 1263 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Oct 30 05:25:00.065500 update_engine[1263]: I1030 05:25:00.065482 1263 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Oct 30 05:25:00.118077 sshd[1276]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:00.120835 systemd[1]: session-25.scope: Deactivated successfully. Oct 30 05:25:00.121410 systemd[1]: sshd@24-10.0.0.6:22-10.0.0.1:34784.service: Deactivated successfully. Oct 30 05:25:00.122525 systemd-logind[916]: Session 25 logged out. Waiting for processes to exit. Oct 30 05:25:00.123191 systemd-logind[916]: Removed session 25. Oct 30 05:25:01.721345 update_engine[1263]: I1030 05:25:01.721282 1263 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Oct 30 05:25:01.721345 update_engine[1263]: I1030 05:25:01.721324 1263 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Oct 30 05:25:01.796212 update_engine[1263]: E1030 05:25:01.796170 1263 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Oct 30 05:25:01.796397 update_engine[1263]: I1030 05:25:01.796386 1263 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Oct 30 05:25:01.796444 update_engine[1263]: I1030 05:25:01.796434 1263 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Oct 30 05:25:01.796493 update_engine[1263]: I1030 05:25:01.796483 1263 update_attempter.cc:302] Processing Done. Oct 30 05:25:01.796583 update_engine[1263]: E1030 05:25:01.796571 1263 update_attempter.cc:615] Update failed. Oct 30 05:25:01.796668 update_engine[1263]: I1030 05:25:01.796654 1263 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Oct 30 05:25:01.796727 update_engine[1263]: I1030 05:25:01.796717 1263 payload_state.cc:276] Incrementing the URL failure count Oct 30 05:25:01.796777 update_engine[1263]: I1030 05:25:01.796766 1263 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 30 05:25:01.797022 update_engine[1263]: I1030 05:25:01.797003 1263 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 30 05:25:01.797113 update_engine[1263]: I1030 05:25:01.797101 1263 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.5:34567/v1/update Oct 30 05:25:01.797161 update_engine[1263]: I1030 05:25:01.797151 1263 omaha_request_action.cc:269] Request: Oct 30 05:25:01.797161 update_engine[1263]: Oct 30 05:25:01.797161 update_engine[1263]: Oct 30 05:25:01.797161 update_engine[1263]: Oct 30 05:25:01.797161 update_engine[1263]: Oct 30 05:25:01.797161 update_engine[1263]: Oct 30 05:25:01.797161 update_engine[1263]: Oct 30 05:25:01.797304 update_engine[1263]: I1030 05:25:01.797293 1263 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 30 05:25:01.797403 update_engine[1263]: I1030 05:25:01.797392 1263 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 30 05:25:01.797572 update_engine[1263]: I1030 05:25:01.797557 1263 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 30 05:25:01.928716 update_engine[1263]: I1030 05:25:01.928681 1263 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 30 05:25:01.928914 update_engine[1263]: I1030 05:25:01.928898 1263 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Oct 30 05:25:01.928985 update_engine[1263]: I1030 05:25:01.928973 1263 omaha_request_action.cc:619] Omaha request response: Oct 30 05:25:01.928985 update_engine[1263]: Oct 30 05:25:01.928985 update_engine[1263]: Oct 30 05:25:01.928985 update_engine[1263]: Oct 30 05:25:01.928985 update_engine[1263]: Oct 30 05:25:01.928985 update_engine[1263]: Oct 30 05:25:01.928985 update_engine[1263]: Oct 30 05:25:01.929135 update_engine[1263]: E1030 05:25:01.929124 1263 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Oct 30 05:25:01.929181 update_engine[1263]: I1030 05:25:01.929172 1263 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 30 05:25:01.929229 update_engine[1263]: I1030 05:25:01.929219 1263 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 30 05:25:01.929278 update_engine[1263]: I1030 05:25:01.929267 1263 update_attempter.cc:302] Processing Done. Oct 30 05:25:01.929329 update_engine[1263]: I1030 05:25:01.929319 1263 update_attempter.cc:306] Error event sent. Oct 30 05:25:10.068456 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52304). Oct 30 05:25:10.103233 sshd[1298]: Accepted publickey for core from 10.0.0.1 port 52304 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:10.104578 sshd[1298]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:10.104799 kernel: kauditd_printk_skb: 287 callbacks suppressed Oct 30 05:25:10.104834 kernel: audit: type=1006 audit(1761801910.103:359): pid=1298 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=26 res=1 Oct 30 05:25:10.107335 systemd-logind[916]: New session 26 of user core. Oct 30 05:25:10.121793 systemd[1]: Started Session 26 of User core. Oct 30 05:25:10.180297 sshd[1298]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:10.187604 systemd[1]: sshd@25-10.0.0.6:22-10.0.0.1:52304.service: Deactivated successfully. Oct 30 05:25:10.188153 systemd[1]: session-26.scope: Deactivated successfully. Oct 30 05:25:10.188751 systemd-logind[916]: Session 26 logged out. Waiting for processes to exit. Oct 30 05:25:10.189689 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52320). Oct 30 05:25:10.190815 systemd-logind[916]: Removed session 26. Oct 30 05:25:10.221544 sshd[1305]: Accepted publickey for core from 10.0.0.1 port 52320 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:10.222902 sshd[1305]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:10.224684 kernel: audit: type=1006 audit(1761801910.221:360): pid=1305 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=27 res=1 Oct 30 05:25:10.225809 systemd-logind[916]: New session 27 of user core. Oct 30 05:25:10.240968 systemd[1]: Started Session 27 of User core. Oct 30 05:25:10.296824 sshd[1305]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:10.307029 systemd[1]: sshd@26-10.0.0.6:22-10.0.0.1:52320.service: Deactivated successfully. Oct 30 05:25:10.307609 systemd[1]: session-27.scope: Deactivated successfully. Oct 30 05:25:10.308219 systemd-logind[916]: Session 27 logged out. Waiting for processes to exit. Oct 30 05:25:10.309147 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52326). Oct 30 05:25:10.309822 systemd-logind[916]: Removed session 27. Oct 30 05:25:10.341565 sshd[1313]: Accepted publickey for core from 10.0.0.1 port 52326 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:10.342230 sshd[1313]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:10.344557 systemd-logind[916]: New session 28 of user core. Oct 30 05:25:10.344644 kernel: audit: type=1006 audit(1761801910.340:361): pid=1313 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=28 res=1 Oct 30 05:25:10.365178 systemd[1]: Started Session 28 of User core. Oct 30 05:25:10.416209 sshd[1313]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:10.428138 systemd[1]: sshd@27-10.0.0.6:22-10.0.0.1:52326.service: Deactivated successfully. Oct 30 05:25:10.428841 systemd[1]: session-28.scope: Deactivated successfully. Oct 30 05:25:10.429512 systemd-logind[916]: Session 28 logged out. Waiting for processes to exit. Oct 30 05:25:10.430713 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52340). Oct 30 05:25:10.431374 systemd-logind[916]: Removed session 28. Oct 30 05:25:10.465232 sshd[1319]: Accepted publickey for core from 10.0.0.1 port 52340 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:10.466150 sshd[1319]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:10.468644 kernel: audit: type=1006 audit(1761801910.465:362): pid=1319 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=29 res=1 Oct 30 05:25:10.470958 systemd-logind[916]: New session 29 of user core. Oct 30 05:25:10.485827 systemd[1]: Started Session 29 of User core. Oct 30 05:25:10.536857 sshd[1319]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:10.551253 systemd[1]: sshd@28-10.0.0.6:22-10.0.0.1:52340.service: Deactivated successfully. Oct 30 05:25:10.551773 systemd[1]: session-29.scope: Deactivated successfully. Oct 30 05:25:10.552366 systemd-logind[916]: Session 29 logged out. Waiting for processes to exit. Oct 30 05:25:10.553277 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52342). Oct 30 05:25:10.553991 systemd-logind[916]: Removed session 29. Oct 30 05:25:10.587434 sshd[1325]: Accepted publickey for core from 10.0.0.1 port 52342 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:10.588504 sshd[1325]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:10.590644 kernel: audit: type=1006 audit(1761801910.587:363): pid=1325 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=30 res=1 Oct 30 05:25:10.592795 systemd-logind[916]: New session 30 of user core. Oct 30 05:25:10.618484 systemd[1]: Started Session 30 of User core. Oct 30 05:25:10.671864 sudo[1329]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Oct 30 05:25:10.672079 sudo[1329]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:25:10.677463 systemd[1]: sshd.socket: Deactivated successfully. Oct 30 05:25:10.677817 systemd[1]: Closed OpenSSH Server Socket. Oct 30 05:25:10.678734 sudo[1329]: pam_unix(sudo:session): session closed for user root Oct 30 05:25:10.682196 sudo[1328]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Oct 30 05:25:10.682389 sudo[1328]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:25:10.696173 systemd[1]: Stopping Session 1 of User core... Oct 30 05:25:10.697419 sshd[944]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:10.697518 systemd[1]: Stopping Session 30 of User core... Oct 30 05:25:10.697635 sshd[1325]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:10.698332 sudo[1328]: pam_unix(sudo:session): session closed for user root Oct 30 05:25:10.699351 systemd[1]: Removed slice Slice /system/addon-config. Oct 30 05:25:10.701384 systemd[1]: Removed slice Slice /system/addon-run. Oct 30 05:25:10.702588 systemd[1]: Removed slice Slice /system/modprobe. Oct 30 05:25:10.703835 systemd[1]: Removed slice Slice /system/system-cloudinit. Oct 30 05:25:10.704942 systemd[1]: Stopped target Multi-User System. Oct 30 05:25:10.705786 systemd[1]: Stopped target Login Prompts. Oct 30 05:25:10.706548 systemd[1]: Stopped target Containers. Oct 30 05:25:10.707526 systemd[1]: Stopped target Host and Network Name Lookups. Oct 30 05:25:10.708535 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 30 05:25:10.709521 systemd[1]: Stopped target Timer Units. Oct 30 05:25:10.710503 systemd[1]: logrotate.timer: Deactivated successfully. Oct 30 05:25:10.710552 systemd[1]: Stopped Daily Log Rotation. Oct 30 05:25:10.711353 systemd[1]: mdadm.timer: Deactivated successfully. Oct 30 05:25:10.711393 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Oct 30 05:25:10.712513 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Oct 30 05:25:10.712555 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Oct 30 05:25:10.713592 systemd[1]: Stopped target System Time Set. Oct 30 05:25:10.714468 systemd[1]: Stopped target Load user-provided cloud configs. Oct 30 05:25:10.715488 systemd[1]: Stopped target Load system-provided cloud configs. Oct 30 05:25:10.716556 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 30 05:25:10.716664 systemd[1]: Closed Process Core Dump Socket. Oct 30 05:25:10.718177 systemd[1]: Unmounting Boot partition... Oct 30 05:25:10.719154 systemd[1]: Stopping Getty on tty1... Oct 30 05:25:10.720160 systemd[1]: Stopping Serial Getty on ttyAMA0... Oct 30 05:25:10.721061 systemd[1]: Stopping OpenSSH per-connection server daemon... Oct 30 05:25:10.722107 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:52342)... Oct 30 05:25:10.723127 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Oct 30 05:25:10.723268 systemd[1]: Stopped Commit a transient machine-id on disk. Oct 30 05:25:10.724332 systemd[1]: Stopped target First Boot Complete. Oct 30 05:25:10.735440 systemd[1]: Stopping Load/Save Random Seed... Oct 30 05:25:10.736451 systemd[1]: Stopping Update Engine... Oct 30 05:25:10.739657 systemd[1]: getty@tty1.service: Deactivated successfully. Oct 30 05:25:10.739857 systemd[1]: Stopped Getty on tty1. Oct 30 05:25:10.741074 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Oct 30 05:25:10.741257 systemd[1]: Stopped Serial Getty on ttyAMA0. Oct 30 05:25:10.742524 systemd[1]: sshd@0-10.0.0.6:22-10.0.0.1:37390.service: Deactivated successfully. Oct 30 05:25:10.742730 systemd[1]: Stopped OpenSSH per-connection server daemon. Oct 30 05:25:10.744097 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 30 05:25:10.744167 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 30 05:25:10.744403 systemd[1]: Stopped Update Engine. Oct 30 05:25:10.745180 systemd[1]: update-engine.service: Consumed 2.361s CPU time. Oct 30 05:25:10.745402 systemd[1]: sshd@29-10.0.0.6:22-10.0.0.1:52342.service: Deactivated successfully. Oct 30 05:25:10.745572 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:52342). Oct 30 05:25:10.747781 systemd[1]: systemd-random-seed.service: Deactivated successfully. Oct 30 05:25:10.748000 systemd[1]: Stopped Load/Save Random Seed. Oct 30 05:25:10.749176 systemd[1]: session-30.scope: Deactivated successfully. Oct 30 05:25:10.749389 systemd[1]: Stopped Session 30 of User core. Oct 30 05:25:10.750496 systemd[1]: boot.mount: Deactivated successfully. Oct 30 05:25:10.750752 systemd[1]: Unmounted Boot partition. Oct 30 05:25:10.751670 systemd[1]: session-1.scope: Deactivated successfully. Oct 30 05:25:10.751890 systemd[1]: Stopped Session 1 of User core. Oct 30 05:25:10.753393 systemd-logind[916]: Session 1 logged out. Waiting for processes to exit. Oct 30 05:25:10.754289 systemd-logind[916]: Session 30 logged out. Waiting for processes to exit. Oct 30 05:25:10.754504 systemd[1]: Removed slice Slice /system/getty. Oct 30 05:25:10.755835 systemd[1]: Removed slice Slice /system/serial-getty. Oct 30 05:25:10.757006 systemd[1]: Removed slice Slice /system/sshd. Oct 30 05:25:10.758031 systemd[1]: sshd-keygen.service: Deactivated successfully. Oct 30 05:25:10.758131 systemd[1]: Stopped Generate sshd host keys. Oct 30 05:25:10.759178 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Oct 30 05:25:10.759292 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Oct 30 05:25:10.760604 systemd[1]: Stopping User Login Management... Oct 30 05:25:10.761391 systemd[1]: Stopping User Manager for UID 500... Oct 30 05:25:10.762368 systemd[947]: Stopped target Main User Target. Oct 30 05:25:10.762385 systemd[947]: Stopped target Basic System. Oct 30 05:25:10.762394 systemd[947]: Stopped target Paths. Oct 30 05:25:10.762401 systemd[947]: Stopped target Sockets. Oct 30 05:25:10.762416 systemd[947]: Reached target Shutdown. Oct 30 05:25:10.762422 systemd[947]: Stopped target Timers. Oct 30 05:25:10.762520 systemd[947]: Finished Exit the Session. Oct 30 05:25:10.762543 systemd[947]: Reached target Exit the Session. Oct 30 05:25:10.763507 systemd-logind[916]: Removed session 1. Oct 30 05:25:10.769005 systemd[1]: user@500.service: Deactivated successfully. Oct 30 05:25:10.769276 systemd[1]: Stopped User Manager for UID 500. Oct 30 05:25:10.771266 systemd[1]: Stopping User Runtime Directory /run/user/500... Oct 30 05:25:10.776439 systemd[1]: run-user-500.mount: Deactivated successfully. Oct 30 05:25:10.776582 systemd[1]: Unmounted /run/user/500. Oct 30 05:25:10.777813 systemd[1]: systemd-logind.service: Deactivated successfully. Oct 30 05:25:10.778174 systemd[1]: Stopped User Login Management. Oct 30 05:25:10.779366 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Oct 30 05:25:10.779698 systemd[1]: Stopped User Runtime Directory /run/user/500. Oct 30 05:25:10.781432 systemd[1]: Removed slice User Slice of UID 500. Oct 30 05:25:10.783259 systemd[1]: Stopping D-Bus System Message Bus... Oct 30 05:25:10.799000 audit: BPF prog-id=61 op=UNLOAD Oct 30 05:25:10.802822 kernel: audit: type=1334 audit(1761801910.799:364): prog-id=61 op=UNLOAD Oct 30 05:25:10.801726 systemd[1]: Stopping Permit User Sessions... Oct 30 05:25:10.803325 systemd[1]: dbus.service: Deactivated successfully. Oct 30 05:25:10.803615 systemd[1]: Stopped D-Bus System Message Bus. Oct 30 05:25:10.806691 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Oct 30 05:25:10.806920 systemd[1]: Stopped Permit User Sessions. Oct 30 05:25:10.807744 systemd[1]: Stopped target Basic System. Oct 30 05:25:10.808465 systemd[1]: Stopped target Network. Oct 30 05:25:10.809178 systemd[1]: Stopped target Path Units. Oct 30 05:25:10.810008 systemd[1]: motdgen.path: Deactivated successfully. Oct 30 05:25:10.814760 systemd[1]: Stopped Watch for update engine configuration changes. Oct 30 05:25:10.815760 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Oct 30 05:25:10.820872 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 30 05:25:10.822076 systemd[1]: Stopped target Remote File Systems. Oct 30 05:25:10.822875 systemd[1]: Stopped target Slice Units. Oct 30 05:25:10.823863 systemd[1]: Removed slice User and Session Slice. Oct 30 05:25:10.824670 systemd[1]: Stopped target Socket Units. Oct 30 05:25:10.825424 systemd[1]: dbus.socket: Deactivated successfully. Oct 30 05:25:10.825481 systemd[1]: Closed D-Bus System Message Bus Socket. Oct 30 05:25:10.826510 systemd[1]: docker.socket: Deactivated successfully. Oct 30 05:25:10.826764 systemd[1]: Closed Docker Socket for the API. Oct 30 05:25:10.827550 systemd[1]: Stopped target System Initialization. Oct 30 05:25:10.828441 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Oct 30 05:25:10.828578 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Oct 30 05:25:10.829713 systemd[1]: Stopped target Local Verity Protected Volumes. Oct 30 05:25:10.831346 systemd[1]: Stopping Load Security Auditing Rules... Oct 30 05:25:10.832456 systemd[1]: Stopping Network Name Resolution... Oct 30 05:25:10.833426 systemd[1]: Stopping Network Time Synchronization... Oct 30 05:25:10.834270 systemd[1]: systemd-update-done.service: Deactivated successfully. Oct 30 05:25:10.834338 systemd[1]: Stopped Update is Completed. Oct 30 05:25:10.834506 auditctl[1343]: No rules Oct 30 05:25:10.835211 systemd[1]: ldconfig.service: Deactivated successfully. Oct 30 05:25:10.835272 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Oct 30 05:25:10.836147 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Oct 30 05:25:10.836207 systemd[1]: Stopped Rebuild Hardware Database. Oct 30 05:25:10.837020 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Oct 30 05:25:10.837082 systemd[1]: Stopped Rebuild Journal Catalog. Oct 30 05:25:10.838647 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Oct 30 05:25:10.841061 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 30 05:25:10.841311 systemd[1]: Stopped Network Name Resolution. Oct 30 05:25:10.842449 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Oct 30 05:25:10.842722 systemd[1]: Stopped Network Time Synchronization. Oct 30 05:25:10.843907 systemd[1]: audit-rules.service: Deactivated successfully. Oct 30 05:25:10.844103 systemd[1]: Stopped Load Security Auditing Rules. Oct 30 05:25:10.846359 systemd[1]: Stopping Network Configuration... Oct 30 05:25:10.851665 systemd-networkd[833]: eth0: DHCPv6 lease lost Oct 30 05:25:10.863000 audit: BPF prog-id=64 op=UNLOAD Oct 30 05:25:10.863000 audit: BPF prog-id=56 op=UNLOAD Oct 30 05:25:10.863998 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 30 05:25:10.864342 systemd[1]: Stopped Network Configuration. Oct 30 05:25:10.865664 kernel: audit: type=1334 audit(1761801910.863:365): prog-id=64 op=UNLOAD Oct 30 05:25:10.865705 kernel: audit: type=1334 audit(1761801910.863:366): prog-id=56 op=UNLOAD Oct 30 05:25:10.867153 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Oct 30 05:25:10.867371 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Oct 30 05:25:10.869039 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 30 05:25:10.869123 systemd[1]: Closed Network Service Netlink Socket. Oct 30 05:25:10.870020 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 30 05:25:10.870076 systemd[1]: Stopped Apply Kernel Variables. Oct 30 05:25:10.870857 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 30 05:25:10.870911 systemd[1]: Stopped Create Volatile Files and Directories. Oct 30 05:25:10.871814 systemd[1]: Stopped target Local File Systems. Oct 30 05:25:10.873353 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Oct 30 05:25:10.874849 systemd[1]: Unmounting External Media Directory... Oct 30 05:25:10.876544 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Oct 30 05:25:10.875000 audit: BPF prog-id=60 op=UNLOAD Oct 30 05:25:10.877648 kernel: audit: type=1334 audit(1761801910.875:367): prog-id=60 op=UNLOAD Oct 30 05:25:10.879249 systemd[1]: Unmounting /run/torcx/unpack... Oct 30 05:25:10.880505 systemd[1]: Unmounting Temporary Directory /tmp... Oct 30 05:25:10.881834 systemd[1]: Unmounting /usr/share/oem... Oct 30 05:25:10.883348 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Oct 30 05:25:10.885971 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 30 05:25:10.886191 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Oct 30 05:25:10.887440 systemd[1]: media.mount: Deactivated successfully. Oct 30 05:25:10.887733 systemd[1]: Unmounted External Media Directory. Oct 30 05:25:10.888676 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Oct 30 05:25:10.888907 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Oct 30 05:25:10.890130 systemd[1]: tmp.mount: Deactivated successfully. Oct 30 05:25:10.890379 systemd[1]: Unmounted Temporary Directory /tmp. Oct 30 05:25:10.891357 systemd[1]: usr-share-oem.mount: Deactivated successfully. Oct 30 05:25:10.891615 systemd[1]: Unmounted /usr/share/oem. Oct 30 05:25:10.892485 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 30 05:25:10.892760 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Oct 30 05:25:10.894073 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Oct 30 05:25:10.894143 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Oct 30 05:25:10.895413 systemd[1]: Removed slice Slice /system/systemd-fsck. Oct 30 05:25:10.907921 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Oct 30 05:25:10.908252 systemd[1]: Unmounted /run/torcx/unpack. Oct 30 05:25:10.909446 systemd[1]: Stopped target Preparation for Local File Systems. Oct 30 05:25:10.910535 systemd[1]: Stopped target Swaps. Oct 30 05:25:10.911233 systemd[1]: Reached target Unmount All Filesystems. Oct 30 05:25:10.912086 systemd[1]: lvm2-activation.service: Deactivated successfully. Oct 30 05:25:10.912155 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 30 05:25:10.913062 systemd[1]: Stopped target Local Encrypted Volumes. Oct 30 05:25:10.913895 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 30 05:25:10.915687 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 30 05:25:10.916746 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Oct 30 05:25:10.920680 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Oct 30 05:25:10.921724 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Oct 30 05:25:10.921794 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 30 05:25:10.922725 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 30 05:25:10.922786 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 30 05:25:10.923679 systemd[1]: systemd-sysusers.service: Deactivated successfully. Oct 30 05:25:10.923737 systemd[1]: Stopped Create System Users. Oct 30 05:25:10.924479 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Oct 30 05:25:10.924532 systemd[1]: Stopped Remount Root and Kernel File Systems. Oct 30 05:25:10.925515 systemd[1]: Reached target System Shutdown. Oct 30 05:25:10.926318 systemd[1]: Reached target Late Shutdown Services. Oct 30 05:25:10.927236 systemd[1]: systemd-reboot.service: Deactivated successfully. Oct 30 05:25:10.927275 systemd[1]: Finished System Reboot. Oct 30 05:25:10.927980 systemd[1]: Reached target System Reboot. Oct 30 05:25:10.928697 systemd[1]: Shutting down. Oct 30 05:25:10.928000 audit: BPF prog-id=55 op=UNLOAD Oct 30 05:25:10.928000 audit: BPF prog-id=54 op=UNLOAD Oct 30 05:25:10.928000 audit: BPF prog-id=53 op=UNLOAD Oct 30 05:25:10.930642 kernel: audit: type=1334 audit(1761801910.928:368): prog-id=55 op=UNLOAD Oct 30 05:25:10.932000 audit: BPF prog-id=59 op=UNLOAD Oct 30 05:25:10.932000 audit: BPF prog-id=58 op=UNLOAD Oct 30 05:25:10.932000 audit: BPF prog-id=57 op=UNLOAD Oct 30 05:25:10.933000 audit: BPF prog-id=63 op=UNLOAD Oct 30 05:25:10.933000 audit: BPF prog-id=62 op=UNLOAD Oct 30 05:25:10.978657 systemd-shutdown[1]: Syncing filesystems and block devices. Oct 30 05:25:10.985711 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Oct 30 05:25:10.985790 systemd-journald[798]: Journal stopped -- Reboot -- Oct 30 05:25:18.675023 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 30 05:25:18.675039 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 Oct 30 05:25:18.675048 kernel: efi: EFI v2.70 by EDK II Oct 30 05:25:18.675053 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 30 05:25:18.675058 kernel: efi: seeding entropy pool Oct 30 05:25:18.675084 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 30 05:25:18.675092 kernel: ACPI: Early table checksum verification disabled Oct 30 05:25:18.675097 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 30 05:25:18.675102 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 30 05:25:18.675107 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:25:18.675114 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:25:18.675119 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:25:18.675124 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:25:18.675129 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:25:18.675135 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:25:18.675141 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:25:18.675147 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:25:18.675152 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:25:18.675158 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 30 05:25:18.675163 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 30 05:25:18.675169 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:25:18.675174 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 30 05:25:18.675179 kernel: Zone ranges: Oct 30 05:25:18.675184 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:25:18.675190 kernel: DMA32 empty Oct 30 05:25:18.675195 kernel: Normal empty Oct 30 05:25:18.675200 kernel: Movable zone start for each node Oct 30 05:25:18.675206 kernel: Early memory node ranges Oct 30 05:25:18.675211 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 30 05:25:18.675216 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 30 05:25:18.675222 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 30 05:25:18.675227 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 30 05:25:18.675232 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 30 05:25:18.675237 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 30 05:25:18.675242 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 30 05:25:18.675247 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 30 05:25:18.675253 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 30 05:25:18.675258 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 30 05:25:18.675263 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 30 05:25:18.675269 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:25:18.675276 kernel: On node 0 totalpages: 643072 Oct 30 05:25:18.675282 kernel: DMA zone: 10048 pages used for memmap Oct 30 05:25:18.675288 kernel: DMA zone: 0 pages reserved Oct 30 05:25:18.675293 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 30 05:25:18.675299 kernel: psci: probing for conduit method from ACPI. Oct 30 05:25:18.675304 kernel: psci: PSCIv1.1 detected in firmware. Oct 30 05:25:18.675310 kernel: psci: Using standard PSCI v0.2 function IDs Oct 30 05:25:18.675322 kernel: psci: Trusted OS migration not required Oct 30 05:25:18.675329 kernel: psci: SMC Calling Convention v1.1 Oct 30 05:25:18.675335 kernel: ACPI: SRAT not present Oct 30 05:25:18.675341 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 30 05:25:18.675346 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 30 05:25:18.675352 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 30 05:25:18.675357 kernel: Detected PIPT I-cache on CPU0 Oct 30 05:25:18.675363 kernel: CPU features: detected: GIC system register CPU interface Oct 30 05:25:18.675369 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 30 05:25:18.675374 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 30 05:25:18.675380 kernel: CPU features: detected: Hardware dirty bit management Oct 30 05:25:18.675385 kernel: CPU features: detected: Spectre-v4 Oct 30 05:25:18.675392 kernel: CPU features: detected: ARM erratum 1418040 Oct 30 05:25:18.675397 kernel: CPU features: detected: Spectre-BHB Oct 30 05:25:18.675403 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 30 05:25:18.675408 kernel: Policy zone: DMA Oct 30 05:25:18.675415 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 Oct 30 05:25:18.675421 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 30 05:25:18.675426 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 30 05:25:18.675432 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 30 05:25:18.675438 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 30 05:25:18.675444 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 30 05:25:18.675449 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 30 05:25:18.675456 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 30 05:25:18.675462 kernel: rcu: RCU event tracing is enabled. Oct 30 05:25:18.675468 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 30 05:25:18.675473 kernel: Trampoline variant of Tasks RCU enabled. Oct 30 05:25:18.675479 kernel: Tracing variant of Tasks RCU enabled. Oct 30 05:25:18.675485 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 30 05:25:18.675490 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 30 05:25:18.675496 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 30 05:25:18.675501 kernel: GICv3: 256 SPIs implemented Oct 30 05:25:18.675507 kernel: GICv3: 0 Extended SPIs implemented Oct 30 05:25:18.675512 kernel: GICv3: Distributor has no Range Selector support Oct 30 05:25:18.675518 kernel: GICv3: 16 PPIs implemented Oct 30 05:25:18.675525 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 30 05:25:18.675530 kernel: ACPI: SRAT not present Oct 30 05:25:18.675536 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 30 05:25:18.675541 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 30 05:25:18.675547 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 30 05:25:18.675553 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 30 05:25:18.675559 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 30 05:25:18.675564 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:25:18.675570 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 30 05:25:18.675576 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 30 05:25:18.675582 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 30 05:25:18.675588 kernel: arm-pv: using stolen time PV Oct 30 05:25:18.675594 kernel: Console: colour dummy device 80x25 Oct 30 05:25:18.675600 kernel: ACPI: Core revision 20200925 Oct 30 05:25:18.675606 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 30 05:25:18.675612 kernel: pid_max: default: 32768 minimum: 301 Oct 30 05:25:18.675617 kernel: LSM: Security Framework initializing Oct 30 05:25:18.675623 kernel: SELinux: Initializing. Oct 30 05:25:18.675629 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 30 05:25:18.675635 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 30 05:25:18.675641 kernel: rcu: Hierarchical SRCU implementation. Oct 30 05:25:18.675647 kernel: Platform MSI: ITS@0x8080000 domain created Oct 30 05:25:18.675653 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 30 05:25:18.675659 kernel: Remapping and enabling EFI services. Oct 30 05:25:18.675665 kernel: smp: Bringing up secondary CPUs ... Oct 30 05:25:18.675670 kernel: Detected PIPT I-cache on CPU1 Oct 30 05:25:18.675676 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 30 05:25:18.675682 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 30 05:25:18.675688 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:25:18.675694 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 30 05:25:18.675699 kernel: Detected PIPT I-cache on CPU2 Oct 30 05:25:18.675706 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 30 05:25:18.675712 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 30 05:25:18.675719 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:25:18.675725 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 30 05:25:18.675730 kernel: Detected PIPT I-cache on CPU3 Oct 30 05:25:18.675740 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 30 05:25:18.675746 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 30 05:25:18.675753 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:25:18.675760 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 30 05:25:18.675766 kernel: smp: Brought up 1 node, 4 CPUs Oct 30 05:25:18.675772 kernel: SMP: Total of 4 processors activated. Oct 30 05:25:18.675778 kernel: CPU features: detected: Privileged Access Never Oct 30 05:25:18.675784 kernel: CPU features: detected: LSE atomic instructions Oct 30 05:25:18.675790 kernel: CPU features: detected: User Access Override Oct 30 05:25:18.675796 kernel: CPU features: detected: 32-bit EL0 Support Oct 30 05:25:18.675802 kernel: CPU features: detected: Common not Private translations Oct 30 05:25:18.675808 kernel: CPU features: detected: RAS Extension Support Oct 30 05:25:18.675815 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 30 05:25:18.675821 kernel: CPU features: detected: CRC32 instructions Oct 30 05:25:18.675827 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 30 05:25:18.675833 kernel: CPU: All CPU(s) started at EL1 Oct 30 05:25:18.675839 kernel: alternatives: patching kernel code Oct 30 05:25:18.675846 kernel: devtmpfs: initialized Oct 30 05:25:18.675852 kernel: KASLR enabled Oct 30 05:25:18.675858 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 30 05:25:18.675865 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 30 05:25:18.675871 kernel: pinctrl core: initialized pinctrl subsystem Oct 30 05:25:18.675877 kernel: SMBIOS 3.0.0 present. Oct 30 05:25:18.675883 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 30 05:25:18.675889 kernel: NET: Registered protocol family 16 Oct 30 05:25:18.675895 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 30 05:25:18.675901 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 30 05:25:18.675908 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 30 05:25:18.675914 kernel: audit: initializing netlink subsys (disabled) Oct 30 05:25:18.675920 kernel: audit: type=2000 audit(0.029:1): state=initialized audit_enabled=0 res=1 Oct 30 05:25:18.675926 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 30 05:25:18.675932 kernel: cpuidle: using governor menu Oct 30 05:25:18.675938 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 30 05:25:18.675944 kernel: ASID allocator initialised with 32768 entries Oct 30 05:25:18.675950 kernel: ACPI: bus type PCI registered Oct 30 05:25:18.675957 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 30 05:25:18.675964 kernel: Serial: AMBA PL011 UART driver Oct 30 05:25:18.675969 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 30 05:25:18.675976 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 30 05:25:18.675982 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 30 05:25:18.675988 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 30 05:25:18.675994 kernel: cryptd: max_cpu_qlen set to 1000 Oct 30 05:25:18.676000 kernel: ACPI: Added _OSI(Module Device) Oct 30 05:25:18.676006 kernel: ACPI: Added _OSI(Processor Device) Oct 30 05:25:18.676012 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 30 05:25:18.676019 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 30 05:25:18.676025 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 30 05:25:18.676031 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 30 05:25:18.676037 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 30 05:25:18.676043 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 30 05:25:18.676049 kernel: ACPI: Interpreter enabled Oct 30 05:25:18.676055 kernel: ACPI: Using GIC for interrupt routing Oct 30 05:25:18.676061 kernel: ACPI: MCFG table detected, 1 entries Oct 30 05:25:18.676083 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 30 05:25:18.676089 kernel: printk: console [ttyAMA0] enabled Oct 30 05:25:18.676097 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 30 05:25:18.676221 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 30 05:25:18.676280 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 30 05:25:18.676342 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 30 05:25:18.676398 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 30 05:25:18.676451 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 30 05:25:18.676459 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 30 05:25:18.676468 kernel: PCI host bridge to bus 0000:00 Oct 30 05:25:18.676526 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 30 05:25:18.676575 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 30 05:25:18.676623 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 30 05:25:18.676670 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 30 05:25:18.676736 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 30 05:25:18.676798 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 30 05:25:18.676857 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 30 05:25:18.676912 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 30 05:25:18.676966 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 30 05:25:18.677020 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 30 05:25:18.677090 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 30 05:25:18.677147 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 30 05:25:18.677202 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 30 05:25:18.677257 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 30 05:25:18.677304 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 30 05:25:18.677318 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 30 05:25:18.677325 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 30 05:25:18.677331 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 30 05:25:18.677337 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 30 05:25:18.677343 kernel: vgaarb: loaded Oct 30 05:25:18.677349 kernel: Registered efivars operations Oct 30 05:25:18.677356 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 30 05:25:18.677363 kernel: VFS: Disk quotas dquot_6.6.0 Oct 30 05:25:18.677370 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 30 05:25:18.677376 kernel: pnp: PnP ACPI init Oct 30 05:25:18.677434 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 30 05:25:18.677484 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 30 05:25:18.677493 kernel: pnp: PnP ACPI: found 1 devices Oct 30 05:25:18.677499 kernel: NET: Registered protocol family 2 Oct 30 05:25:18.677505 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 30 05:25:18.677513 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 30 05:25:18.677519 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 30 05:25:18.677525 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 30 05:25:18.677532 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 30 05:25:18.677538 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 30 05:25:18.677544 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 30 05:25:18.677550 kernel: NET: Registered protocol family 1 Oct 30 05:25:18.677556 kernel: PCI: CLS 0 bytes, default 64 Oct 30 05:25:18.677562 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 30 05:25:18.677569 kernel: kvm [1]: HYP mode not available Oct 30 05:25:18.677575 kernel: Initialise system trusted keyrings Oct 30 05:25:18.677581 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 30 05:25:18.677587 kernel: Key type asymmetric registered Oct 30 05:25:18.677593 kernel: Asymmetric key parser 'x509' registered Oct 30 05:25:18.677599 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 30 05:25:18.677605 kernel: io scheduler mq-deadline registered Oct 30 05:25:18.677611 kernel: io scheduler kyber registered Oct 30 05:25:18.677617 kernel: io scheduler bfq registered Oct 30 05:25:18.677624 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 30 05:25:18.677631 kernel: ACPI: Power Button [PWRB] Oct 30 05:25:18.677637 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 30 05:25:18.677691 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 30 05:25:18.677700 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 30 05:25:18.677706 kernel: msm_serial: driver initialized Oct 30 05:25:18.677712 kernel: random: fast init done Oct 30 05:25:18.677718 kernel: random: crng init done Oct 30 05:25:18.677724 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 30 05:25:18.677730 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 30 05:25:18.677737 kernel: thunder_xcv, ver 1.0 Oct 30 05:25:18.677744 kernel: thunder_bgx, ver 1.0 Oct 30 05:25:18.677750 kernel: nicpf, ver 1.0 Oct 30 05:25:18.677756 kernel: nicvf, ver 1.0 Oct 30 05:25:18.677821 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 30 05:25:18.677873 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-30T05:25:18 UTC (1761801918) Oct 30 05:25:18.677881 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 30 05:25:18.677887 kernel: NET: Registered protocol family 10 Oct 30 05:25:18.677895 kernel: Segment Routing with IPv6 Oct 30 05:25:18.677901 kernel: NET: Registered protocol family 17 Oct 30 05:25:18.677907 kernel: Key type dns_resolver registered Oct 30 05:25:18.677912 kernel: registered taskstats version 1 Oct 30 05:25:18.677918 kernel: Loading compiled-in X.509 certificates Oct 30 05:25:18.677925 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 30 05:25:18.677931 kernel: Key type ._fscrypt registered Oct 30 05:25:18.677937 kernel: Key type .fscrypt registered Oct 30 05:25:18.677943 kernel: Key type fscrypt-provisioning registered Oct 30 05:25:18.677950 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 30 05:25:18.677957 kernel: ima: Allocated hash algorithm: sha1 Oct 30 05:25:18.677963 kernel: ima: No architecture policies found Oct 30 05:25:18.677969 kernel: Freeing unused kernel memory: 34240K Oct 30 05:25:18.677975 kernel: Run /init as init process Oct 30 05:25:18.677981 kernel: with arguments: Oct 30 05:25:18.677987 kernel: /init Oct 30 05:25:18.677993 kernel: with environment: Oct 30 05:25:18.677998 kernel: HOME=/ Oct 30 05:25:18.678004 kernel: TERM=linux Oct 30 05:25:18.678011 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 30 05:25:18.678019 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) Oct 30 05:25:18.678027 systemd[1]: Detected virtualization kvm. Oct 30 05:25:18.678034 systemd[1]: Detected architecture arm64. Oct 30 05:25:18.678040 systemd[1]: Running in initial RAM disk. Oct 30 05:25:18.678047 systemd[1]: No hostname configured, using default hostname. Oct 30 05:25:18.678053 systemd[1]: Hostname set to . Oct 30 05:25:18.678061 systemd[1]: Initializing machine ID from VM UUID. Oct 30 05:25:18.678075 systemd[1]: Queued start job for default target Initrd Default Target. Oct 30 05:25:18.678082 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 30 05:25:18.678089 systemd[1]: Reached target Local Encrypted Volumes. Oct 30 05:25:18.678095 systemd[1]: Reached target Path Units. Oct 30 05:25:18.678101 systemd[1]: Reached target Slice Units. Oct 30 05:25:18.678108 systemd[1]: Reached target Swaps. Oct 30 05:25:18.678114 systemd[1]: Reached target Timer Units. Oct 30 05:25:18.678122 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 30 05:25:18.678129 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 30 05:25:18.678135 systemd[1]: Listening on Journal Audit Socket. Oct 30 05:25:18.678142 systemd[1]: Listening on Journal Socket (/dev/log). Oct 30 05:25:18.678148 systemd[1]: Listening on Journal Socket. Oct 30 05:25:18.678154 systemd[1]: Listening on udev Control Socket. Oct 30 05:25:18.678161 systemd[1]: Listening on udev Kernel Socket. Oct 30 05:25:18.678167 systemd[1]: Reached target Socket Units. Oct 30 05:25:18.678174 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 30 05:25:18.678181 systemd[1]: Starting Create List of Static Device Nodes... Oct 30 05:25:18.678188 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 30 05:25:18.678194 systemd[1]: Starting Journal Service... Oct 30 05:25:18.678201 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 30 05:25:18.678207 systemd[1]: Starting Apply Kernel Variables... Oct 30 05:25:18.678214 systemd[1]: Starting Setup Virtual Console... Oct 30 05:25:18.678220 kernel: SCSI subsystem initialized Oct 30 05:25:18.678226 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 30 05:25:18.678233 systemd[1]: Finished Create List of Static Device Nodes. Oct 30 05:25:18.678240 systemd[1]: Finished Apply Kernel Variables. Oct 30 05:25:18.678246 kernel: Loading iSCSI transport class v2.0-870. Oct 30 05:25:18.678253 systemd[1]: Finished Setup Virtual Console. Oct 30 05:25:18.678261 systemd-journald[270]: Journal started Oct 30 05:25:18.678297 systemd-journald[270]: Runtime Journal (/run/log/journal/405d5b88619e4982ab91f873a02d04cf) is 6.0M, max 48.5M, 42.4M free. Oct 30 05:25:18.680097 systemd[1]: Started Journal Service. Oct 30 05:25:18.680797 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 30 05:25:18.682298 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 30 05:25:18.685365 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 30 05:25:18.696919 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 30 05:25:18.698650 systemd[1]: Starting dracut cmdline hook... Oct 30 05:25:18.707207 dracut-cmdline[290]: dracut-dracut-053 Oct 30 05:25:18.709316 dracut-cmdline[290]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 30 05:25:18.763095 kernel: iscsi: registered transport (tcp) Oct 30 05:25:18.774214 kernel: iscsi: registered transport (qla4xxx) Oct 30 05:25:18.774230 kernel: QLogic iSCSI HBA Driver Oct 30 05:25:18.783566 systemd[1]: Finished dracut cmdline hook. Oct 30 05:25:18.784956 systemd[1]: Starting dracut pre-udev hook... Oct 30 05:25:18.786204 systemd[1]: Starting Open-iSCSI... Oct 30 05:25:18.788398 iscsid[376]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 30 05:25:18.788398 iscsid[376]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Oct 30 05:25:18.788398 iscsid[376]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 30 05:25:18.788398 iscsid[376]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 30 05:25:18.788398 iscsid[376]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 30 05:25:18.800402 kernel: device-mapper: uevent: version 1.0.3 Oct 30 05:25:18.800419 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 30 05:25:18.800428 iscsid[376]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 30 05:25:18.791921 systemd[1]: Started Open-iSCSI. Oct 30 05:25:18.834096 kernel: raid6: neonx8 gen() 13779 MB/s Oct 30 05:25:18.851088 kernel: raid6: neonx8 xor() 10742 MB/s Oct 30 05:25:18.868086 kernel: raid6: neonx4 gen() 13579 MB/s Oct 30 05:25:18.885085 kernel: raid6: neonx4 xor() 11556 MB/s Oct 30 05:25:18.902085 kernel: raid6: neonx2 gen() 13000 MB/s Oct 30 05:25:18.919088 kernel: raid6: neonx2 xor() 9873 MB/s Oct 30 05:25:18.936087 kernel: raid6: neonx1 gen() 10899 MB/s Oct 30 05:25:18.953081 kernel: raid6: neonx1 xor() 8815 MB/s Oct 30 05:25:18.970087 kernel: raid6: int64x8 gen() 6811 MB/s Oct 30 05:25:18.987100 kernel: raid6: int64x8 xor() 3764 MB/s Oct 30 05:25:19.004097 kernel: raid6: int64x4 gen() 6899 MB/s Oct 30 05:25:19.021098 kernel: raid6: int64x4 xor() 3832 MB/s Oct 30 05:25:19.038098 kernel: raid6: int64x2 gen() 6186 MB/s Oct 30 05:25:19.055091 kernel: raid6: int64x2 xor() 3313 MB/s Oct 30 05:25:19.072096 kernel: raid6: int64x1 gen() 5012 MB/s Oct 30 05:25:19.089188 kernel: raid6: int64x1 xor() 2597 MB/s Oct 30 05:25:19.089208 kernel: raid6: using algorithm neonx8 gen() 13779 MB/s Oct 30 05:25:19.089223 kernel: raid6: .... xor() 10742 MB/s, rmw enabled Oct 30 05:25:19.090287 kernel: raid6: using neon recovery algorithm Oct 30 05:25:19.100093 kernel: xor: measuring software checksum speed Oct 30 05:25:19.100118 kernel: 8regs : 17170 MB/sec Oct 30 05:25:19.101606 kernel: 32regs : 20765 MB/sec Oct 30 05:25:19.102504 kernel: arm64_neon : 29059 MB/sec Oct 30 05:25:19.102524 kernel: xor: using function: arm64_neon (29059 MB/sec) Oct 30 05:25:19.147094 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 30 05:25:19.156429 systemd[1]: Finished dracut pre-udev hook. Oct 30 05:25:19.157000 audit: BPF prog-id=6 op=LOAD Oct 30 05:25:19.157000 audit: BPF prog-id=7 op=LOAD Oct 30 05:25:19.157000 audit: BPF prog-id=8 op=LOAD Oct 30 05:25:19.158238 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 30 05:25:19.161336 kernel: audit: type=1334 audit(1761801919.157:2): prog-id=6 op=LOAD Oct 30 05:25:19.161353 kernel: audit: type=1334 audit(1761801919.157:3): prog-id=7 op=LOAD Oct 30 05:25:19.161366 kernel: audit: type=1334 audit(1761801919.157:4): prog-id=8 op=LOAD Oct 30 05:25:19.170581 systemd-udevd[409]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 30 05:25:19.172257 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 30 05:25:19.173848 systemd[1]: Starting dracut pre-trigger hook... Oct 30 05:25:19.185502 dracut-pre-trigger[416]: rd.md=0: removing MD RAID activation Oct 30 05:25:19.207515 systemd[1]: Finished dracut pre-trigger hook. Oct 30 05:25:19.208861 systemd[1]: Starting Coldplug All udev Devices... Oct 30 05:25:19.218196 systemd-udevd[409]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 30 05:25:19.238338 systemd[1]: Finished Coldplug All udev Devices. Oct 30 05:25:19.239744 systemd[1]: Starting dracut initqueue hook... Oct 30 05:25:19.254473 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 30 05:25:19.254590 kernel: vda: detected capacity change from 0 to 4756340736 Oct 30 05:25:19.263083 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 30 05:25:19.264833 systemd-udevd[471]: Using default interface naming scheme 'v249'. Oct 30 05:25:19.283094 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (462) Oct 30 05:25:19.285511 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 30 05:25:19.286445 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 30 05:25:19.293629 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 30 05:25:19.294571 systemd[1]: Reached target Initrd Root Device. Oct 30 05:25:19.296652 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 30 05:25:19.298738 systemd[1]: Finished dracut initqueue hook. Oct 30 05:25:19.299743 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 30 05:25:19.299850 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 30 05:25:19.301229 systemd[1]: Reached target Preparation for Local File Systems. Oct 30 05:25:19.302821 systemd[1]: Reached target Preparation for Remote File Systems. Oct 30 05:25:19.304660 systemd[1]: Reached target Remote Encrypted Volumes. Oct 30 05:25:19.306275 systemd[1]: Reached target Remote File Systems. Oct 30 05:25:19.308468 systemd[1]: Starting dracut pre-mount hook... Oct 30 05:25:19.309821 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 30 05:25:19.316516 systemd[1]: Finished dracut pre-mount hook. Oct 30 05:25:19.317886 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 30 05:25:19.323098 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 30 05:25:19.327104 systemd-fsck[507]: ROOT: clean, 640/553792 files, 39961/553472 blocks Oct 30 05:25:19.329378 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 30 05:25:19.331999 systemd[1]: Mounting /sysroot... Oct 30 05:25:19.342683 systemd[1]: Found device /dev/mapper/usr. Oct 30 05:25:19.344585 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 30 05:25:19.346704 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 30 05:25:19.356369 systemd-fsck[518]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 30 05:25:19.356369 systemd-fsck[518]: You must have r/w access to the filesystem or be root Oct 30 05:25:19.359613 systemd-fsck[514]: fsck failed with exit status 8. Oct 30 05:25:19.359618 systemd-fsck[514]: Ignoring error. Oct 30 05:25:19.360507 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 30 05:25:19.363643 systemd[1]: Mounting /sysusr/usr... Oct 30 05:25:19.372421 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 30 05:25:19.372448 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 30 05:25:19.372457 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 30 05:25:19.373095 systemd[1]: Mounted /sysusr/usr. Oct 30 05:25:19.374624 systemd[1]: Mounted /sysroot. Oct 30 05:25:19.375430 systemd[1]: Reached target Initrd Root File System. Oct 30 05:25:19.376599 systemd[1]: Reached target Local File Systems. Oct 30 05:25:19.378019 systemd[1]: Reached target System Initialization. Oct 30 05:25:19.379479 systemd[1]: Reached target Basic System. Oct 30 05:25:19.381850 systemd[1]: Mounting /sysroot/usr... Oct 30 05:25:19.383029 systemd[1]: Starting Reload Configuration from the Real Root... Oct 30 05:25:19.384597 systemd[1]: Mounted /sysroot/usr. Oct 30 05:25:19.387135 systemd[1]: Reloading. Oct 30 05:25:19.389000 audit: BPF prog-id=6 op=UNLOAD Oct 30 05:25:19.391090 kernel: audit: type=1334 audit(1761801919.389:5): prog-id=6 op=UNLOAD Oct 30 05:25:19.394000 audit: BPF prog-id=3 op=UNLOAD Oct 30 05:25:19.396098 kernel: audit: type=1334 audit(1761801919.394:6): prog-id=3 op=UNLOAD Oct 30 05:25:19.467000 audit: BPF prog-id=9 op=LOAD Oct 30 05:25:19.468000 audit: BPF prog-id=10 op=LOAD Oct 30 05:25:19.469233 kernel: audit: type=1334 audit(1761801919.467:7): prog-id=9 op=LOAD Oct 30 05:25:19.469263 kernel: audit: type=1334 audit(1761801919.468:8): prog-id=10 op=LOAD Oct 30 05:25:19.469287 kernel: audit: type=1334 audit(1761801919.468:9): prog-id=11 op=LOAD Oct 30 05:25:19.468000 audit: BPF prog-id=11 op=LOAD Oct 30 05:25:19.470087 kernel: audit: type=1334 audit(1761801919.468:10): prog-id=7 op=UNLOAD Oct 30 05:25:19.468000 audit: BPF prog-id=7 op=UNLOAD Oct 30 05:25:19.468000 audit: BPF prog-id=8 op=UNLOAD Oct 30 05:25:19.469000 audit: BPF prog-id=12 op=LOAD Oct 30 05:25:19.470000 audit: BPF prog-id=13 op=LOAD Oct 30 05:25:19.470000 audit: BPF prog-id=14 op=LOAD Oct 30 05:25:19.470000 audit: BPF prog-id=4 op=UNLOAD Oct 30 05:25:19.470000 audit: BPF prog-id=5 op=UNLOAD Oct 30 05:25:19.483796 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 30 05:25:19.483909 systemd[1]: Finished Reload Configuration from the Real Root. Oct 30 05:25:19.485834 systemd[1]: Reached target Initrd File Systems. Oct 30 05:25:19.487362 systemd[1]: Reached target Initrd Default Target. Oct 30 05:25:19.488827 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 30 05:25:19.489489 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 30 05:25:19.499296 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 30 05:25:19.500841 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 30 05:25:19.506204 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 30 05:25:19.507156 systemd[1]: Stopped target Timer Units. Oct 30 05:25:19.508747 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 30 05:25:19.508855 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 30 05:25:19.510249 systemd[1]: Stopped target Initrd Default Target. Oct 30 05:25:19.511842 systemd[1]: Stopped target Basic System. Oct 30 05:25:19.513283 systemd[1]: Stopped target Initrd Root Device. Oct 30 05:25:19.514688 systemd[1]: Stopped target Path Units. Oct 30 05:25:19.515918 systemd[1]: Stopped target Remote File Systems. Oct 30 05:25:19.517351 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 30 05:25:19.518861 systemd[1]: Stopped target Slice Units. Oct 30 05:25:19.520213 systemd[1]: Stopped target Socket Units. Oct 30 05:25:19.521705 systemd[1]: Stopped target System Initialization. Oct 30 05:25:19.523041 systemd[1]: Stopped target Local File Systems. Oct 30 05:25:19.524379 systemd[1]: Stopped target Preparation for Local File Systems. Oct 30 05:25:19.525954 systemd[1]: Stopped target Swaps. Oct 30 05:25:19.527246 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 30 05:25:19.527357 systemd[1]: Stopped dracut pre-mount hook. Oct 30 05:25:19.528825 systemd[1]: Stopped target Local Encrypted Volumes. Oct 30 05:25:19.530041 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 30 05:25:19.534552 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 30 05:25:19.535772 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 30 05:25:19.535868 systemd[1]: Stopped dracut initqueue hook. Oct 30 05:25:19.539386 iscsid[376]: iscsid shutting down. Oct 30 05:25:19.537578 systemd[1]: Stopping Open-iSCSI... Oct 30 05:25:19.538742 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 30 05:25:19.538862 systemd[1]: Stopped Apply Kernel Variables. Oct 30 05:25:19.540158 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 30 05:25:19.540250 systemd[1]: Stopped Coldplug All udev Devices. Oct 30 05:25:19.541438 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 30 05:25:19.541525 systemd[1]: Stopped dracut pre-trigger hook. Oct 30 05:25:19.542757 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 30 05:25:19.547945 systemd[1]: iscsid.service: Deactivated successfully. Oct 30 05:25:19.548059 systemd[1]: Stopped Open-iSCSI. Oct 30 05:25:19.549797 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 30 05:25:19.549916 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 30 05:25:19.551798 systemd[1]: iscsid.socket: Deactivated successfully. Oct 30 05:25:19.551843 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 30 05:25:19.552781 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 30 05:25:19.562000 audit: BPF prog-id=9 op=UNLOAD Oct 30 05:25:19.552820 systemd[1]: Closed udev Control Socket. Oct 30 05:25:19.554402 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 30 05:25:19.554434 systemd[1]: Closed udev Kernel Socket. Oct 30 05:25:19.555773 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 30 05:25:19.555817 systemd[1]: Stopped dracut pre-udev hook. Oct 30 05:25:19.556976 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 30 05:25:19.557016 systemd[1]: Stopped dracut cmdline hook. Oct 30 05:25:19.558542 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 30 05:25:19.558584 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 30 05:25:19.560899 systemd[1]: Starting Cleanup udev Database... Oct 30 05:25:19.561711 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 30 05:25:19.563216 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 30 05:25:19.564809 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 30 05:25:19.564867 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 30 05:25:19.566256 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 30 05:25:19.566298 systemd[1]: Stopped Create List of Static Device Nodes. Oct 30 05:25:19.567951 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 30 05:25:19.567994 systemd[1]: Stopped Setup Virtual Console. Oct 30 05:25:19.587000 audit: BPF prog-id=12 op=UNLOAD Oct 30 05:25:19.569534 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 30 05:25:19.569647 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 30 05:25:19.571052 systemd[1]: rngd.service: Deactivated successfully. Oct 30 05:25:19.571176 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 30 05:25:19.572681 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 30 05:25:19.572784 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 30 05:25:19.574425 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 30 05:25:19.574525 systemd[1]: Finished Cleanup udev Database. Oct 30 05:25:19.576225 systemd[1]: Reached target Switch Root. Oct 30 05:25:19.577082 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 30 05:25:19.577153 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 30 05:25:19.579359 systemd[1]: Starting Switch Root... Oct 30 05:25:19.584632 systemd[1]: Switching root. Oct 30 05:25:19.600349 systemd-journald[270]: Journal stopped Oct 30 05:25:21.634375 systemd-journald[270]: Received SIGTERM from PID 1 (systemd). Oct 30 05:25:21.634430 kernel: SELinux: policy capability network_peer_controls=1 Oct 30 05:25:21.634443 kernel: SELinux: policy capability open_perms=1 Oct 30 05:25:21.634456 kernel: SELinux: policy capability extended_socket_class=1 Oct 30 05:25:21.634466 kernel: SELinux: policy capability always_check_network=0 Oct 30 05:25:21.634475 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 30 05:25:21.634484 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 30 05:25:21.634493 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 30 05:25:21.634502 systemd[1]: Successfully loaded SELinux policy in 32.142ms. Oct 30 05:25:21.634517 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.072ms. Oct 30 05:25:21.634528 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) Oct 30 05:25:21.634539 systemd[1]: Detected virtualization kvm. Oct 30 05:25:21.634548 systemd[1]: Detected architecture arm64. Oct 30 05:25:21.634559 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. Oct 30 05:25:21.634571 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 30 05:25:21.634582 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 30 05:25:21.634591 systemd[1]: Stopped Switch Root. Oct 30 05:25:21.634601 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 30 05:25:21.634612 systemd[1]: Created slice Slice /system/addon-config. Oct 30 05:25:21.634622 systemd[1]: Created slice Slice /system/addon-run. Oct 30 05:25:21.634632 systemd[1]: Created slice Slice /system/getty. Oct 30 05:25:21.634643 systemd[1]: Created slice Slice /system/modprobe. Oct 30 05:25:21.634652 systemd[1]: Created slice Slice /system/serial-getty. Oct 30 05:25:21.634662 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 30 05:25:21.634671 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 30 05:25:21.634680 systemd[1]: Created slice User and Session Slice. Oct 30 05:25:21.634690 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 30 05:25:21.634700 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 30 05:25:21.634709 systemd[1]: Set up automount Boot partition Automount Point. Oct 30 05:25:21.634719 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 30 05:25:21.634730 systemd[1]: Stopped target Switch Root. Oct 30 05:25:21.634746 systemd[1]: Stopped target Initrd File Systems. Oct 30 05:25:21.634755 systemd[1]: Stopped target Initrd Root File System. Oct 30 05:25:21.634765 systemd[1]: Reached target Remote Encrypted Volumes. Oct 30 05:25:21.634774 systemd[1]: Reached target Remote File Systems. Oct 30 05:25:21.634784 systemd[1]: Reached target Slice Units. Oct 30 05:25:21.634793 systemd[1]: Reached target Swaps. Oct 30 05:25:21.634803 systemd[1]: Reached target Verify torcx succeeded. Oct 30 05:25:21.634813 systemd[1]: Reached target Local Verity Protected Volumes. Oct 30 05:25:21.634822 systemd[1]: Listening on Process Core Dump Socket. Oct 30 05:25:21.634832 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 30 05:25:21.634842 systemd[1]: Listening on Network Service Netlink Socket. Oct 30 05:25:21.634852 systemd[1]: Listening on udev Control Socket. Oct 30 05:25:21.634862 systemd[1]: Listening on udev Kernel Socket. Oct 30 05:25:21.634873 systemd[1]: Mounting Huge Pages File System... Oct 30 05:25:21.634884 systemd[1]: Mounting POSIX Message Queue File System... Oct 30 05:25:21.634893 systemd[1]: Mounting External Media Directory... Oct 30 05:25:21.634902 systemd[1]: Mounting Kernel Debug File System... Oct 30 05:25:21.634912 systemd[1]: Mounting Kernel Trace File System... Oct 30 05:25:21.634923 systemd[1]: Mounting Temporary Directory /tmp... Oct 30 05:25:21.634933 systemd[1]: Starting Create missing system files... Oct 30 05:25:21.634942 systemd[1]: Starting Create List of Static Device Nodes... Oct 30 05:25:21.634953 systemd[1]: Starting Load Kernel Module configfs... Oct 30 05:25:21.634962 systemd[1]: Starting Load Kernel Module drm... Oct 30 05:25:21.634972 systemd[1]: Starting Load Kernel Module fuse... Oct 30 05:25:21.634981 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 30 05:25:21.634991 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 30 05:25:21.635001 systemd[1]: Stopped File System Check on Root Device. Oct 30 05:25:21.635011 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 30 05:25:21.635022 systemd[1]: Stopped systemd-fsck-usr.service. Oct 30 05:25:21.635032 kernel: fuse: init (API version 7.32) Oct 30 05:25:21.635042 systemd[1]: Stopped Journal Service. Oct 30 05:25:21.635052 systemd[1]: Starting Journal Service... Oct 30 05:25:21.635062 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 30 05:25:21.635080 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 30 05:25:21.635090 systemd[1]: Starting Apply Kernel Variables... Oct 30 05:25:21.635100 systemd[1]: Starting Coldplug All udev Devices... Oct 30 05:25:21.635110 systemd[1]: verity-setup.service: Deactivated successfully. Oct 30 05:25:21.635120 systemd[1]: Stopped verity-setup.service. Oct 30 05:25:21.635136 systemd-journald[693]: Journal started Oct 30 05:25:21.635174 systemd-journald[693]: Runtime Journal (/run/log/journal/405d5b88619e4982ab91f873a02d04cf) is 6.0M, max 48.5M, 42.4M free. Oct 30 05:25:19.673000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 30 05:25:19.700000 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 Oct 30 05:25:19.700000 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 Oct 30 05:25:19.700000 audit: BPF prog-id=15 op=LOAD Oct 30 05:25:19.700000 audit: BPF prog-id=15 op=UNLOAD Oct 30 05:25:19.700000 audit: BPF prog-id=16 op=LOAD Oct 30 05:25:19.700000 audit: BPF prog-id=16 op=UNLOAD Oct 30 05:25:19.731000 audit[646]: AVC avc: denied { associate } for pid=646 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 Oct 30 05:25:21.515000 audit: BPF prog-id=17 op=LOAD Oct 30 05:25:21.515000 audit: BPF prog-id=18 op=LOAD Oct 30 05:25:21.515000 audit: BPF prog-id=19 op=LOAD Oct 30 05:25:21.515000 audit: BPF prog-id=13 op=UNLOAD Oct 30 05:25:21.515000 audit: BPF prog-id=14 op=UNLOAD Oct 30 05:25:21.516000 audit: BPF prog-id=20 op=LOAD Oct 30 05:25:21.516000 audit: BPF prog-id=17 op=UNLOAD Oct 30 05:25:21.516000 audit: BPF prog-id=21 op=LOAD Oct 30 05:25:21.516000 audit: BPF prog-id=22 op=LOAD Oct 30 05:25:21.516000 audit: BPF prog-id=18 op=UNLOAD Oct 30 05:25:21.516000 audit: BPF prog-id=19 op=UNLOAD Oct 30 05:25:21.516000 audit: BPF prog-id=23 op=LOAD Oct 30 05:25:21.516000 audit: BPF prog-id=20 op=UNLOAD Oct 30 05:25:21.516000 audit: BPF prog-id=24 op=LOAD Oct 30 05:25:21.516000 audit: BPF prog-id=25 op=LOAD Oct 30 05:25:21.516000 audit: BPF prog-id=21 op=UNLOAD Oct 30 05:25:21.516000 audit: BPF prog-id=22 op=UNLOAD Oct 30 05:25:21.525000 audit: BPF prog-id=23 op=UNLOAD Oct 30 05:25:21.620000 audit: BPF prog-id=26 op=LOAD Oct 30 05:25:21.621000 audit: BPF prog-id=27 op=LOAD Oct 30 05:25:21.621000 audit: BPF prog-id=28 op=LOAD Oct 30 05:25:21.621000 audit: BPF prog-id=24 op=UNLOAD Oct 30 05:25:21.621000 audit: BPF prog-id=25 op=UNLOAD Oct 30 05:25:21.633000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 30 05:25:21.507402 systemd[1]: Queued start job for default target Multi-User System. Oct 30 05:25:19.729379 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" 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]" Oct 30 05:25:21.517350 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 30 05:25:19.729662 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 30 05:25:19.729682 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 30 05:25:19.729981 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 30 05:25:19.729993 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 30 05:25:19.730027 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 30 05:25:19.730039 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 30 05:25:19.730349 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 30 05:25:19.730397 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 30 05:25:19.730412 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 30 05:25:19.730741 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" 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 Oct 30 05:25:19.730770 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" 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 Oct 30 05:25:19.730789 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" 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 Oct 30 05:25:19.730804 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 30 05:25:19.730885 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" 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 Oct 30 05:25:19.730900 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:19Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 30 05:25:21.419057 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:21Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 30 05:25:21.419364 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:21Z" 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 Oct 30 05:25:21.419468 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:21Z" 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 Oct 30 05:25:21.419589 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:21Z" 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 Oct 30 05:25:21.419682 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:21Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 30 05:25:21.419740 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-30T05:25:21Z" 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 Oct 30 05:25:21.637754 systemd[1]: Started Journal Service. Oct 30 05:25:21.638299 systemd[1]: Mounted Huge Pages File System. Oct 30 05:25:21.639281 systemd[1]: Mounted POSIX Message Queue File System. Oct 30 05:25:21.640260 systemd[1]: Mounted External Media Directory. Oct 30 05:25:21.641165 systemd[1]: Mounted Kernel Debug File System. Oct 30 05:25:21.642050 systemd[1]: Mounted Kernel Trace File System. Oct 30 05:25:21.642952 systemd[1]: Mounted Temporary Directory /tmp. Oct 30 05:25:21.644170 systemd[1]: Finished Create missing system files. Oct 30 05:25:21.645314 systemd[1]: Finished Create List of Static Device Nodes. Oct 30 05:25:21.646456 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 30 05:25:21.646636 systemd[1]: Finished Load Kernel Module configfs. Oct 30 05:25:21.647723 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 30 05:25:21.647900 systemd[1]: Finished Load Kernel Module drm. Oct 30 05:25:21.648963 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 30 05:25:21.649163 systemd[1]: Finished Load Kernel Module fuse. Oct 30 05:25:21.650246 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 30 05:25:21.651532 systemd[1]: Finished Apply Kernel Variables. Oct 30 05:25:21.678882 systemd[1]: Mounting FUSE Control File System... Oct 30 05:25:21.680700 systemd[1]: Mounting Kernel Configuration File System... Oct 30 05:25:21.681563 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 30 05:25:21.682501 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 30 05:25:21.683446 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 30 05:25:21.684484 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 30 05:25:21.685610 systemd[1]: Starting Load/Save Random Seed... Oct 30 05:25:21.686644 systemd[1]: Condition check resulted in Create System Users being skipped. Oct 30 05:25:21.688844 systemd-journald[693]: Time spent on flushing to /var/log/journal/405d5b88619e4982ab91f873a02d04cf is 12.368ms for 667 entries. Oct 30 05:25:21.688844 systemd-journald[693]: System Journal (/var/log/journal/405d5b88619e4982ab91f873a02d04cf) is 8.0M, max 203.0M, 195.0M free. Oct 30 05:25:21.708000 audit: BPF prog-id=29 op=LOAD Oct 30 05:25:21.708000 audit: BPF prog-id=30 op=LOAD Oct 30 05:25:21.708000 audit: BPF prog-id=31 op=LOAD Oct 30 05:25:21.708000 audit: BPF prog-id=10 op=UNLOAD Oct 30 05:25:21.708000 audit: BPF prog-id=11 op=UNLOAD Oct 30 05:25:21.687641 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 30 05:25:21.689621 systemd[1]: Mounted FUSE Control File System. Oct 30 05:25:21.691239 systemd[1]: Mounted Kernel Configuration File System. Oct 30 05:25:21.695479 systemd[1]: Finished Load/Save Random Seed. Oct 30 05:25:21.697009 systemd[1]: Finished Coldplug All udev Devices. Oct 30 05:25:21.698371 systemd[1]: Condition check resulted in First Boot Complete being skipped. Oct 30 05:25:21.705017 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 30 05:25:21.706416 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 30 05:25:21.710209 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 30 05:25:21.715272 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 30 05:25:21.732631 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 30 05:25:21.740000 audit: BPF prog-id=32 op=LOAD Oct 30 05:25:21.741204 systemd[1]: Starting Network Configuration... Oct 30 05:25:21.768814 systemd-networkd[726]: lo: Link UP Oct 30 05:25:21.768824 systemd-networkd[726]: lo: Gained carrier Oct 30 05:25:21.769180 systemd-networkd[726]: Enumeration completed Oct 30 05:25:21.769274 systemd[1]: Started Network Configuration. Oct 30 05:25:21.776864 systemd-udevd[717]: Using default interface naming scheme 'v249'. Oct 30 05:25:21.796295 systemd-networkd[726]: eth0: Link UP Oct 30 05:25:21.801144 systemd-networkd[726]: eth0: Gained carrier Oct 30 05:25:21.805612 udevadm[705]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 30 05:25:21.806257 systemd-networkd[726]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 30 05:25:21.827355 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 30 05:25:21.845338 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 30 05:25:21.855304 lvm[734]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 30 05:25:21.890133 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 30 05:25:21.891587 systemd[1]: Reached target Local Encrypted Volumes. Oct 30 05:25:21.911097 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 30 05:25:21.914873 lvm[735]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 30 05:25:21.948126 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 30 05:25:21.949177 systemd[1]: Reached target Preparation for Local File Systems. Oct 30 05:25:21.950225 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 30 05:25:21.950251 systemd[1]: Reached target Containers. Oct 30 05:25:21.973511 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 30 05:25:21.986885 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 30 05:25:21.989005 systemd[1]: Mounting /usr/share/oem... Oct 30 05:25:21.995082 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 30 05:25:21.995139 kernel: BTRFS info (device vda6): has skinny extents Oct 30 05:25:21.997109 systemd[1]: Mounted /usr/share/oem. Oct 30 05:25:21.997888 systemd[1]: Reached target Local File Systems. Oct 30 05:25:21.998842 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Oct 30 05:25:21.999207 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 30 05:25:21.999247 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 30 05:25:21.999274 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 30 05:25:22.010448 systemd[1]: Starting Create Volatile Files and Directories... Oct 30 05:25:22.016376 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 30 05:25:22.017401 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 30 05:25:22.044401 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Oct 30 05:25:22.044412 systemd-tmpfiles[758]: Skipping /boot Oct 30 05:25:22.049956 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Oct 30 05:25:22.049974 systemd-tmpfiles[758]: Skipping /boot Oct 30 05:25:22.078253 systemd[1]: Finished Create Volatile Files and Directories. Oct 30 05:25:22.111652 systemd[1]: Starting Load Security Auditing Rules... Oct 30 05:25:22.113696 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 30 05:25:22.114797 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Oct 30 05:25:22.115000 audit: BPF prog-id=33 op=LOAD Oct 30 05:25:22.116507 systemd[1]: Starting Network Name Resolution... Oct 30 05:25:22.117000 audit: BPF prog-id=34 op=LOAD Oct 30 05:25:22.119027 systemd[1]: Starting Network Time Synchronization... Oct 30 05:25:22.120094 systemd[1]: Condition check resulted in Update is Completed being skipped. Oct 30 05:25:22.121125 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 30 05:25:22.122532 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 30 05:25:22.123870 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 30 05:25:22.129393 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 30 05:25:22.138000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 30 05:25:22.138650 augenrules[779]: No rules Oct 30 05:25:22.149448 systemd[1]: Finished Load Security Auditing Rules. Oct 30 05:25:22.154745 systemd[1]: Started Network Time Synchronization. Oct 30 05:25:22.155242 systemd-timesyncd[768]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 30 05:25:22.155948 systemd[1]: Reached target System Initialization. Oct 30 05:25:22.156624 systemd-resolved[762]: Positive Trust Anchors: Oct 30 05:25:22.156635 systemd-resolved[762]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 30 05:25:22.156664 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 Oct 30 05:25:22.157027 systemd[1]: Started Watch for update engine configuration changes. Oct 30 05:25:22.157522 systemd-resolved[762]: Defaulting to hostname 'linux'. Oct 30 05:25:22.158251 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 30 05:25:22.159408 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 30 05:25:22.160452 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 30 05:25:22.160481 systemd[1]: Reached target Path Units. Oct 30 05:25:22.161218 systemd[1]: Reached target System Time Set. Oct 30 05:25:22.162181 systemd[1]: Started Daily Log Rotation. Oct 30 05:25:22.162998 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 30 05:25:22.164168 systemd[1]: Reached target Timer Units. Oct 30 05:25:22.165232 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 30 05:25:22.173813 systemd[1]: Starting Docker Socket for the API... Oct 30 05:25:22.176909 systemd[1]: Listening on OpenSSH Server Socket. Oct 30 05:25:22.178222 systemd[1]: Started Network Name Resolution. Oct 30 05:25:22.179153 systemd[1]: Listening on Docker Socket for the API. Oct 30 05:25:22.180061 systemd[1]: Reached target Network. Oct 30 05:25:22.180788 systemd[1]: Reached target Host and Network Name Lookups. Oct 30 05:25:22.181784 systemd[1]: Reached target Socket Units. Oct 30 05:25:22.182594 systemd[1]: Reached target Basic System. Oct 30 05:25:22.183407 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 30 05:25:22.183439 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 30 05:25:22.184360 systemd[1]: Started D-Bus System Message Bus. Oct 30 05:25:22.187468 systemd[1]: Starting Extend Filesystems... Oct 30 05:25:22.188291 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 30 05:25:22.189286 systemd[1]: Starting Generate /run/flatcar/motd... Oct 30 05:25:22.191111 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 30 05:25:22.193137 systemd[1]: Starting Generate sshd host keys... Oct 30 05:25:22.194664 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 30 05:25:22.194693 systemd[1]: Reached target Load system-provided cloud configs. Oct 30 05:25:22.197205 extend-filesystems[789]: Found vda Oct 30 05:25:22.197595 systemd[1]: Starting User Login Management... Oct 30 05:25:22.198259 extend-filesystems[789]: Found vda1 Oct 30 05:25:22.199456 extend-filesystems[789]: Found vda2 Oct 30 05:25:22.199514 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 30 05:25:22.200135 systemd[1]: Starting Update Engine... Oct 30 05:25:22.200333 extend-filesystems[789]: Found vda3 Oct 30 05:25:22.202035 extend-filesystems[789]: Found usr Oct 30 05:25:22.202035 extend-filesystems[789]: Found vda4 Oct 30 05:25:22.202035 extend-filesystems[789]: Found vda6 Oct 30 05:25:22.202035 extend-filesystems[789]: Found vda7 Oct 30 05:25:22.202035 extend-filesystems[789]: Found vda9 Oct 30 05:25:22.202035 extend-filesystems[789]: Checking size of /dev/vda9 Oct 30 05:25:22.201309 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 30 05:25:22.201343 systemd[1]: Reached target Load user-provided cloud configs. Oct 30 05:25:22.203704 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 30 05:25:22.203927 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 30 05:25:22.217470 systemd[1]: motdgen.service: Deactivated successfully. Oct 30 05:25:22.220392 extend-filesystems[789]: Old size kept for /dev/vda9 Oct 30 05:25:22.217735 systemd[1]: Finished Generate /run/flatcar/motd. Oct 30 05:25:22.218954 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 30 05:25:22.219201 systemd[1]: Finished Extend Filesystems. Oct 30 05:25:22.236508 systemd-logind[800]: Watching system buttons on /dev/input/event0 (Power Button) Oct 30 05:25:22.237381 systemd-logind[800]: New seat seat0. Oct 30 05:25:22.241246 systemd[1]: Started User Login Management. Oct 30 05:25:22.250088 systemd[1]: Finished Generate sshd host keys. Oct 30 05:25:22.250167 update_engine[804]: I1030 05:25:22.249810 804 main.cc:89] Flatcar Update Engine starting Oct 30 05:25:22.250773 update_engine[804]: I1030 05:25:22.250735 804 payload_state.cc:360] Current Response Signature = Oct 30 05:25:22.250773 update_engine[804]: NumURLs = 1 Oct 30 05:25:22.250773 update_engine[804]: Url0 = http://10.0.0.5:34567/packages/update.gz Oct 30 05:25:22.250773 update_engine[804]: Payload Size = 439617737 Oct 30 05:25:22.250773 update_engine[804]: Payload Sha256 Hash = hKuDazTd3yRvZZ+1GzVZ5iDGEt/oXMhd+zKPhlhnEaA= Oct 30 05:25:22.250773 update_engine[804]: Is Delta Payload = 0 Oct 30 05:25:22.250773 update_engine[804]: Max Failure Count Per Url = 10 Oct 30 05:25:22.250773 update_engine[804]: Disable Payload Backoff = 1 Oct 30 05:25:22.251054 update_engine[804]: I1030 05:25:22.250937 804 payload_state.cc:381] Payload Attempt Number = 0 Oct 30 05:25:22.251135 update_engine[804]: I1030 05:25:22.251104 804 payload_state.cc:404] Current URL Index = 0 Oct 30 05:25:22.251459 update_engine[804]: I1030 05:25:22.251266 804 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 30 05:25:22.251459 update_engine[804]: I1030 05:25:22.251410 804 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 30 05:25:22.253261 update_engine[804]: I1030 05:25:22.253223 804 update_check_scheduler.cc:74] Next update check in 2m4s Oct 30 05:25:22.262315 systemd[1]: Starting Generate /run/issue... Oct 30 05:25:22.263219 systemd[1]: Started Update Engine. Oct 30 05:25:22.266635 systemd[1]: issuegen.service: Deactivated successfully. Oct 30 05:25:22.266847 systemd[1]: Finished Generate /run/issue. Oct 30 05:25:22.268955 systemd[1]: Starting Permit User Sessions... Oct 30 05:25:22.272916 systemd[1]: Finished Permit User Sessions. Oct 30 05:25:22.274984 systemd[1]: Started Getty on tty1. Oct 30 05:25:22.276869 systemd[1]: Started Serial Getty on ttyAMA0. Oct 30 05:25:22.277901 systemd[1]: Reached target Login Prompts. Oct 30 05:25:22.278936 systemd[1]: Reached target Multi-User System. Oct 30 05:25:22.280908 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 30 05:25:22.285484 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 30 05:25:22.285693 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 30 05:25:22.286741 systemd[1]: Startup finished in 693ms (kernel) + 1.079s (initrd) + 2.647s (userspace) = 4.420s. Oct 30 05:25:23.529333 systemd-networkd[726]: eth0: Gained IPv6LL Oct 30 05:25:31.852633 systemd[1]: Created slice Slice /system/sshd. Oct 30 05:25:31.853692 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55840). Oct 30 05:25:31.890570 sshd[830]: Accepted publickey for core from 10.0.0.1 port 55840 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:31.892557 sshd[830]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:31.917523 systemd[1]: Created slice User Slice of UID 500. Oct 30 05:25:31.918474 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 30 05:25:31.920049 systemd-logind[800]: New session 1 of user core. Oct 30 05:25:31.923972 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 30 05:25:31.925142 systemd[1]: Starting User Manager for UID 500... Oct 30 05:25:31.927090 systemd[833]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:31.971425 systemd[833]: Queued start job for default target Main User Target. Oct 30 05:25:31.971562 systemd[833]: Reached target Paths. Oct 30 05:25:31.971575 systemd[833]: Reached target Sockets. Oct 30 05:25:31.971585 systemd[833]: Reached target Timers. Oct 30 05:25:31.971596 systemd[833]: Reached target Basic System. Oct 30 05:25:31.971637 systemd[833]: Reached target Main User Target. Oct 30 05:25:31.971650 systemd[833]: Startup finished in 41ms. Oct 30 05:25:31.971865 systemd[1]: Started User Manager for UID 500. Oct 30 05:25:31.981700 systemd[1]: Started Session 1 of User core. Oct 30 05:25:32.041324 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55850). Oct 30 05:25:32.076906 sshd[842]: Accepted publickey for core from 10.0.0.1 port 55850 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:32.077815 sshd[842]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:32.080775 systemd-logind[800]: New session 2 of user core. Oct 30 05:25:32.091490 systemd[1]: Started Session 2 of User core. Oct 30 05:25:32.144755 sshd[842]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:32.160098 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:55850.service: Deactivated successfully. Oct 30 05:25:32.160603 systemd[1]: session-2.scope: Deactivated successfully. Oct 30 05:25:32.161179 systemd-logind[800]: Session 2 logged out. Waiting for processes to exit. Oct 30 05:25:32.162084 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55860). Oct 30 05:25:32.162748 systemd-logind[800]: Removed session 2. Oct 30 05:25:32.196881 sshd[848]: Accepted publickey for core from 10.0.0.1 port 55860 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:32.198574 sshd[848]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:32.201077 systemd-logind[800]: New session 3 of user core. Oct 30 05:25:32.213593 systemd[1]: Started Session 3 of User core. Oct 30 05:25:32.263527 sshd[848]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:32.272345 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:55860.service: Deactivated successfully. Oct 30 05:25:32.272816 systemd[1]: session-3.scope: Deactivated successfully. Oct 30 05:25:32.273396 systemd-logind[800]: Session 3 logged out. Waiting for processes to exit. Oct 30 05:25:32.274247 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55868). Oct 30 05:25:32.274890 systemd-logind[800]: Removed session 3. Oct 30 05:25:32.306883 sshd[854]: Accepted publickey for core from 10.0.0.1 port 55868 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:32.307811 sshd[854]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:32.310289 systemd-logind[800]: New session 4 of user core. Oct 30 05:25:32.326419 systemd[1]: Started Session 4 of User core. Oct 30 05:25:32.379994 sshd[854]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:32.392483 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:55868.service: Deactivated successfully. Oct 30 05:25:32.392965 systemd[1]: session-4.scope: Deactivated successfully. Oct 30 05:25:32.393539 systemd-logind[800]: Session 4 logged out. Waiting for processes to exit. Oct 30 05:25:32.394383 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55874). Oct 30 05:25:32.395046 systemd-logind[800]: Removed session 4. Oct 30 05:25:32.427012 sshd[860]: Accepted publickey for core from 10.0.0.1 port 55874 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:32.428654 sshd[860]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:32.431115 systemd-logind[800]: New session 5 of user core. Oct 30 05:25:32.447666 systemd[1]: Started Session 5 of User core. Oct 30 05:25:32.503729 sudo[863]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 30 05:25:32.503923 sudo[863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:25:32.519575 sudo[863]: pam_unix(sudo:session): session closed for user root Oct 30 05:25:32.522032 sshd[860]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:32.535545 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55890). Oct 30 05:25:32.537603 dbus-daemon[788]: [system] Reloaded configuration Oct 30 05:25:32.540015 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:55874.service: Deactivated successfully. Oct 30 05:25:32.540591 systemd[1]: session-5.scope: Deactivated successfully. Oct 30 05:25:32.541171 systemd-logind[800]: Session 5 logged out. Waiting for processes to exit. Oct 30 05:25:32.541746 systemd-logind[800]: Removed session 5. Oct 30 05:25:32.569141 sshd[866]: Accepted publickey for core from 10.0.0.1 port 55890 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:32.570296 sshd[866]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:32.573137 systemd-logind[800]: New session 6 of user core. Oct 30 05:25:32.584567 systemd[1]: Started Session 6 of User core. Oct 30 05:25:32.636524 sudo[871]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 30 05:25:32.636744 sudo[871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:25:32.639048 sudo[871]: pam_unix(sudo:session): session closed for user root Oct 30 05:25:32.642435 sudo[870]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 30 05:25:32.642845 sudo[870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:25:32.662881 systemd[1]: Stopping Load Security Auditing Rules... Oct 30 05:25:32.664000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 30 05:25:32.666298 kernel: kauditd_printk_skb: 49 callbacks suppressed Oct 30 05:25:32.666336 kernel: audit: type=1305 audit(1761801932.664:60): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 30 05:25:32.666586 auditctl[874]: No rules Oct 30 05:25:32.668307 systemd[1]: audit-rules.service: Deactivated successfully. Oct 30 05:25:32.668543 systemd[1]: Stopped Load Security Auditing Rules. Oct 30 05:25:32.669893 systemd[1]: Starting Load Security Auditing Rules... Oct 30 05:25:32.684750 augenrules[891]: No rules Oct 30 05:25:32.685420 systemd[1]: Finished Load Security Auditing Rules. Oct 30 05:25:32.686204 sudo[870]: pam_unix(sudo:session): session closed for user root Oct 30 05:25:32.687418 sshd[866]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:32.690200 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55892). Oct 30 05:25:32.690646 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:55890.service: Deactivated successfully. Oct 30 05:25:32.691215 systemd[1]: session-6.scope: Deactivated successfully. Oct 30 05:25:32.691752 systemd-logind[800]: Session 6 logged out. Waiting for processes to exit. Oct 30 05:25:32.692474 systemd-logind[800]: Removed session 6. Oct 30 05:25:32.728114 sshd[896]: Accepted publickey for core from 10.0.0.1 port 55892 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:32.729758 sshd[896]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:32.732083 kernel: audit: type=1006 audit(1761801932.728:61): 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 Oct 30 05:25:32.734044 systemd-logind[800]: New session 7 of user core. Oct 30 05:25:32.754094 systemd[1]: Started Session 7 of User core. Oct 30 05:25:32.802703 sshd[896]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:32.810841 systemd[1]: sshd@6-10.0.0.6:22-10.0.0.1:55892.service: Deactivated successfully. Oct 30 05:25:32.811374 systemd[1]: session-7.scope: Deactivated successfully. Oct 30 05:25:32.811988 systemd-logind[800]: Session 7 logged out. Waiting for processes to exit. Oct 30 05:25:32.812989 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55906). Oct 30 05:25:32.813699 systemd-logind[800]: Removed session 7. Oct 30 05:25:32.847578 sshd[903]: Accepted publickey for core from 10.0.0.1 port 55906 ssh2: RSA SHA256:ujpBl5D+N03fYMluBXafGF70l6DxBt4ZiOsJ1zP8FXA Oct 30 05:25:32.848911 sshd[903]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:25:32.851088 kernel: audit: type=1006 audit(1761801932.848:62): pid=903 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Oct 30 05:25:32.853456 systemd-logind[800]: New session 8 of user core. Oct 30 05:25:32.872839 systemd[1]: Started Session 8 of User core. Oct 30 05:25:32.923645 sshd[903]: pam_unix(sshd:session): session closed for user core Oct 30 05:25:32.926335 systemd[1]: sshd@7-10.0.0.6:22-10.0.0.1:55906.service: Deactivated successfully. Oct 30 05:25:32.926883 systemd[1]: session-8.scope: Deactivated successfully. Oct 30 05:25:32.927486 systemd-logind[800]: Session 8 logged out. Waiting for processes to exit. Oct 30 05:25:32.928300 systemd-logind[800]: Removed session 8.