Oct 28 13:15:31.686776 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 28 13:15:31.686793 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 28 13:15:31.686801 kernel: efi: EFI v2.70 by EDK II Oct 28 13:15:31.686806 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82d018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 28 13:15:31.686811 kernel: efi: seeding entropy pool Oct 28 13:15:31.686816 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 28 13:15:31.686823 kernel: ACPI: Early table checksum verification disabled Oct 28 13:15:31.686828 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 28 13:15:31.686833 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 28 13:15:31.686838 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:15:31.686844 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:15:31.686849 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:15:31.686854 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:15:31.686859 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:15:31.686865 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:15:31.686871 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:15:31.686877 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:15:31.686883 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:15:31.686888 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 28 13:15:31.686894 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 28 13:15:31.686899 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:15:31.686904 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 28 13:15:31.686909 kernel: Zone ranges: Oct 28 13:15:31.686915 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:15:31.686920 kernel: DMA32 empty Oct 28 13:15:31.686925 kernel: Normal empty Oct 28 13:15:31.686930 kernel: Movable zone start for each node Oct 28 13:15:31.686936 kernel: Early memory node ranges Oct 28 13:15:31.686942 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 28 13:15:31.686947 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 28 13:15:31.686952 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 28 13:15:31.686958 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 28 13:15:31.686963 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 28 13:15:31.686968 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 28 13:15:31.686973 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 28 13:15:31.686979 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 28 13:15:31.686984 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 28 13:15:31.686989 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 28 13:15:31.686994 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 28 13:15:31.687000 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:15:31.687008 kernel: On node 0 totalpages: 643072 Oct 28 13:15:31.687014 kernel: DMA zone: 10048 pages used for memmap Oct 28 13:15:31.687020 kernel: DMA zone: 0 pages reserved Oct 28 13:15:31.687026 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 28 13:15:31.687031 kernel: psci: probing for conduit method from ACPI. Oct 28 13:15:31.687037 kernel: psci: PSCIv1.1 detected in firmware. Oct 28 13:15:31.687042 kernel: psci: Using standard PSCI v0.2 function IDs Oct 28 13:15:31.687048 kernel: psci: Trusted OS migration not required Oct 28 13:15:31.687055 kernel: psci: SMC Calling Convention v1.1 Oct 28 13:15:31.687060 kernel: ACPI: SRAT not present Oct 28 13:15:31.687066 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 28 13:15:31.687072 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 28 13:15:31.687077 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 28 13:15:31.687083 kernel: Detected PIPT I-cache on CPU0 Oct 28 13:15:31.687089 kernel: CPU features: detected: GIC system register CPU interface Oct 28 13:15:31.687095 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 28 13:15:31.687100 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 28 13:15:31.687106 kernel: CPU features: detected: Hardware dirty bit management Oct 28 13:15:31.687112 kernel: CPU features: detected: Spectre-v4 Oct 28 13:15:31.687118 kernel: CPU features: detected: ARM erratum 1418040 Oct 28 13:15:31.687124 kernel: CPU features: detected: Spectre-BHB Oct 28 13:15:31.687129 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 28 13:15:31.687135 kernel: Policy zone: DMA Oct 28 13:15:31.687142 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 28 13:15:31.687148 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 28 13:15:31.687154 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 28 13:15:31.687159 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 28 13:15:31.687165 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 28 13:15:31.687171 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 28 13:15:31.687177 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 28 13:15:31.687214 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 28 13:15:31.687221 kernel: rcu: RCU event tracing is enabled. Oct 28 13:15:31.687227 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 28 13:15:31.687233 kernel: Trampoline variant of Tasks RCU enabled. Oct 28 13:15:31.687239 kernel: Tracing variant of Tasks RCU enabled. Oct 28 13:15:31.687244 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 28 13:15:31.687256 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 28 13:15:31.687263 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 28 13:15:31.687268 kernel: GICv3: 256 SPIs implemented Oct 28 13:15:31.687274 kernel: GICv3: 0 Extended SPIs implemented Oct 28 13:15:31.687280 kernel: GICv3: Distributor has no Range Selector support Oct 28 13:15:31.687285 kernel: GICv3: 16 PPIs implemented Oct 28 13:15:31.687293 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 28 13:15:31.687298 kernel: ACPI: SRAT not present Oct 28 13:15:31.687304 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 28 13:15:31.687310 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 28 13:15:31.687316 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 28 13:15:31.687322 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 28 13:15:31.687327 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 28 13:15:31.687333 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:15:31.687339 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 28 13:15:31.687345 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 28 13:15:31.687351 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 28 13:15:31.687357 kernel: arm-pv: using stolen time PV Oct 28 13:15:31.687364 kernel: Console: colour dummy device 80x25 Oct 28 13:15:31.687369 kernel: ACPI: Core revision 20200925 Oct 28 13:15:31.687376 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 28 13:15:31.687381 kernel: pid_max: default: 32768 minimum: 301 Oct 28 13:15:31.687387 kernel: LSM: Security Framework initializing Oct 28 13:15:31.687393 kernel: SELinux: Initializing. Oct 28 13:15:31.687400 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 13:15:31.687405 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 13:15:31.687411 kernel: rcu: Hierarchical SRCU implementation. Oct 28 13:15:31.687418 kernel: Platform MSI: ITS@0x8080000 domain created Oct 28 13:15:31.687424 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 28 13:15:31.687430 kernel: Remapping and enabling EFI services. Oct 28 13:15:31.687436 kernel: smp: Bringing up secondary CPUs ... Oct 28 13:15:31.687442 kernel: Detected PIPT I-cache on CPU1 Oct 28 13:15:31.687448 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 28 13:15:31.687454 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 28 13:15:31.687460 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:15:31.687466 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 28 13:15:31.687472 kernel: Detected PIPT I-cache on CPU2 Oct 28 13:15:31.687479 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 28 13:15:31.687485 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 28 13:15:31.687491 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:15:31.687497 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 28 13:15:31.687503 kernel: Detected PIPT I-cache on CPU3 Oct 28 13:15:31.687512 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 28 13:15:31.687519 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 28 13:15:31.687526 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:15:31.687532 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 28 13:15:31.687538 kernel: smp: Brought up 1 node, 4 CPUs Oct 28 13:15:31.687544 kernel: SMP: Total of 4 processors activated. Oct 28 13:15:31.687551 kernel: CPU features: detected: Privileged Access Never Oct 28 13:15:31.687557 kernel: CPU features: detected: LSE atomic instructions Oct 28 13:15:31.687563 kernel: CPU features: detected: User Access Override Oct 28 13:15:31.687569 kernel: CPU features: detected: 32-bit EL0 Support Oct 28 13:15:31.687576 kernel: CPU features: detected: Common not Private translations Oct 28 13:15:31.687582 kernel: CPU features: detected: RAS Extension Support Oct 28 13:15:31.687589 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 28 13:15:31.687595 kernel: CPU features: detected: CRC32 instructions Oct 28 13:15:31.687602 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 28 13:15:31.687608 kernel: CPU: All CPU(s) started at EL1 Oct 28 13:15:31.687614 kernel: alternatives: patching kernel code Oct 28 13:15:31.687621 kernel: devtmpfs: initialized Oct 28 13:15:31.687627 kernel: KASLR enabled Oct 28 13:15:31.687633 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 28 13:15:31.687640 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 28 13:15:31.687646 kernel: pinctrl core: initialized pinctrl subsystem Oct 28 13:15:31.687652 kernel: SMBIOS 3.0.0 present. Oct 28 13:15:31.687658 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 28 13:15:31.687665 kernel: NET: Registered protocol family 16 Oct 28 13:15:31.687671 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 28 13:15:31.687677 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 28 13:15:31.687685 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 28 13:15:31.687691 kernel: audit: initializing netlink subsys (disabled) Oct 28 13:15:31.687697 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Oct 28 13:15:31.687704 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 28 13:15:31.687710 kernel: cpuidle: using governor menu Oct 28 13:15:31.687717 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 28 13:15:31.687723 kernel: ASID allocator initialised with 32768 entries Oct 28 13:15:31.687729 kernel: ACPI: bus type PCI registered Oct 28 13:15:31.687735 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 28 13:15:31.687743 kernel: Serial: AMBA PL011 UART driver Oct 28 13:15:31.687749 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 28 13:15:31.687756 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 28 13:15:31.687762 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 28 13:15:31.687768 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 28 13:15:31.687774 kernel: cryptd: max_cpu_qlen set to 1000 Oct 28 13:15:31.687781 kernel: ACPI: Added _OSI(Module Device) Oct 28 13:15:31.687787 kernel: ACPI: Added _OSI(Processor Device) Oct 28 13:15:31.687793 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 28 13:15:31.687801 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 28 13:15:31.687807 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 28 13:15:31.687813 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 28 13:15:31.687819 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 28 13:15:31.687826 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 28 13:15:31.687832 kernel: ACPI: Interpreter enabled Oct 28 13:15:31.687838 kernel: ACPI: Using GIC for interrupt routing Oct 28 13:15:31.687844 kernel: ACPI: MCFG table detected, 1 entries Oct 28 13:15:31.687850 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 28 13:15:31.687857 kernel: printk: console [ttyAMA0] enabled Oct 28 13:15:31.687864 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 28 13:15:31.687966 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 28 13:15:31.688024 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 28 13:15:31.688078 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 28 13:15:31.688131 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 28 13:15:31.688192 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 28 13:15:31.688201 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 28 13:15:31.688210 kernel: PCI host bridge to bus 0000:00 Oct 28 13:15:31.688278 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 28 13:15:31.688330 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 28 13:15:31.688379 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 28 13:15:31.688428 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 28 13:15:31.688494 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 28 13:15:31.688557 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 28 13:15:31.688618 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 28 13:15:31.688675 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 28 13:15:31.688735 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 13:15:31.688792 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 13:15:31.688849 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 28 13:15:31.688904 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 28 13:15:31.688954 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 28 13:15:31.689005 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 28 13:15:31.689055 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 28 13:15:31.689063 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 28 13:15:31.689069 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 28 13:15:31.689076 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 28 13:15:31.689082 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 28 13:15:31.689088 kernel: vgaarb: loaded Oct 28 13:15:31.689094 kernel: Registered efivars operations Oct 28 13:15:31.689100 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 28 13:15:31.689108 kernel: VFS: Disk quotas dquot_6.6.0 Oct 28 13:15:31.689114 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 28 13:15:31.689121 kernel: pnp: PnP ACPI init Oct 28 13:15:31.689180 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 28 13:15:31.689240 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 28 13:15:31.689249 kernel: pnp: PnP ACPI: found 1 devices Oct 28 13:15:31.689262 kernel: NET: Registered protocol family 2 Oct 28 13:15:31.689268 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 28 13:15:31.689276 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 28 13:15:31.689283 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 28 13:15:31.689289 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 28 13:15:31.689296 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 28 13:15:31.689302 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 13:15:31.689308 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 13:15:31.689315 kernel: NET: Registered protocol family 1 Oct 28 13:15:31.689321 kernel: PCI: CLS 0 bytes, default 64 Oct 28 13:15:31.689327 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 28 13:15:31.689334 kernel: kvm [1]: HYP mode not available Oct 28 13:15:31.689340 kernel: Initialise system trusted keyrings Oct 28 13:15:31.689347 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 28 13:15:31.689353 kernel: Key type asymmetric registered Oct 28 13:15:31.689359 kernel: Asymmetric key parser 'x509' registered Oct 28 13:15:31.689365 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 28 13:15:31.689371 kernel: io scheduler mq-deadline registered Oct 28 13:15:31.689378 kernel: io scheduler kyber registered Oct 28 13:15:31.689384 kernel: io scheduler bfq registered Oct 28 13:15:31.689391 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 28 13:15:31.689398 kernel: ACPI: Power Button [PWRB] Oct 28 13:15:31.689404 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 28 13:15:31.689464 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 28 13:15:31.689473 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 28 13:15:31.689479 kernel: msm_serial: driver initialized Oct 28 13:15:31.689485 kernel: random: fast init done Oct 28 13:15:31.689491 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 28 13:15:31.689498 kernel: random: crng init done Oct 28 13:15:31.689504 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 28 13:15:31.689512 kernel: thunder_xcv, ver 1.0 Oct 28 13:15:31.689518 kernel: thunder_bgx, ver 1.0 Oct 28 13:15:31.689524 kernel: nicpf, ver 1.0 Oct 28 13:15:31.689531 kernel: nicvf, ver 1.0 Oct 28 13:15:31.689600 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 28 13:15:31.689655 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-28T13:15:31 UTC (1761657331) Oct 28 13:15:31.689663 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 28 13:15:31.689670 kernel: NET: Registered protocol family 10 Oct 28 13:15:31.689677 kernel: Segment Routing with IPv6 Oct 28 13:15:31.689684 kernel: NET: Registered protocol family 17 Oct 28 13:15:31.689690 kernel: Key type dns_resolver registered Oct 28 13:15:31.689696 kernel: registered taskstats version 1 Oct 28 13:15:31.689702 kernel: Loading compiled-in X.509 certificates Oct 28 13:15:31.689709 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 28 13:15:31.689715 kernel: Key type ._fscrypt registered Oct 28 13:15:31.689721 kernel: Key type .fscrypt registered Oct 28 13:15:31.689728 kernel: Key type fscrypt-provisioning registered Oct 28 13:15:31.689735 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 28 13:15:31.689741 kernel: ima: Allocated hash algorithm: sha1 Oct 28 13:15:31.689747 kernel: ima: No architecture policies found Oct 28 13:15:31.689753 kernel: Freeing unused kernel memory: 34240K Oct 28 13:15:31.689760 kernel: Run /init as init process Oct 28 13:15:31.689766 kernel: with arguments: Oct 28 13:15:31.689772 kernel: /init Oct 28 13:15:31.689778 kernel: with environment: Oct 28 13:15:31.689784 kernel: HOME=/ Oct 28 13:15:31.689790 kernel: TERM=linux Oct 28 13:15:31.689797 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 28 13:15:31.689805 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 28 13:15:31.689813 systemd[1]: Detected virtualization kvm. Oct 28 13:15:31.689820 systemd[1]: Detected architecture arm64. Oct 28 13:15:31.689826 systemd[1]: Running in initial RAM disk. Oct 28 13:15:31.689833 systemd[1]: No hostname configured, using default hostname. Oct 28 13:15:31.689839 systemd[1]: Hostname set to . Oct 28 13:15:31.689847 systemd[1]: Initializing machine ID from VM UUID. Oct 28 13:15:31.689854 systemd[1]: Queued start job for default target Initrd Default Target. Oct 28 13:15:31.689860 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 13:15:31.689867 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 13:15:31.689873 systemd[1]: Reached target Path Units. Oct 28 13:15:31.689880 systemd[1]: Reached target Slice Units. Oct 28 13:15:31.689886 systemd[1]: Reached target Swaps. Oct 28 13:15:31.689893 systemd[1]: Reached target Timer Units. Oct 28 13:15:31.689900 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 28 13:15:31.689907 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 28 13:15:31.689914 systemd[1]: Listening on Journal Audit Socket. Oct 28 13:15:31.689921 systemd[1]: Listening on Journal Socket (/dev/log). Oct 28 13:15:31.689928 systemd[1]: Listening on Journal Socket. Oct 28 13:15:31.689935 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 13:15:31.689941 systemd[1]: Listening on udev Control Socket. Oct 28 13:15:31.689948 systemd[1]: Listening on udev Kernel Socket. Oct 28 13:15:31.689954 systemd[1]: Reached target Socket Units. Oct 28 13:15:31.689963 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 13:15:31.689970 systemd[1]: Finished Network Cleanup. Oct 28 13:15:31.689977 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 28 13:15:31.689983 systemd[1]: Starting Journal Service... Oct 28 13:15:31.689990 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 13:15:31.689997 systemd[1]: Starting Apply Kernel Variables... Oct 28 13:15:31.690004 systemd[1]: Starting Setup Virtual Console... Oct 28 13:15:31.690011 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 13:15:31.690017 systemd[1]: Finished Apply Kernel Variables. Oct 28 13:15:31.690025 systemd[1]: Finished Setup Virtual Console. Oct 28 13:15:31.690032 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 28 13:15:31.690039 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 13:15:31.690048 systemd-journald[279]: Journal started Oct 28 13:15:31.690085 systemd-journald[279]: Runtime Journal (/run/log/journal/fd7e443d971541c8942fa565c71b6154) is 6.0M, max 48.5M, 42.4M free. Oct 28 13:15:31.695310 systemd[1]: Started Journal Service. Oct 28 13:15:31.693264 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 13:15:31.702835 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 28 13:15:31.704449 systemd[1]: Starting dracut cmdline hook... Oct 28 13:15:31.712723 dracut-cmdline[296]: dracut-dracut-053 Oct 28 13:15:31.714895 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 28 13:15:31.769210 kernel: SCSI subsystem initialized Oct 28 13:15:31.773199 kernel: Loading iSCSI transport class v2.0-870. Oct 28 13:15:31.779217 kernel: iscsi: registered transport (tcp) Oct 28 13:15:31.790199 kernel: iscsi: registered transport (qla4xxx) Oct 28 13:15:31.790228 kernel: QLogic iSCSI HBA Driver Oct 28 13:15:31.799263 systemd[1]: Finished dracut cmdline hook. Oct 28 13:15:31.800653 systemd[1]: Starting dracut pre-udev hook... Oct 28 13:15:31.813790 kernel: device-mapper: uevent: version 1.0.3 Oct 28 13:15:31.813823 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 28 13:15:31.848213 kernel: raid6: neonx8 gen() 13731 MB/s Oct 28 13:15:31.865215 kernel: raid6: neonx8 xor() 10737 MB/s Oct 28 13:15:31.882214 kernel: raid6: neonx4 gen() 13602 MB/s Oct 28 13:15:31.899209 kernel: raid6: neonx4 xor() 11567 MB/s Oct 28 13:15:31.916205 kernel: raid6: neonx2 gen() 13004 MB/s Oct 28 13:15:31.933213 kernel: raid6: neonx2 xor() 9880 MB/s Oct 28 13:15:31.950204 kernel: raid6: neonx1 gen() 10901 MB/s Oct 28 13:15:31.967213 kernel: raid6: neonx1 xor() 8829 MB/s Oct 28 13:15:31.984207 kernel: raid6: int64x8 gen() 6811 MB/s Oct 28 13:15:32.001214 kernel: raid6: int64x8 xor() 3788 MB/s Oct 28 13:15:32.018214 kernel: raid6: int64x4 gen() 6897 MB/s Oct 28 13:15:32.035210 kernel: raid6: int64x4 xor() 3825 MB/s Oct 28 13:15:32.052206 kernel: raid6: int64x2 gen() 6178 MB/s Oct 28 13:15:32.069214 kernel: raid6: int64x2 xor() 3311 MB/s Oct 28 13:15:32.086217 kernel: raid6: int64x1 gen() 4999 MB/s Oct 28 13:15:32.103302 kernel: raid6: int64x1 xor() 2597 MB/s Oct 28 13:15:32.103324 kernel: raid6: using algorithm neonx8 gen() 13731 MB/s Oct 28 13:15:32.103340 kernel: raid6: .... xor() 10737 MB/s, rmw enabled Oct 28 13:15:32.104398 kernel: raid6: using neon recovery algorithm Oct 28 13:15:32.114692 kernel: xor: measuring software checksum speed Oct 28 13:15:32.114712 kernel: 8regs : 17188 MB/sec Oct 28 13:15:32.115719 kernel: 32regs : 20765 MB/sec Oct 28 13:15:32.116560 kernel: arm64_neon : 29059 MB/sec Oct 28 13:15:32.116571 kernel: xor: using function: arm64_neon (29059 MB/sec) Oct 28 13:15:32.161225 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 28 13:15:32.170822 systemd[1]: Finished dracut pre-udev hook. Oct 28 13:15:32.171000 audit: BPF prog-id=6 op=LOAD Oct 28 13:15:32.172000 audit: BPF prog-id=7 op=LOAD Oct 28 13:15:32.173835 kernel: audit: type=1334 audit(1761657332.171:2): prog-id=6 op=LOAD Oct 28 13:15:32.173855 kernel: audit: type=1334 audit(1761657332.172:3): prog-id=7 op=LOAD Oct 28 13:15:32.173864 kernel: audit: type=1334 audit(1761657332.173:4): prog-id=8 op=LOAD Oct 28 13:15:32.173000 audit: BPF prog-id=8 op=LOAD Oct 28 13:15:32.174155 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 13:15:32.185501 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 13:15:32.187703 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 13:15:32.189419 systemd[1]: Starting dracut pre-trigger hook... Oct 28 13:15:32.191339 systemd[1]: Starting Network Configuration... Oct 28 13:15:32.190000 audit: BPF prog-id=9 op=LOAD Oct 28 13:15:32.195224 kernel: audit: type=1334 audit(1761657332.190:5): prog-id=9 op=LOAD Oct 28 13:15:32.200509 dracut-pre-trigger[426]: rd.md=0: removing MD RAID activation Oct 28 13:15:32.211064 systemd-networkd[433]: lo: Link UP Oct 28 13:15:32.211072 systemd-networkd[433]: lo: Gained carrier Oct 28 13:15:32.211365 systemd-networkd[433]: Enumeration completed Oct 28 13:15:32.212270 systemd[1]: Started Network Configuration. Oct 28 13:15:32.213000 audit: BPF prog-id=10 op=LOAD Oct 28 13:15:32.214151 systemd[1]: Starting Network Name Resolution... Oct 28 13:15:32.216809 kernel: audit: type=1334 audit(1761657332.213:6): prog-id=10 op=LOAD Oct 28 13:15:32.230171 systemd[1]: Finished dracut pre-trigger hook. Oct 28 13:15:32.231431 systemd[1]: Starting Coldplug All udev Devices... Oct 28 13:15:32.240688 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 13:15:32.241722 systemd-resolved[456]: Positive Trust Anchors: Oct 28 13:15:32.241729 systemd-resolved[456]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 13:15:32.241756 systemd-resolved[456]: 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 28 13:15:32.242002 systemd-resolved[456]: Defaulting to hostname 'linux'. Oct 28 13:15:32.242948 systemd[1]: Started Network Name Resolution. Oct 28 13:15:32.243809 systemd[1]: Reached target Network. Oct 28 13:15:32.245722 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 13:15:32.258575 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 28 13:15:32.264122 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 28 13:15:32.265533 systemd[1]: Starting Open-iSCSI... Oct 28 13:15:32.267795 iscsid[490]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 28 13:15:32.267795 iscsid[490]: 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 28 13:15:32.267795 iscsid[490]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 28 13:15:32.267795 iscsid[490]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 28 13:15:32.267795 iscsid[490]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 28 13:15:32.267795 iscsid[490]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 28 13:15:32.271178 systemd[1]: Started Open-iSCSI. Oct 28 13:15:32.276612 systemd[1]: Finished Coldplug All udev Devices. Oct 28 13:15:32.278707 systemd[1]: Starting dracut initqueue hook... Oct 28 13:15:32.299326 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 28 13:15:32.299472 kernel: vda: detected capacity change from 0 to 4756340736 Oct 28 13:15:32.308094 systemd-udevd[473]: Using default interface naming scheme 'v249'. Oct 28 13:15:32.310208 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 13:15:32.312522 systemd-networkd[433]: eth0: Link UP Oct 28 13:15:32.327206 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (470) Oct 28 13:15:32.328384 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 28 13:15:32.329555 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 28 13:15:32.334888 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Oct 28 13:15:32.337572 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 28 13:15:32.340229 systemd[1]: Found device /dev/disk/by-label/OEM. Oct 28 13:15:32.344512 systemd[1]: Reached target Initrd Root Device. Oct 28 13:15:32.345898 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 28 13:15:32.347850 systemd[1]: Finished dracut initqueue hook. Oct 28 13:15:32.348752 systemd[1]: Reached target Preparation for Remote File Systems. Oct 28 13:15:32.350328 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 13:15:32.352075 systemd[1]: Reached target Remote File Systems. Oct 28 13:15:32.354408 systemd[1]: Starting dracut pre-mount hook... Oct 28 13:15:32.357198 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 13:15:32.363040 systemd[1]: Finished dracut pre-mount hook. Oct 28 13:15:33.329230 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 28 13:15:33.329370 systemd-networkd[433]: eth0: Gained carrier Oct 28 13:15:33.348521 systemd-networkd[433]: eth0: DHCPv4 address 10.0.0.4/16 via 10.0.0.1 Oct 28 13:15:33.363737 disk-uuid[510]: The operation has completed successfully. Oct 28 13:15:33.365069 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 13:15:33.383016 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 28 13:15:33.383139 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 28 13:15:33.384891 systemd[1]: Starting Ignition (setup)... Oct 28 13:15:33.393200 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 13:15:33.393227 kernel: BTRFS info (device vda6): has skinny extents Oct 28 13:15:33.398799 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 28 13:15:33.403981 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 28 13:15:33.404088 systemd[1]: Finished Ignition (setup). Oct 28 13:15:33.405464 systemd[1]: Starting Ignition (disks)... Oct 28 13:15:33.415264 ignition[548]: Ignition v0.36.1-15-gde4e6cc9 Oct 28 13:15:33.415280 ignition[548]: Stage: disks Oct 28 13:15:33.415289 ignition[548]: reading system config file "/usr/lib/ignition/base.ign" Oct 28 13:15:33.415299 ignition[548]: no config at "/usr/lib/ignition/base.ign" Oct 28 13:15:33.415340 ignition[548]: parsed url from cmdline: "" Oct 28 13:15:33.415343 ignition[548]: no config URL provided Oct 28 13:15:33.415348 ignition[548]: reading system config file "/usr/lib/ignition/user.ign" Oct 28 13:15:33.415354 ignition[548]: no config at "/usr/lib/ignition/user.ign" Oct 28 13:15:33.415372 ignition[548]: op(1): [started] loading QEMU firmware config module Oct 28 13:15:33.415377 ignition[548]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 28 13:15:33.416322 ignition[548]: op(1): [finished] loading QEMU firmware config module Oct 28 13:15:33.429704 ignition[548]: parsing config with SHA512: 0e791fa2f06da95475a552f79058c6e23456b23db29a8a3ed623a32966b851fafe2e6e7455b289ede93e1fcdb9b235cfdbe37e20772af687809cee8c6ff2c387 Oct 28 13:15:33.431528 ignition[548]: disks: disks passed Oct 28 13:15:33.431536 ignition[548]: Ignition finished successfully Oct 28 13:15:33.432397 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 28 13:15:33.432505 systemd[1]: Finished Ignition (disks). Oct 28 13:15:33.433750 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 13:15:33.435935 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 28 13:15:33.437456 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 28 13:15:33.445879 systemd-fsck[561]: ROOT: clean, 528/553792 files, 37752/553472 blocks Oct 28 13:15:33.448872 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 28 13:15:33.452094 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 28 13:15:33.451914 systemd[1]: Mounting /sysroot... Oct 28 13:15:33.469736 systemd[1]: Found device /dev/mapper/usr. Oct 28 13:15:33.471096 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 28 13:15:33.472180 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 28 13:15:33.479722 systemd-fsck[577]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 28 13:15:33.479722 systemd-fsck[577]: You must have r/w access to the filesystem or be root Oct 28 13:15:33.480833 systemd-fsck[573]: fsck failed with exit status 8. Oct 28 13:15:33.480844 systemd-fsck[573]: Ignoring error. Oct 28 13:15:33.483513 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 28 13:15:33.484981 systemd[1]: Mounting /sysusr/usr... Oct 28 13:15:33.500284 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 28 13:15:33.500318 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 28 13:15:33.500978 systemd[1]: Mounted /sysroot. Oct 28 13:15:33.501697 systemd[1]: Reached target Initrd Root File System. Oct 28 13:15:33.514208 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 28 13:15:33.514636 systemd[1]: Mounted /sysusr/usr. Oct 28 13:15:33.515301 systemd[1]: Reached target Local File Systems. Oct 28 13:15:33.516505 systemd[1]: Reached target System Initialization. Oct 28 13:15:33.517941 systemd[1]: Reached target Basic System. Oct 28 13:15:33.520251 systemd[1]: Mounting /sysroot/usr... Oct 28 13:15:33.522233 systemd[1]: Mounted /sysroot/usr. Oct 28 13:15:33.523453 systemd[1]: Starting Root filesystem setup... Oct 28 13:15:33.546567 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 28 13:15:33.546682 systemd[1]: Finished Root filesystem setup. Oct 28 13:15:33.548845 systemd[1]: Starting Ignition (files)... Oct 28 13:15:33.550021 systemd[1]: Starting /sysroot/boot... Oct 28 13:15:33.551993 ignition[593]: Ignition v0.36.1-15-gde4e6cc9 Oct 28 13:15:33.552013 ignition[593]: Stage: files Oct 28 13:15:33.552022 ignition[593]: reading system config file "/usr/lib/ignition/base.ign" Oct 28 13:15:33.552032 ignition[593]: no config at "/usr/lib/ignition/base.ign" Oct 28 13:15:33.552546 ignition[593]: files: compiled without relabeling support, skipping Oct 28 13:15:33.566231 systemd[1]: Finished /sysroot/boot. Oct 28 13:15:33.567753 ignition[593]: files: createUsers: op(1): [started] creating or modifying user "core" Oct 28 13:15:33.567769 ignition[593]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Oct 28 13:15:33.568867 ignition[593]: files: createUsers: op(1): [finished] creating or modifying user "core" Oct 28 13:15:33.568873 ignition[593]: files: createUsers: op(2): [started] adding ssh keys to user "core" Oct 28 13:15:33.569926 ignition[593]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Oct 28 13:15:33.571248 systemd[1]: ignition-files.service: Deactivated successfully. Oct 28 13:15:33.569944 ignition[593]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Oct 28 13:15:33.571346 systemd[1]: Finished Ignition (files). Oct 28 13:15:33.570228 ignition[593]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Oct 28 13:15:33.572616 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Oct 28 13:15:33.583236 kernel: audit: type=1334 audit(1761657333.580:7): prog-id=6 op=UNLOAD Oct 28 13:15:33.583263 kernel: audit: type=1334 audit(1761657333.580:8): prog-id=9 op=UNLOAD Oct 28 13:15:33.580000 audit: BPF prog-id=6 op=UNLOAD Oct 28 13:15:33.580000 audit: BPF prog-id=9 op=UNLOAD Oct 28 13:15:33.570235 ignition[593]: files: op(4): [started] processing unit "coreos-metadata.service" Oct 28 13:15:33.573162 systemd[1]: Starting Ignition (record completion)... Oct 28 13:15:33.570328 ignition[593]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 28 13:15:33.589877 kernel: audit: type=1334 audit(1761657333.586:9): prog-id=3 op=UNLOAD Oct 28 13:15:33.589894 kernel: audit: type=1334 audit(1761657333.586:10): prog-id=10 op=UNLOAD Oct 28 13:15:33.586000 audit: BPF prog-id=3 op=UNLOAD Oct 28 13:15:33.586000 audit: BPF prog-id=10 op=UNLOAD Oct 28 13:15:33.574645 systemd[1]: Starting Reload Configuration from the Real Root... Oct 28 13:15:33.570699 ignition[593]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 28 13:15:33.576053 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 28 13:15:33.570705 ignition[593]: files: op(4): [finished] processing unit "coreos-metadata.service" Oct 28 13:15:33.576158 systemd[1]: Finished Ignition (record completion). Oct 28 13:15:33.570709 ignition[593]: files: files passed Oct 28 13:15:33.579468 systemd[1]: Reloading. Oct 28 13:15:33.570712 ignition[593]: Ignition finished successfully Oct 28 13:15:33.664000 audit: BPF prog-id=11 op=LOAD Oct 28 13:15:33.664000 audit: BPF prog-id=12 op=LOAD Oct 28 13:15:33.664000 audit: BPF prog-id=13 op=LOAD Oct 28 13:15:33.664000 audit: BPF prog-id=7 op=UNLOAD Oct 28 13:15:33.664000 audit: BPF prog-id=8 op=UNLOAD Oct 28 13:15:33.665000 audit: BPF prog-id=14 op=LOAD Oct 28 13:15:33.665000 audit: BPF prog-id=15 op=LOAD Oct 28 13:15:33.665000 audit: BPF prog-id=16 op=LOAD Oct 28 13:15:33.665000 audit: BPF prog-id=17 op=LOAD Oct 28 13:15:33.665000 audit: BPF prog-id=4 op=UNLOAD Oct 28 13:15:33.665000 audit: BPF prog-id=5 op=UNLOAD Oct 28 13:15:33.666000 audit: BPF prog-id=18 op=LOAD Oct 28 13:15:33.679019 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 28 13:15:33.679125 systemd[1]: Finished Reload Configuration from the Real Root. Oct 28 13:15:33.680983 systemd[1]: Reached target Initrd File Systems. Oct 28 13:15:33.682428 systemd[1]: Reached target Initrd Default Target. Oct 28 13:15:33.683886 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 28 13:15:33.684503 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 28 13:15:33.694117 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 28 13:15:33.695668 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 28 13:15:33.701137 systemd[1]: Stopped target Host and Network Name Lookups. Oct 28 13:15:33.702199 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 13:15:33.703851 systemd[1]: Stopped target Timer Units. Oct 28 13:15:33.705229 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 28 13:15:33.705342 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 28 13:15:33.706687 systemd[1]: Stopped target Initrd Default Target. Oct 28 13:15:33.708213 systemd[1]: Stopped target Basic System. Oct 28 13:15:33.709626 systemd[1]: Stopped target Initrd Root Device. Oct 28 13:15:33.711038 systemd[1]: Stopped target Path Units. Oct 28 13:15:33.712303 systemd[1]: Stopped target Remote File Systems. Oct 28 13:15:33.713662 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 28 13:15:33.715157 systemd[1]: Stopped target Slice Units. Oct 28 13:15:33.716545 systemd[1]: Stopped target Socket Units. Oct 28 13:15:33.718001 systemd[1]: Stopped target System Initialization. Oct 28 13:15:33.719203 systemd[1]: Stopped target Local File Systems. Oct 28 13:15:33.720425 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 13:15:33.721957 systemd[1]: Stopped target Swaps. Oct 28 13:15:33.723169 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 28 13:15:33.723302 systemd[1]: Stopped dracut pre-mount hook. Oct 28 13:15:33.724773 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 13:15:33.726035 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 13:15:33.729214 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 13:15:33.730365 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 28 13:15:33.730457 systemd[1]: Stopped dracut initqueue hook. Oct 28 13:15:33.734072 iscsid[490]: iscsid shutting down. Oct 28 13:15:33.732253 systemd[1]: Stopping Open-iSCSI... Oct 28 13:15:33.734016 systemd[1]: Stopping /sysroot/boot... Oct 28 13:15:33.734700 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 28 13:15:33.734818 systemd[1]: Stopped Coldplug All udev Devices. Oct 28 13:15:33.736098 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 28 13:15:33.736175 systemd[1]: Stopped dracut pre-trigger hook. Oct 28 13:15:33.738279 systemd[1]: iscsid.service: Deactivated successfully. Oct 28 13:15:33.738392 systemd[1]: Stopped Open-iSCSI. Oct 28 13:15:33.740013 systemd[1]: iscsid.socket: Deactivated successfully. Oct 28 13:15:33.740073 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 28 13:15:33.741691 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 28 13:15:33.742948 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 28 13:15:33.743051 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 28 13:15:33.744679 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 28 13:15:33.744783 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 28 13:15:33.746864 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 28 13:15:33.746965 systemd[1]: Stopped /sysroot/boot. Oct 28 13:15:33.747994 systemd[1]: Stopped target Network. Oct 28 13:15:33.749252 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 28 13:15:33.749286 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 28 13:15:33.750726 systemd[1]: Stopping Network Name Resolution... Oct 28 13:15:33.756467 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 28 13:15:33.756574 systemd[1]: Stopped Network Name Resolution. Oct 28 13:15:33.757882 systemd[1]: Stopping Network Configuration... Oct 28 13:15:33.761319 systemd-networkd[433]: eth0: DHCP lease lost Oct 28 13:15:33.767000 audit: BPF prog-id=18 op=UNLOAD Oct 28 13:15:33.772289 systemd-networkd[433]: eth0: DHCPv6 lease lost Oct 28 13:15:33.773606 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 28 13:15:33.773752 systemd[1]: Stopped Network Configuration. Oct 28 13:15:33.775579 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 28 13:15:33.775607 systemd[1]: Closed Network Service Netlink Socket. Oct 28 13:15:33.777453 systemd[1]: Stopping Network Cleanup... Oct 28 13:15:33.778388 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 13:15:33.778446 systemd[1]: Stopped Apply Kernel Variables. Oct 28 13:15:33.783000 audit: BPF prog-id=14 op=UNLOAD Oct 28 13:15:33.781179 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 28 13:15:33.786083 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 28 13:15:33.786214 systemd[1]: Stopped Network Cleanup. Oct 28 13:15:33.788621 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 28 13:15:33.788729 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 28 13:15:33.790131 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 28 13:15:33.790165 systemd[1]: Closed udev Control Socket. Oct 28 13:15:33.791525 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 28 13:15:33.791558 systemd[1]: Closed udev Kernel Socket. Oct 28 13:15:33.792948 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 28 13:15:33.792987 systemd[1]: Stopped dracut pre-udev hook. Oct 28 13:15:33.794566 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 28 13:15:33.794606 systemd[1]: Stopped dracut cmdline hook. Oct 28 13:15:33.803000 audit: BPF prog-id=11 op=UNLOAD Oct 28 13:15:33.795966 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 28 13:15:33.796004 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 28 13:15:33.798317 systemd[1]: Starting Cleanup udev Database... Oct 28 13:15:33.799147 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 28 13:15:33.800617 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 13:15:33.800675 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 13:15:33.802081 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 28 13:15:33.802122 systemd[1]: Stopped Create List of Static Device Nodes. Oct 28 13:15:33.803895 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 13:15:33.803936 systemd[1]: Stopped Setup Virtual Console. Oct 28 13:15:33.805388 systemd[1]: rngd.service: Deactivated successfully. Oct 28 13:15:33.816000 audit: BPF prog-id=15 op=UNLOAD Oct 28 13:15:33.805490 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 28 13:15:33.807052 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 28 13:15:33.807145 systemd[1]: Finished Cleanup udev Database. Oct 28 13:15:33.808551 systemd[1]: Reached target Switch Root. Oct 28 13:15:33.810321 systemd[1]: Starting Switch Root... Oct 28 13:15:33.814887 systemd[1]: Switching root. Oct 28 13:15:33.840043 systemd-journald[279]: Journal stopped Oct 28 13:15:35.991223 systemd-journald[279]: Received SIGTERM from PID 1 (systemd). Oct 28 13:15:35.991283 kernel: SELinux: policy capability network_peer_controls=1 Oct 28 13:15:35.991295 kernel: SELinux: policy capability open_perms=1 Oct 28 13:15:35.991305 kernel: SELinux: policy capability extended_socket_class=1 Oct 28 13:15:35.991314 kernel: SELinux: policy capability always_check_network=0 Oct 28 13:15:35.991323 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 28 13:15:35.991331 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 28 13:15:35.991344 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 28 13:15:35.991353 systemd[1]: Successfully loaded SELinux policy in 32.929ms. Oct 28 13:15:35.991367 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.152ms. Oct 28 13:15:35.991382 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 28 13:15:35.991392 systemd[1]: Detected virtualization kvm. Oct 28 13:15:35.991401 systemd[1]: Detected architecture arm64. Oct 28 13:15:35.991411 systemd[1]: Detected first boot. Oct 28 13:15:35.991420 systemd[1]: Initializing machine ID from VM UUID. Oct 28 13:15:35.991430 systemd[1]: Populated /etc with preset unit settings. Oct 28 13:15:35.991441 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 28 13:15:35.991453 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 28 13:15:35.991463 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 28 13:15:35.991472 systemd[1]: Stopped Switch Root. Oct 28 13:15:35.991482 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 28 13:15:35.991492 systemd[1]: Created slice Slice /system/addon-config. Oct 28 13:15:35.991502 systemd[1]: Created slice Slice /system/addon-run. Oct 28 13:15:35.991511 systemd[1]: Created slice Slice /system/getty. Oct 28 13:15:35.991520 systemd[1]: Created slice Slice /system/modprobe. Oct 28 13:15:35.991530 systemd[1]: Created slice Slice /system/serial-getty. Oct 28 13:15:35.991541 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 28 13:15:35.991550 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 28 13:15:35.991560 systemd[1]: Created slice User and Session Slice. Oct 28 13:15:35.991569 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 13:15:35.991579 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 28 13:15:35.991588 systemd[1]: Set up automount Boot partition Automount Point. Oct 28 13:15:35.991598 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 28 13:15:35.991607 systemd[1]: Stopped target Switch Root. Oct 28 13:15:35.991617 systemd[1]: Stopped target Initrd File Systems. Oct 28 13:15:35.991627 systemd[1]: Stopped target Initrd Root File System. Oct 28 13:15:35.991637 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 13:15:35.991646 systemd[1]: Reached target Remote File Systems. Oct 28 13:15:35.991656 systemd[1]: Reached target Slice Units. Oct 28 13:15:35.991667 systemd[1]: Reached target Swaps. Oct 28 13:15:35.991680 systemd[1]: Reached target Verify torcx succeeded. Oct 28 13:15:35.991690 systemd[1]: Reached target Local Verity Protected Volumes. Oct 28 13:15:35.991699 systemd[1]: Listening on Process Core Dump Socket. Oct 28 13:15:35.991708 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 28 13:15:35.991718 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 13:15:35.991728 systemd[1]: Listening on udev Control Socket. Oct 28 13:15:35.991738 systemd[1]: Listening on udev Kernel Socket. Oct 28 13:15:35.991747 systemd[1]: Mounting Huge Pages File System... Oct 28 13:15:35.991757 systemd[1]: Mounting POSIX Message Queue File System... Oct 28 13:15:35.991766 systemd[1]: Mounting External Media Directory... Oct 28 13:15:35.991775 systemd[1]: Mounting Kernel Debug File System... Oct 28 13:15:35.991784 systemd[1]: Mounting Kernel Trace File System... Oct 28 13:15:35.991794 systemd[1]: Mounting Temporary Directory /tmp... Oct 28 13:15:35.991803 systemd[1]: Starting Create missing system files... Oct 28 13:15:35.991813 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 13:15:35.991823 systemd[1]: Starting Load Kernel Module configfs... Oct 28 13:15:35.991833 systemd[1]: Starting Load Kernel Module drm... Oct 28 13:15:35.991843 systemd[1]: Starting Load Kernel Module fuse... Oct 28 13:15:35.991852 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 28 13:15:35.991861 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 28 13:15:35.991871 systemd[1]: Stopped File System Check on Root Device. Oct 28 13:15:35.991880 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 28 13:15:35.991890 systemd[1]: Stopped systemd-fsck-usr.service. Oct 28 13:15:35.991899 kernel: fuse: init (API version 7.32) Oct 28 13:15:35.991909 systemd[1]: Stopped Journal Service. Oct 28 13:15:35.991918 kernel: kauditd_printk_skb: 30 callbacks suppressed Oct 28 13:15:35.991927 kernel: audit: type=1334 audit(1761657335.974:41): prog-id=24 op=LOAD Oct 28 13:15:35.991936 kernel: audit: type=1334 audit(1761657335.976:42): prog-id=25 op=LOAD Oct 28 13:15:35.991944 kernel: audit: type=1334 audit(1761657335.977:43): prog-id=26 op=LOAD Oct 28 13:15:35.991954 systemd[1]: Starting Journal Service... Oct 28 13:15:35.991963 kernel: audit: type=1334 audit(1761657335.977:44): prog-id=22 op=UNLOAD Oct 28 13:15:35.991971 kernel: audit: type=1334 audit(1761657335.977:45): prog-id=23 op=UNLOAD Oct 28 13:15:35.991980 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 13:15:35.991991 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 28 13:15:35.992000 systemd[1]: Starting Apply Kernel Variables... Oct 28 13:15:35.992010 systemd[1]: Starting Coldplug All udev Devices... Oct 28 13:15:35.992020 systemd[1]: verity-setup.service: Deactivated successfully. Oct 28 13:15:35.992030 kernel: audit: type=1305 audit(1761657335.990:46): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 28 13:15:35.992039 systemd[1]: Stopped verity-setup.service. Oct 28 13:15:35.992049 systemd-journald[808]: Journal started Oct 28 13:15:35.992081 systemd-journald[808]: Runtime Journal (/run/log/journal/fd7e443d971541c8942fa565c71b6154) is 6.0M, max 48.5M, 42.4M free. Oct 28 13:15:33.903000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 28 13:15:33.933000 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 28 13:15:33.933000 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 28 13:15:33.933000 audit: BPF prog-id=19 op=LOAD Oct 28 13:15:33.933000 audit: BPF prog-id=19 op=UNLOAD Oct 28 13:15:33.933000 audit: BPF prog-id=20 op=LOAD Oct 28 13:15:33.933000 audit: BPF prog-id=20 op=UNLOAD Oct 28 13:15:33.966000 audit[758]: AVC avc: denied { associate } for pid=758 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 28 13:15:35.858000 audit: BPF prog-id=21 op=LOAD Oct 28 13:15:35.858000 audit: BPF prog-id=22 op=LOAD Oct 28 13:15:35.858000 audit: BPF prog-id=23 op=LOAD Oct 28 13:15:35.858000 audit: BPF prog-id=16 op=UNLOAD Oct 28 13:15:35.858000 audit: BPF prog-id=17 op=UNLOAD Oct 28 13:15:35.872000 audit: BPF prog-id=21 op=UNLOAD Oct 28 13:15:35.974000 audit: BPF prog-id=24 op=LOAD Oct 28 13:15:35.976000 audit: BPF prog-id=25 op=LOAD Oct 28 13:15:35.977000 audit: BPF prog-id=26 op=LOAD Oct 28 13:15:35.977000 audit: BPF prog-id=22 op=UNLOAD Oct 28 13:15:35.977000 audit: BPF prog-id=23 op=UNLOAD Oct 28 13:15:35.990000 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 28 13:15:35.843495 systemd[1]: Queued start job for default target Multi-User System. Oct 28 13:15:33.965202 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" 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 28 13:15:35.859703 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 28 13:15:33.965448 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 13:15:33.965466 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 13:15:33.965565 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 28 13:15:33.965576 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 28 13:15:33.965604 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 28 13:15:33.965616 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 28 13:15:33.965789 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 28 13:15:33.965821 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 13:15:33.965839 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 13:15:33.966171 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" 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 28 13:15:33.966212 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" 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 28 13:15:33.966232 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" 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 28 13:15:33.966255 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 28 13:15:33.966274 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" 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 28 13:15:33.966288 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:33Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 28 13:15:35.677736 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:35Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 13:15:35.677997 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:35Z" 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 28 13:15:35.678110 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:35Z" 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 28 13:15:35.678265 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:35Z" 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 28 13:15:35.678318 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:35Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 28 13:15:35.678376 /usr/lib/systemd/system-generators/torcx-generator[758]: time="2025-10-28T13:15:35Z" 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 28 13:15:35.996883 systemd[1]: Started Journal Service. Oct 28 13:15:35.997298 systemd[1]: Mounted Huge Pages File System. Oct 28 13:15:35.998146 systemd[1]: Mounted POSIX Message Queue File System. Oct 28 13:15:35.999146 systemd[1]: Mounted External Media Directory. Oct 28 13:15:36.000064 systemd[1]: Mounted Kernel Debug File System. Oct 28 13:15:36.000978 systemd[1]: Mounted Kernel Trace File System. Oct 28 13:15:36.001880 systemd[1]: Mounted Temporary Directory /tmp. Oct 28 13:15:36.002965 systemd[1]: Finished Create missing system files. Oct 28 13:15:36.004126 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 13:15:36.005281 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 28 13:15:36.005445 systemd[1]: Finished Load Kernel Module configfs. Oct 28 13:15:36.006442 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 13:15:36.006611 systemd[1]: Finished Load Kernel Module drm. Oct 28 13:15:36.007580 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 28 13:15:36.007756 systemd[1]: Finished Load Kernel Module fuse. Oct 28 13:15:36.008849 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 28 13:15:36.010065 systemd[1]: Finished Apply Kernel Variables. Oct 28 13:15:36.031020 systemd[1]: Mounting FUSE Control File System... Oct 28 13:15:36.032943 systemd[1]: Mounting Kernel Configuration File System... Oct 28 13:15:36.033806 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 28 13:15:36.035066 systemd[1]: Starting Rebuild Hardware Database... Oct 28 13:15:36.036821 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 28 13:15:36.037831 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 28 13:15:36.038694 systemd[1]: Starting Load/Save Random Seed... Oct 28 13:15:36.040760 systemd-journald[808]: Time spent on flushing to /var/log/journal/fd7e443d971541c8942fa565c71b6154 is 8.523ms for 767 entries. Oct 28 13:15:36.040760 systemd-journald[808]: System Journal (/var/log/journal/fd7e443d971541c8942fa565c71b6154) is 8.0M, max 203.0M, 195.0M free. Oct 28 13:15:36.040454 systemd[1]: Starting Create System Users... Oct 28 13:15:36.044927 systemd[1]: Mounted FUSE Control File System. Oct 28 13:15:36.045887 systemd[1]: Mounted Kernel Configuration File System. Oct 28 13:15:36.049068 systemd[1]: Finished Coldplug All udev Devices. Oct 28 13:15:36.050296 systemd[1]: Finished Load/Save Random Seed. Oct 28 13:15:36.051287 systemd[1]: Reached target First Boot Complete. Oct 28 13:15:36.056250 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 28 13:15:36.058471 systemd-sysusers[819]: Creating group sgx with gid 999. Oct 28 13:15:36.059438 systemd-sysusers[819]: Creating group systemd-oom with gid 998. Oct 28 13:15:36.060354 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 28 13:15:36.060894 systemd-sysusers[819]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Oct 28 13:15:36.061973 systemd-sysusers[819]: Creating group systemd-timesync with gid 997. Oct 28 13:15:36.062488 systemd-sysusers[819]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Oct 28 13:15:36.063118 systemd-sysusers[819]: Creating group systemd-coredump with gid 996. Oct 28 13:15:36.063654 systemd-sysusers[819]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Oct 28 13:15:36.071890 systemd[1]: Finished Create System Users. Oct 28 13:15:36.081102 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 13:15:36.092732 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 13:15:36.268120 systemd[1]: Finished Rebuild Hardware Database. Oct 28 13:15:36.290209 kernel: audit: type=1334 audit(1761657336.287:47): prog-id=27 op=LOAD Oct 28 13:15:36.290286 kernel: audit: type=1334 audit(1761657336.288:48): prog-id=28 op=LOAD Oct 28 13:15:36.290305 kernel: audit: type=1334 audit(1761657336.289:49): prog-id=29 op=LOAD Oct 28 13:15:36.287000 audit: BPF prog-id=27 op=LOAD Oct 28 13:15:36.288000 audit: BPF prog-id=28 op=LOAD Oct 28 13:15:36.290391 kernel: audit: type=1334 audit(1761657336.289:50): prog-id=12 op=UNLOAD Oct 28 13:15:36.289000 audit: BPF prog-id=29 op=LOAD Oct 28 13:15:36.289000 audit: BPF prog-id=12 op=UNLOAD Oct 28 13:15:36.289000 audit: BPF prog-id=13 op=UNLOAD Oct 28 13:15:36.290160 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 13:15:36.312837 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 13:15:36.320000 audit: BPF prog-id=30 op=LOAD Oct 28 13:15:36.321328 systemd[1]: Starting Network Configuration... Oct 28 13:15:36.344438 systemd-udevd[843]: Using default interface naming scheme 'v249'. Oct 28 13:15:36.349602 systemd-networkd[844]: lo: Link UP Oct 28 13:15:36.349614 systemd-networkd[844]: lo: Gained carrier Oct 28 13:15:36.349903 systemd-networkd[844]: Enumeration completed Oct 28 13:15:36.349987 systemd[1]: Started Network Configuration. Oct 28 13:15:36.351100 systemd-networkd[844]: eth0: Link UP Oct 28 13:15:36.357264 systemd-networkd[844]: eth0: Gained carrier Oct 28 13:15:36.363334 systemd-networkd[844]: eth0: DHCPv4 address 10.0.0.4/16 via 10.0.0.1 Oct 28 13:15:36.369478 udevadm[822]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 28 13:15:36.390283 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 28 13:15:36.401055 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 13:15:36.408473 lvm[852]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 13:15:36.443054 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 13:15:36.444553 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 13:15:36.464940 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 13:15:36.468658 lvm[853]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 13:15:36.495827 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 13:15:36.497311 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 13:15:36.498439 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 28 13:15:36.498462 systemd[1]: Reached target Containers. Oct 28 13:15:36.513156 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 28 13:15:36.523977 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 28 13:15:36.526065 systemd[1]: Mounting /usr/share/oem... Oct 28 13:15:36.531558 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 13:15:36.531601 kernel: BTRFS info (device vda6): has skinny extents Oct 28 13:15:36.533789 systemd[1]: Mounted /usr/share/oem. Oct 28 13:15:36.534602 systemd[1]: Reached target Local File Systems. Oct 28 13:15:36.536374 systemd[1]: Starting Rebuild Dynamic Linker Cache... Oct 28 13:15:36.537486 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 28 13:15:36.537526 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 28 13:15:36.538595 systemd[1]: Starting Commit a transient machine-id on disk... Oct 28 13:15:36.540627 systemd[1]: Starting Create Volatile Files and Directories... Oct 28 13:15:36.547509 systemd-tmpfiles[878]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 28 13:15:36.549096 systemd-tmpfiles[878]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 28 13:15:36.553379 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 28 13:15:36.553896 systemd[1]: Finished Commit a transient machine-id on disk. Oct 28 13:15:36.581656 systemd-tmpfiles[878]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 13:15:36.581668 systemd-tmpfiles[878]: Skipping /boot Oct 28 13:15:36.588294 systemd-tmpfiles[878]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 13:15:36.588329 systemd-tmpfiles[878]: Skipping /boot Oct 28 13:15:36.610853 systemd[1]: Finished Rebuild Dynamic Linker Cache. Oct 28 13:15:36.626624 systemd[1]: Finished Create Volatile Files and Directories. Oct 28 13:15:36.628719 systemd[1]: Starting Load Security Auditing Rules... Oct 28 13:15:36.630565 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 28 13:15:36.633000 audit: BPF prog-id=31 op=LOAD Oct 28 13:15:36.632680 systemd[1]: Starting Rebuild Journal Catalog... Oct 28 13:15:36.636000 audit: BPF prog-id=32 op=LOAD Oct 28 13:15:36.635053 systemd[1]: Starting Network Name Resolution... Oct 28 13:15:36.637311 systemd[1]: Starting Network Time Synchronization... Oct 28 13:15:36.639290 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 28 13:15:36.640875 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 28 13:15:36.642336 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 28 13:15:36.644613 systemd[1]: Finished Rebuild Journal Catalog. Oct 28 13:15:36.646535 systemd[1]: Starting Update is Completed... Oct 28 13:15:36.648564 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 28 13:15:36.650755 systemd[1]: Finished Update is Completed. Oct 28 13:15:36.658000 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 28 13:15:36.658914 augenrules[900]: No rules Oct 28 13:15:36.659743 systemd[1]: Finished Load Security Auditing Rules. Oct 28 13:15:36.677015 systemd-resolved[885]: Positive Trust Anchors: Oct 28 13:15:36.677025 systemd-resolved[885]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 13:15:36.677053 systemd-resolved[885]: 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 28 13:15:36.677843 systemd-resolved[885]: Defaulting to hostname 'linux'. Oct 28 13:15:36.679235 systemd[1]: Started Network Time Synchronization. Oct 28 13:15:36.679874 systemd-timesyncd[889]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 28 13:15:36.680326 systemd[1]: Started Network Name Resolution. Oct 28 13:15:36.681225 systemd[1]: Reached target Network. Oct 28 13:15:36.681928 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 13:15:36.682921 systemd[1]: Reached target System Initialization. Oct 28 13:15:36.683870 systemd[1]: Started Watch for update engine configuration changes. Oct 28 13:15:36.685015 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 13:15:36.686204 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 28 13:15:36.687159 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 28 13:15:36.687209 systemd[1]: Reached target Path Units. Oct 28 13:15:36.687950 systemd[1]: Reached target System Time Set. Oct 28 13:15:36.688930 systemd[1]: Started Daily Log Rotation. Oct 28 13:15:36.689857 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 28 13:15:36.691007 systemd[1]: Reached target Timer Units. Oct 28 13:15:36.692125 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 28 13:15:36.705886 systemd[1]: Starting Docker Socket for the API... Oct 28 13:15:36.709543 systemd[1]: Listening on OpenSSH Server Socket. Oct 28 13:15:36.710887 systemd[1]: Listening on Docker Socket for the API. Oct 28 13:15:36.711906 systemd[1]: Reached target Socket Units. Oct 28 13:15:36.712746 systemd[1]: Reached target Basic System. Oct 28 13:15:36.713604 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 28 13:15:36.713633 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 28 13:15:36.714607 systemd[1]: Started D-Bus System Message Bus. Oct 28 13:15:36.717702 systemd[1]: Starting Extend Filesystems... Oct 28 13:15:36.718539 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 28 13:15:36.719454 systemd[1]: Starting Generate /run/flatcar/motd... Oct 28 13:15:36.721112 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 28 13:15:36.723327 systemd[1]: Starting Generate sshd host keys... Oct 28 13:15:36.724542 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 28 13:15:36.724578 systemd[1]: Reached target Load system-provided cloud configs. Oct 28 13:15:36.726148 extend-filesystems[909]: Found vda Oct 28 13:15:36.727433 extend-filesystems[909]: Found vda1 Oct 28 13:15:36.727433 extend-filesystems[909]: Found vda2 Oct 28 13:15:36.727433 extend-filesystems[909]: Found vda3 Oct 28 13:15:36.727433 extend-filesystems[909]: Found usr Oct 28 13:15:36.727433 extend-filesystems[909]: Found vda4 Oct 28 13:15:36.727433 extend-filesystems[909]: Found vda6 Oct 28 13:15:36.727433 extend-filesystems[909]: Found vda7 Oct 28 13:15:36.727433 extend-filesystems[909]: Found vda9 Oct 28 13:15:36.727433 extend-filesystems[909]: Checking size of /dev/vda9 Oct 28 13:15:36.728132 systemd[1]: Starting User Login Management... Oct 28 13:15:36.729279 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 28 13:15:36.731566 systemd[1]: Starting Update Engine... Oct 28 13:15:36.732848 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 28 13:15:36.732875 systemd[1]: Reached target Load user-provided cloud configs. Oct 28 13:15:36.734843 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 28 13:15:36.735062 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 28 13:15:36.738488 systemd[1]: motdgen.service: Deactivated successfully. Oct 28 13:15:36.738696 systemd[1]: Finished Generate /run/flatcar/motd. Oct 28 13:15:36.753244 extend-filesystems[909]: Old size kept for /dev/vda9 Oct 28 13:15:36.755007 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 28 13:15:36.755266 systemd[1]: Finished Extend Filesystems. Oct 28 13:15:36.757161 systemd-logind[924]: Watching system buttons on /dev/input/event0 (Power Button) Oct 28 13:15:36.757338 systemd-logind[924]: New seat seat0. Oct 28 13:15:36.759831 systemd[1]: Started User Login Management. Oct 28 13:15:36.770166 update_engine[925]: I1028 13:15:36.769927 925 main.cc:89] Flatcar Update Engine starting Oct 28 13:15:36.772724 systemd[1]: Started Update Engine. Oct 28 13:15:36.773282 update_engine[925]: I1028 13:15:36.772737 925 update_check_scheduler.cc:74] Next update check in 3m57s Oct 28 13:15:36.779486 systemd[1]: Started Cluster reboot manager. Oct 28 13:15:36.805311 locksmithd[932]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 28 13:15:37.230245 sshd_keygen[927]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Oct 28 13:15:37.247152 systemd[1]: Finished Generate sshd host keys. Oct 28 13:15:37.263928 systemd[1]: Starting Generate /run/issue... Oct 28 13:15:37.268447 systemd[1]: issuegen.service: Deactivated successfully. Oct 28 13:15:37.268660 systemd[1]: Finished Generate /run/issue. Oct 28 13:15:37.270625 systemd[1]: Starting Permit User Sessions... Oct 28 13:15:37.274517 systemd[1]: Finished Permit User Sessions. Oct 28 13:15:37.276458 systemd[1]: Started Getty on tty1. Oct 28 13:15:37.278221 systemd[1]: Started Serial Getty on ttyAMA0. Oct 28 13:15:37.279219 systemd[1]: Reached target Login Prompts. Oct 28 13:15:37.280122 systemd[1]: Reached target Multi-User System. Oct 28 13:15:37.282041 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 28 13:15:37.286549 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 28 13:15:37.286759 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 28 13:15:37.287908 systemd[1]: Startup finished in 703ms (kernel) + 2.301s (initrd) + 3.418s (userspace) = 6.423s. Oct 28 13:15:37.487641 systemd-networkd[844]: eth0: Gained IPv6LL Oct 28 13:15:43.349293 systemd[1]: Created slice Slice /system/sshd. Oct 28 13:15:43.350479 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39720). Oct 28 13:15:43.399567 sshd[953]: Accepted publickey for core from 10.0.0.1 port 39720 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:43.401426 sshd[953]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:43.417018 systemd[1]: Created slice User Slice of UID 500. Oct 28 13:15:43.418100 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 28 13:15:43.419710 systemd-logind[924]: New session 1 of user core. Oct 28 13:15:43.423739 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 28 13:15:43.424749 systemd[1]: Starting User Manager for UID 500... Oct 28 13:15:43.426717 systemd[956]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:43.473661 systemd[956]: Queued start job for default target Main User Target. Oct 28 13:15:43.473792 systemd[956]: Reached target Paths. Oct 28 13:15:43.473806 systemd[956]: Reached target Sockets. Oct 28 13:15:43.473816 systemd[956]: Reached target Timers. Oct 28 13:15:43.473826 systemd[956]: Reached target Basic System. Oct 28 13:15:43.473861 systemd[956]: Reached target Main User Target. Oct 28 13:15:43.473872 systemd[956]: Startup finished in 43ms. Oct 28 13:15:43.474265 systemd[1]: Started User Manager for UID 500. Oct 28 13:15:43.486957 systemd[1]: Started Session 1 of User core. Oct 28 13:15:43.551518 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39736). Oct 28 13:15:43.589393 sshd[965]: Accepted publickey for core from 10.0.0.1 port 39736 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:43.590229 sshd[965]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:43.592556 systemd-logind[924]: New session 2 of user core. Oct 28 13:15:43.601001 systemd[1]: Started Session 2 of User core. Oct 28 13:15:43.653981 sshd[965]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:43.661943 systemd[1]: sshd@1-10.0.0.4:22-10.0.0.1:39736.service: Deactivated successfully. Oct 28 13:15:43.662443 systemd[1]: session-2.scope: Deactivated successfully. Oct 28 13:15:43.662988 systemd-logind[924]: Session 2 logged out. Waiting for processes to exit. Oct 28 13:15:43.663876 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39742). Oct 28 13:15:43.664528 systemd-logind[924]: Removed session 2. Oct 28 13:15:43.702211 sshd[971]: Accepted publickey for core from 10.0.0.1 port 39742 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:43.703746 sshd[971]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:43.706140 systemd-logind[924]: New session 3 of user core. Oct 28 13:15:43.721483 systemd[1]: Started Session 3 of User core. Oct 28 13:15:43.773127 sshd[971]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:43.784681 systemd[1]: sshd@2-10.0.0.4:22-10.0.0.1:39742.service: Deactivated successfully. Oct 28 13:15:43.785161 systemd[1]: session-3.scope: Deactivated successfully. Oct 28 13:15:43.785775 systemd-logind[924]: Session 3 logged out. Waiting for processes to exit. Oct 28 13:15:43.786653 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39758). Oct 28 13:15:43.787331 systemd-logind[924]: Removed session 3. Oct 28 13:15:43.823635 sshd[978]: Accepted publickey for core from 10.0.0.1 port 39758 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:43.824639 sshd[978]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:43.826855 systemd-logind[924]: New session 4 of user core. Oct 28 13:15:43.840321 systemd[1]: Started Session 4 of User core. Oct 28 13:15:43.891720 sshd[978]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:43.903485 systemd[1]: sshd@3-10.0.0.4:22-10.0.0.1:39758.service: Deactivated successfully. Oct 28 13:15:43.903968 systemd[1]: session-4.scope: Deactivated successfully. Oct 28 13:15:43.904543 systemd-logind[924]: Session 4 logged out. Waiting for processes to exit. Oct 28 13:15:43.905426 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39762). Oct 28 13:15:43.906056 systemd-logind[924]: Removed session 4. Oct 28 13:15:43.941768 sshd[984]: Accepted publickey for core from 10.0.0.1 port 39762 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:43.942557 sshd[984]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:43.944957 systemd-logind[924]: New session 5 of user core. Oct 28 13:15:43.957027 systemd[1]: Started Session 5 of User core. Oct 28 13:15:44.012417 sudo[987]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 28 13:15:44.012617 sudo[987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:15:44.023478 sudo[987]: pam_unix(sudo:session): session closed for user root Oct 28 13:15:44.026138 sshd[984]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:44.037585 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39766). Oct 28 13:15:44.039810 dbus-daemon[908]: [system] Reloaded configuration Oct 28 13:15:44.042392 systemd[1]: sshd@4-10.0.0.4:22-10.0.0.1:39762.service: Deactivated successfully. Oct 28 13:15:44.042934 systemd[1]: session-5.scope: Deactivated successfully. Oct 28 13:15:44.043624 systemd-logind[924]: Session 5 logged out. Waiting for processes to exit. Oct 28 13:15:44.044396 systemd-logind[924]: Removed session 5. Oct 28 13:15:44.075085 sshd[990]: Accepted publickey for core from 10.0.0.1 port 39766 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:44.076200 sshd[990]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:44.078459 systemd-logind[924]: New session 6 of user core. Oct 28 13:15:44.087533 systemd[1]: Started Session 6 of User core. Oct 28 13:15:44.138881 sudo[995]: 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 28 13:15:44.139086 sudo[995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:15:44.141028 sudo[995]: pam_unix(sudo:session): session closed for user root Oct 28 13:15:44.144329 sudo[994]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 28 13:15:44.144630 sudo[994]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:15:44.160936 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 13:15:44.160000 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 28 13:15:44.161959 auditctl[998]: No rules Oct 28 13:15:44.162174 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 13:15:44.162394 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 13:15:44.162557 kernel: kauditd_printk_skb: 5 callbacks suppressed Oct 28 13:15:44.162586 kernel: audit: type=1305 audit(1761657344.160:56): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 28 13:15:44.163504 systemd[1]: Starting Load Security Auditing Rules... Oct 28 13:15:44.176854 augenrules[1015]: No rules Oct 28 13:15:44.177686 systemd[1]: Finished Load Security Auditing Rules. Oct 28 13:15:44.178384 sudo[994]: pam_unix(sudo:session): session closed for user root Oct 28 13:15:44.179412 sshd[990]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:44.188654 systemd[1]: sshd@5-10.0.0.4:22-10.0.0.1:39766.service: Deactivated successfully. Oct 28 13:15:44.189105 systemd[1]: session-6.scope: Deactivated successfully. Oct 28 13:15:44.189606 systemd-logind[924]: Session 6 logged out. Waiting for processes to exit. Oct 28 13:15:44.190422 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39774). Oct 28 13:15:44.190957 systemd-logind[924]: Removed session 6. Oct 28 13:15:44.227175 sshd[1021]: Accepted publickey for core from 10.0.0.1 port 39774 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:44.230195 kernel: audit: type=1006 audit(1761657344.226:57): pid=1021 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 28 13:15:44.230222 sshd[1021]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:44.232765 systemd-logind[924]: New session 7 of user core. Oct 28 13:15:44.246759 systemd[1]: Started Session 7 of User core. Oct 28 13:15:44.297156 sudo[1024]: 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 28 13:15:47.128492 update_engine[1272]: Oct 28 13:15:47.128492 update_engine[1272]: Oct 28 13:15:47.128492 update_engine[1272]: Oct 28 13:15:47.128492 update_engine[1272]: Oct 28 13:15:47.128492 update_engine[1272]: Oct 28 13:15:47.128492 update_engine[1272]: Oct 28 13:15:47.128492 update_engine[1272]: Oct 28 13:15:47.128492 update_engine[1272]: Oct 28 13:15:47.128492 update_engine[1272]: I1028 13:15:47.128101 1272 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 28 13:15:47.130631 update_engine[1272]: I1028 13:15:47.130610 1272 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 28 13:15:47.130936 update_engine[1272]: I1028 13:15:47.130911 1272 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 28 13:15:47.132072 update_engine[1272]: I1028 13:15:47.132047 1272 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 28 13:15:47.132372 update_engine[1272]: I1028 13:15:47.132351 1272 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Oct 28 13:15:47.132440 update_engine[1272]: I1028 13:15:47.132429 1272 omaha_request_action.cc:619] Omaha request response: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.132440 update_engine[1272]: Oct 28 13:15:47.137066 update_engine[1272]: I1028 13:15:47.137042 1272 omaha_request_action.cc:447] Omaha Response manifest version = Oct 28 13:15:47.137174 update_engine[1272]: I1028 13:15:47.137159 1272 omaha_request_action.cc:470] Found 1 url(s) Oct 28 13:15:47.137258 update_engine[1272]: I1028 13:15:47.137246 1272 omaha_request_action.cc:506] Processing first of 1 package(s) Oct 28 13:15:47.137302 update_engine[1272]: I1028 13:15:47.137292 1272 omaha_request_action.cc:513] Omaha Response package name = update.gz Oct 28 13:15:47.137347 update_engine[1272]: I1028 13:15:47.137336 1272 omaha_request_action.cc:529] Url0: http://10.0.0.3:34567/packages/update.gz Oct 28 13:15:47.137401 update_engine[1272]: I1028 13:15:47.137390 1272 omaha_request_action.cc:541] Payload size = 435526319 bytes Oct 28 13:15:47.137454 update_engine[1272]: I1028 13:15:47.137444 1272 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Oct 28 13:15:47.137512 update_engine[1272]: I1028 13:15:47.137502 1272 payload_state.cc:51] Resetting all persisted state as this is a new response Oct 28 13:15:47.137556 update_engine[1272]: I1028 13:15:47.137548 1272 payload_state.cc:360] Current Response Signature = Oct 28 13:15:47.137556 update_engine[1272]: NumURLs = 1 Oct 28 13:15:47.137556 update_engine[1272]: Url0 = http://10.0.0.3:34567/packages/update.gz Oct 28 13:15:47.137556 update_engine[1272]: Payload Size = 435526319 Oct 28 13:15:47.137556 update_engine[1272]: Payload Sha256 Hash = MWe7Cz0hHAZPhG3RiToog9DXtPRhV9ko4O7ML90dZWg= Oct 28 13:15:47.137556 update_engine[1272]: Is Delta Payload = 0 Oct 28 13:15:47.137556 update_engine[1272]: Max Failure Count Per Url = 10 Oct 28 13:15:47.137556 update_engine[1272]: Disable Payload Backoff = 1 Oct 28 13:15:47.137782 update_engine[1272]: I1028 13:15:47.137768 1272 payload_state.cc:381] Payload Attempt Number = 0 Oct 28 13:15:47.137880 update_engine[1272]: I1028 13:15:47.137868 1272 payload_state.cc:404] Current URL Index = 0 Oct 28 13:15:47.137970 update_engine[1272]: I1028 13:15:47.137959 1272 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Oct 28 13:15:47.138069 update_engine[1272]: I1028 13:15:47.138059 1272 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Oct 28 13:15:47.138119 update_engine[1272]: I1028 13:15:47.138104 1272 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 28 13:15:47.138250 update_engine[1272]: I1028 13:15:47.138235 1272 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Oct 28 13:15:47.138319 update_engine[1272]: I1028 13:15:47.138307 1272 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Oct 28 13:15:47.138361 update_engine[1272]: I1028 13:15:47.138352 1272 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Oct 28 13:15:47.138422 update_engine[1272]: I1028 13:15:47.138412 1272 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Oct 28 13:15:47.138462 update_engine[1272]: E1028 13:15:47.138453 1272 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Oct 28 13:15:47.139471 update_engine[1272]: I1028 13:15:47.139446 1272 omaha_response_handler_action.cc:85] Using this install plan: Oct 28 13:15:47.139546 update_engine[1272]: I1028 13:15:47.139534 1272 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.3:34567/packages/update.gz, payload size: 435526319, payload hash: MWe7Cz0hHAZPhG3RiToog9DXtPRhV9ko4O7ML90dZWg=, 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 28 13:15:47.139663 update_engine[1272]: I1028 13:15:47.139652 1272 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Oct 28 13:15:47.140999 update_engine[1272]: I1028 13:15:47.140975 1272 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Oct 28 13:15:47.173378 sshd[1291]: Accepted publickey for core from 10.0.0.1 port 39950 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:47.174767 sshd[1291]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:47.183748 systemd-logind[924]: New session 25 of user core. Oct 28 13:15:47.189336 systemd[1]: Started Session 25 of User core. Oct 28 13:15:47.244482 sshd[1291]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:47.250585 systemd-logind[924]: Session 25 logged out. Waiting for processes to exit. Oct 28 13:15:47.251120 systemd[1]: session-25.scope: Deactivated successfully. Oct 28 13:15:47.251636 systemd-logind[924]: Removed session 25. Oct 28 13:15:47.251778 systemd[1]: sshd@24-10.0.0.4:22-10.0.0.1:39950.service: Deactivated successfully. Oct 28 13:15:48.773202 update_engine[1272]: I1028 13:15:48.773159 1272 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Oct 28 13:15:48.773637 update_engine[1272]: I1028 13:15:48.773607 1272 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Oct 28 13:15:48.837891 update_engine[1272]: E1028 13:15:48.837855 1272 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Oct 28 13:15:48.838072 update_engine[1272]: I1028 13:15:48.838063 1272 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Oct 28 13:15:48.838116 update_engine[1272]: I1028 13:15:48.838107 1272 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Oct 28 13:15:48.838159 update_engine[1272]: I1028 13:15:48.838151 1272 update_attempter.cc:302] Processing Done. Oct 28 13:15:48.838259 update_engine[1272]: E1028 13:15:48.838248 1272 update_attempter.cc:615] Update failed. Oct 28 13:15:48.838348 update_engine[1272]: I1028 13:15:48.838336 1272 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Oct 28 13:15:48.838398 update_engine[1272]: I1028 13:15:48.838389 1272 payload_state.cc:276] Incrementing the URL failure count Oct 28 13:15:48.838443 update_engine[1272]: I1028 13:15:48.838433 1272 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 28 13:15:48.855931 update_engine[1272]: I1028 13:15:48.855906 1272 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 28 13:15:48.856049 update_engine[1272]: I1028 13:15:48.856037 1272 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.3:34567/v1/update Oct 28 13:15:48.856100 update_engine[1272]: I1028 13:15:48.856089 1272 omaha_request_action.cc:269] Request: Oct 28 13:15:48.856100 update_engine[1272]: Oct 28 13:15:48.856100 update_engine[1272]: Oct 28 13:15:48.856100 update_engine[1272]: Oct 28 13:15:48.856100 update_engine[1272]: Oct 28 13:15:48.856100 update_engine[1272]: Oct 28 13:15:48.856100 update_engine[1272]: Oct 28 13:15:48.856268 update_engine[1272]: I1028 13:15:48.856257 1272 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 28 13:15:48.856369 update_engine[1272]: I1028 13:15:48.856359 1272 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 28 13:15:48.856530 update_engine[1272]: I1028 13:15:48.856516 1272 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 28 13:15:49.002490 update_engine[1272]: I1028 13:15:49.002458 1272 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 28 13:15:49.002728 update_engine[1272]: I1028 13:15:49.002713 1272 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Oct 28 13:15:49.002793 update_engine[1272]: I1028 13:15:49.002784 1272 omaha_request_action.cc:619] Omaha request response: Oct 28 13:15:49.002793 update_engine[1272]: Oct 28 13:15:49.002793 update_engine[1272]: Oct 28 13:15:49.002793 update_engine[1272]: Oct 28 13:15:49.002793 update_engine[1272]: Oct 28 13:15:49.002793 update_engine[1272]: Oct 28 13:15:49.002793 update_engine[1272]: Oct 28 13:15:49.003019 update_engine[1272]: E1028 13:15:49.003008 1272 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Oct 28 13:15:49.003085 update_engine[1272]: I1028 13:15:49.003073 1272 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 28 13:15:49.003128 update_engine[1272]: I1028 13:15:49.003120 1272 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 28 13:15:49.003177 update_engine[1272]: I1028 13:15:49.003163 1272 update_attempter.cc:302] Processing Done. Oct 28 13:15:49.003238 update_engine[1272]: I1028 13:15:49.003227 1272 update_attempter.cc:306] Error event sent. Oct 28 13:15:57.238906 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:57504). Oct 28 13:15:57.280034 sshd[1307]: Accepted publickey for core from 10.0.0.1 port 57504 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:57.281487 kernel: kauditd_printk_skb: 287 callbacks suppressed Oct 28 13:15:57.281533 kernel: audit: type=1006 audit(1761657357.279:353): pid=1307 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 28 13:15:57.281643 sshd[1307]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:57.285094 systemd-logind[924]: New session 26 of user core. Oct 28 13:15:57.302058 systemd[1]: Started Session 26 of User core. Oct 28 13:15:57.358905 sshd[1307]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:57.373381 systemd[1]: sshd@25-10.0.0.4:22-10.0.0.1:57504.service: Deactivated successfully. Oct 28 13:15:57.374050 systemd[1]: session-26.scope: Deactivated successfully. Oct 28 13:15:57.374630 systemd-logind[924]: Session 26 logged out. Waiting for processes to exit. Oct 28 13:15:57.375592 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:57510). Oct 28 13:15:57.376248 systemd-logind[924]: Removed session 26. Oct 28 13:15:57.416061 sshd[1314]: Accepted publickey for core from 10.0.0.1 port 57510 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:57.417473 sshd[1314]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:57.420203 kernel: audit: type=1006 audit(1761657357.415:354): pid=1314 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 28 13:15:57.421683 systemd-logind[924]: New session 27 of user core. Oct 28 13:15:57.431477 systemd[1]: Started Session 27 of User core. Oct 28 13:15:57.487134 sshd[1314]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:57.499096 systemd[1]: sshd@26-10.0.0.4:22-10.0.0.1:57510.service: Deactivated successfully. Oct 28 13:15:57.499755 systemd[1]: session-27.scope: Deactivated successfully. Oct 28 13:15:57.500417 systemd-logind[924]: Session 27 logged out. Waiting for processes to exit. Oct 28 13:15:57.501829 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:57520). Oct 28 13:15:57.502544 systemd-logind[924]: Removed session 27. Oct 28 13:15:57.539717 sshd[1322]: Accepted publickey for core from 10.0.0.1 port 57520 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:57.541160 sshd[1322]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:57.544196 kernel: audit: type=1006 audit(1761657357.539:355): pid=1322 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 28 13:15:57.545356 systemd-logind[924]: New session 28 of user core. Oct 28 13:15:57.567324 systemd[1]: Started Session 28 of User core. Oct 28 13:15:57.617311 sshd[1322]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:57.626625 systemd[1]: sshd@27-10.0.0.4:22-10.0.0.1:57520.service: Deactivated successfully. Oct 28 13:15:57.627218 systemd[1]: session-28.scope: Deactivated successfully. Oct 28 13:15:57.627867 systemd-logind[924]: Session 28 logged out. Waiting for processes to exit. Oct 28 13:15:57.628964 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:57532). Oct 28 13:15:57.629660 systemd-logind[924]: Removed session 28. Oct 28 13:15:57.668052 sshd[1328]: Accepted publickey for core from 10.0.0.1 port 57532 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:57.669146 sshd[1328]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:57.671199 kernel: audit: type=1006 audit(1761657357.667:356): pid=1328 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 28 13:15:57.672921 systemd-logind[924]: New session 29 of user core. Oct 28 13:15:57.681299 systemd[1]: Started Session 29 of User core. Oct 28 13:15:57.729796 sshd[1328]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:57.747076 systemd[1]: sshd@28-10.0.0.4:22-10.0.0.1:57532.service: Deactivated successfully. Oct 28 13:15:57.747657 systemd[1]: session-29.scope: Deactivated successfully. Oct 28 13:15:57.748299 systemd-logind[924]: Session 29 logged out. Waiting for processes to exit. Oct 28 13:15:57.749419 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:57540). Oct 28 13:15:57.750131 systemd-logind[924]: Removed session 29. Oct 28 13:15:57.792072 sshd[1334]: Accepted publickey for core from 10.0.0.1 port 57540 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:15:57.793380 sshd[1334]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:15:57.795838 systemd-logind[924]: New session 30 of user core. Oct 28 13:15:57.796206 kernel: audit: type=1006 audit(1761657357.791:357): pid=1334 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 28 13:15:57.804316 systemd[1]: Started Session 30 of User core. Oct 28 13:15:57.855510 sudo[1338]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Oct 28 13:15:57.855714 sudo[1338]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:15:57.861051 systemd[1]: sshd.socket: Deactivated successfully. Oct 28 13:15:57.861436 systemd[1]: Closed OpenSSH Server Socket. Oct 28 13:15:57.862572 sudo[1338]: pam_unix(sudo:session): session closed for user root Oct 28 13:15:57.865828 sudo[1337]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Oct 28 13:15:57.866006 sudo[1337]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:15:57.879456 systemd[1]: Stopping Session 1 of User core... Oct 28 13:15:57.880301 sshd[953]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:57.880413 systemd[1]: Stopping Session 30 of User core... Oct 28 13:15:57.880837 sshd[1334]: pam_unix(sshd:session): session closed for user core Oct 28 13:15:57.881385 sudo[1337]: pam_unix(sudo:session): session closed for user root Oct 28 13:15:57.881397 systemd[1]: Removed slice Slice /system/addon-config. Oct 28 13:15:57.882619 systemd[1]: Removed slice Slice /system/addon-run. Oct 28 13:15:57.883773 systemd[1]: Removed slice Slice /system/modprobe. Oct 28 13:15:57.885010 systemd[1]: Removed slice Slice /system/system-cloudinit. Oct 28 13:15:57.886135 systemd[1]: Stopped target Multi-User System. Oct 28 13:15:57.887031 systemd[1]: Stopped target Login Prompts. Oct 28 13:15:57.887920 systemd[1]: Stopped target Containers. Oct 28 13:15:57.888704 systemd[1]: Stopped target Host and Network Name Lookups. Oct 28 13:15:57.889643 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 13:15:57.890813 systemd[1]: Stopped target Timer Units. Oct 28 13:15:57.891571 systemd[1]: logrotate.timer: Deactivated successfully. Oct 28 13:15:57.891616 systemd[1]: Stopped Daily Log Rotation. Oct 28 13:15:57.892347 systemd[1]: mdadm.timer: Deactivated successfully. Oct 28 13:15:57.892383 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Oct 28 13:15:57.893430 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Oct 28 13:15:57.893483 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Oct 28 13:15:57.894449 systemd[1]: Stopped target System Time Set. Oct 28 13:15:57.895246 systemd[1]: Stopped target Load user-provided cloud configs. Oct 28 13:15:57.896213 systemd[1]: Stopped target Load system-provided cloud configs. Oct 28 13:15:57.897177 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 28 13:15:57.897276 systemd[1]: Closed Process Core Dump Socket. Oct 28 13:15:57.898718 systemd[1]: Unmounting Boot partition... Oct 28 13:15:57.899635 systemd[1]: Stopping Getty on tty1... Oct 28 13:15:57.900634 systemd[1]: Stopping Serial Getty on ttyAMA0... Oct 28 13:15:57.901519 systemd[1]: Stopping OpenSSH per-connection server daemon... Oct 28 13:15:57.902555 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:57540)... Oct 28 13:15:57.903463 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Oct 28 13:15:57.903602 systemd[1]: Stopped Commit a transient machine-id on disk. Oct 28 13:15:57.904569 systemd[1]: Stopped target First Boot Complete. Oct 28 13:15:57.906308 systemd[1]: Stopping Load/Save Random Seed... Oct 28 13:15:57.907241 systemd[1]: Stopping Update Engine... Oct 28 13:15:57.911265 systemd[1]: getty@tty1.service: Deactivated successfully. Oct 28 13:15:57.911502 systemd[1]: Stopped Getty on tty1. Oct 28 13:15:57.912712 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Oct 28 13:15:57.912894 systemd[1]: Stopped Serial Getty on ttyAMA0. Oct 28 13:15:57.914150 systemd[1]: sshd@0-10.0.0.4:22-10.0.0.1:39720.service: Deactivated successfully. Oct 28 13:15:57.914341 systemd[1]: Stopped OpenSSH per-connection server daemon. Oct 28 13:15:57.915720 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 28 13:15:57.915788 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 28 13:15:57.916021 systemd[1]: Stopped Update Engine. Oct 28 13:15:57.916801 systemd[1]: update-engine.service: Consumed 2.223s CPU time. Oct 28 13:15:57.917033 systemd[1]: sshd@29-10.0.0.4:22-10.0.0.1:57540.service: Deactivated successfully. Oct 28 13:15:57.917215 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:57540). Oct 28 13:15:57.929799 systemd[1]: boot.mount: Deactivated successfully. Oct 28 13:15:57.930039 systemd[1]: Unmounted Boot partition. Oct 28 13:15:57.931152 systemd[1]: systemd-random-seed.service: Deactivated successfully. Oct 28 13:15:57.931379 systemd[1]: Stopped Load/Save Random Seed. Oct 28 13:15:57.932409 systemd[1]: session-30.scope: Deactivated successfully. Oct 28 13:15:57.932626 systemd[1]: Stopped Session 30 of User core. Oct 28 13:15:57.933606 systemd[1]: session-1.scope: Deactivated successfully. Oct 28 13:15:57.933830 systemd[1]: Stopped Session 1 of User core. Oct 28 13:15:57.935010 systemd-logind[924]: Session 1 logged out. Waiting for processes to exit. Oct 28 13:15:57.935904 systemd-logind[924]: Session 30 logged out. Waiting for processes to exit. Oct 28 13:15:57.936128 systemd[1]: Removed slice Slice /system/getty. Oct 28 13:15:57.937644 systemd[1]: Removed slice Slice /system/serial-getty. Oct 28 13:15:57.938823 systemd[1]: Removed slice Slice /system/sshd. Oct 28 13:15:57.939711 systemd[1]: sshd-keygen.service: Deactivated successfully. Oct 28 13:15:57.939808 systemd[1]: Stopped Generate sshd host keys. Oct 28 13:15:57.940696 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Oct 28 13:15:57.940810 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Oct 28 13:15:57.942217 systemd[1]: Stopping User Login Management... Oct 28 13:15:57.942989 systemd[1]: Stopping User Manager for UID 500... Oct 28 13:15:57.943730 systemd[956]: Stopped target Main User Target. Oct 28 13:15:57.943748 systemd[956]: Stopped target Basic System. Oct 28 13:15:57.943758 systemd[956]: Stopped target Paths. Oct 28 13:15:57.943765 systemd[956]: Stopped target Sockets. Oct 28 13:15:57.943782 systemd[956]: Reached target Shutdown. Oct 28 13:15:57.943790 systemd[956]: Stopped target Timers. Oct 28 13:15:57.943893 systemd[956]: Finished Exit the Session. Oct 28 13:15:57.943916 systemd[956]: Reached target Exit the Session. Oct 28 13:15:57.944678 systemd-logind[924]: Removed session 30. Oct 28 13:15:57.946405 systemd[1]: user@500.service: Deactivated successfully. Oct 28 13:15:57.946586 systemd[1]: Stopped User Manager for UID 500. Oct 28 13:15:57.948271 systemd[1]: Stopping User Runtime Directory /run/user/500... Oct 28 13:15:57.953162 systemd[1]: run-user-500.mount: Deactivated successfully. Oct 28 13:15:57.953288 systemd[1]: Unmounted /run/user/500. Oct 28 13:15:57.954333 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Oct 28 13:15:57.954536 systemd[1]: Stopped User Runtime Directory /run/user/500. Oct 28 13:15:57.956073 systemd[1]: Removed slice User Slice of UID 500. Oct 28 13:15:57.957815 systemd[1]: Stopping D-Bus System Message Bus... Oct 28 13:15:57.959310 systemd[1]: Stopping Permit User Sessions... Oct 28 13:15:57.963231 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Oct 28 13:15:57.963453 systemd[1]: Stopped Permit User Sessions. Oct 28 13:15:57.964384 systemd[1]: dbus.service: Deactivated successfully. Oct 28 13:15:57.964625 systemd[1]: Stopped D-Bus System Message Bus. Oct 28 13:15:57.965570 systemd[1]: Stopped target Network. Oct 28 13:15:57.966252 systemd[1]: Stopped target Remote File Systems. Oct 28 13:15:57.967132 systemd[1]: Stopping Network Name Resolution... Oct 28 13:15:57.980094 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 28 13:15:57.980330 systemd[1]: Stopped Network Name Resolution. Oct 28 13:15:57.981336 systemd[1]: systemd-logind.service: Deactivated successfully. Oct 28 13:15:57.981578 systemd[1]: Stopped User Login Management. Oct 28 13:15:57.982493 systemd[1]: Stopped target Basic System. Oct 28 13:15:57.983224 systemd[1]: Stopped target Path Units. Oct 28 13:15:57.983904 systemd[1]: motdgen.path: Deactivated successfully. Oct 28 13:15:57.989973 systemd[1]: Stopped Watch for update engine configuration changes. Oct 28 13:15:57.989000 audit: BPF prog-id=50 op=UNLOAD Oct 28 13:15:57.989000 audit: BPF prog-id=55 op=UNLOAD Oct 28 13:15:57.994045 kernel: audit: type=1334 audit(1761657357.989:358): prog-id=50 op=UNLOAD Oct 28 13:15:57.994077 kernel: audit: type=1334 audit(1761657357.989:359): prog-id=55 op=UNLOAD Oct 28 13:15:57.994086 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Oct 28 13:15:57.999657 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 13:15:58.001753 systemd[1]: Stopped target Slice Units. Oct 28 13:15:58.003033 systemd[1]: Removed slice User and Session Slice. Oct 28 13:15:58.003958 systemd[1]: Stopped target Socket Units. Oct 28 13:15:58.004747 systemd[1]: dbus.socket: Deactivated successfully. Oct 28 13:15:58.004796 systemd[1]: Closed D-Bus System Message Bus Socket. Oct 28 13:15:58.005737 systemd[1]: docker.socket: Deactivated successfully. Oct 28 13:15:58.005971 systemd[1]: Closed Docker Socket for the API. Oct 28 13:15:58.006796 systemd[1]: Stopped target System Initialization. Oct 28 13:15:58.007655 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Oct 28 13:15:58.007766 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Oct 28 13:15:58.008844 systemd[1]: Stopped target Local Verity Protected Volumes. Oct 28 13:15:58.021413 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 13:15:58.022313 systemd[1]: Stopping Network Configuration... Oct 28 13:15:58.023419 systemd[1]: Stopping Network Time Synchronization... Oct 28 13:15:58.024204 systemd[1]: systemd-update-done.service: Deactivated successfully. Oct 28 13:15:58.024259 auditctl[1355]: No rules Oct 28 13:15:58.024273 systemd[1]: Stopped Update is Completed. Oct 28 13:15:58.024996 systemd[1]: ldconfig.service: Deactivated successfully. Oct 28 13:15:58.025051 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Oct 28 13:15:58.025940 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Oct 28 13:15:58.025995 systemd[1]: Stopped Rebuild Hardware Database. Oct 28 13:15:58.026211 systemd-networkd[844]: eth0: DHCPv6 lease lost Oct 28 13:15:58.027639 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Oct 28 13:15:58.027695 systemd[1]: Stopped Rebuild Journal Catalog. Oct 28 13:15:58.029250 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Oct 28 13:15:58.031677 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 28 13:15:58.031930 systemd[1]: Stopped Network Configuration. Oct 28 13:15:58.032932 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Oct 28 13:15:58.033169 systemd[1]: Stopped Network Time Synchronization. Oct 28 13:15:58.034289 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 13:15:58.034497 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 13:15:58.036765 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 28 13:15:58.036806 systemd[1]: Closed Network Service Netlink Socket. Oct 28 13:15:58.037679 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 13:15:58.037732 systemd[1]: Stopped Apply Kernel Variables. Oct 28 13:15:58.038674 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Oct 28 13:15:58.038891 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Oct 28 13:15:58.040403 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 28 13:15:58.040487 systemd[1]: Stopped Create Volatile Files and Directories. Oct 28 13:15:58.041416 systemd[1]: Stopped target Local File Systems. Oct 28 13:15:58.042950 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Oct 28 13:15:58.043000 audit: BPF prog-id=58 op=UNLOAD Oct 28 13:15:58.043000 audit: BPF prog-id=54 op=UNLOAD Oct 28 13:15:58.045533 kernel: audit: type=1334 audit(1761657358.043:360): prog-id=58 op=UNLOAD Oct 28 13:15:58.045571 kernel: audit: type=1334 audit(1761657358.043:361): prog-id=54 op=UNLOAD Oct 28 13:15:58.046126 systemd[1]: Unmounting External Media Directory... Oct 28 13:15:58.047838 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Oct 28 13:15:58.049577 systemd[1]: Unmounting /run/torcx/unpack... Oct 28 13:15:58.050719 systemd[1]: Unmounting Temporary Directory /tmp... Oct 28 13:15:58.051997 systemd[1]: Unmounting /usr/share/oem... Oct 28 13:15:58.053466 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Oct 28 13:15:58.056127 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 28 13:15:58.056386 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Oct 28 13:15:58.057612 systemd[1]: media.mount: Deactivated successfully. Oct 28 13:15:58.057849 systemd[1]: Unmounted External Media Directory. Oct 28 13:15:58.058819 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Oct 28 13:15:58.059032 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Oct 28 13:15:58.060307 systemd[1]: tmp.mount: Deactivated successfully. Oct 28 13:15:58.060563 systemd[1]: Unmounted Temporary Directory /tmp. Oct 28 13:15:58.061510 systemd[1]: usr-share-oem.mount: Deactivated successfully. Oct 28 13:15:58.061760 systemd[1]: Unmounted /usr/share/oem. Oct 28 13:15:58.078029 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 28 13:15:58.078354 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Oct 28 13:15:58.079883 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Oct 28 13:15:58.080098 systemd[1]: Unmounted /run/torcx/unpack. Oct 28 13:15:58.081164 systemd[1]: Stopped target Swaps. Oct 28 13:15:58.081846 systemd[1]: Reached target Unmount All Filesystems. Oct 28 13:15:58.082758 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Oct 28 13:15:58.082831 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Oct 28 13:15:58.084096 systemd[1]: Removed slice Slice /system/systemd-fsck. Oct 28 13:15:58.085150 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 13:15:58.086212 systemd[1]: lvm2-activation.service: Deactivated successfully. Oct 28 13:15:58.086272 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 28 13:15:58.087156 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 13:15:58.087992 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 13:15:58.088061 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 13:15:58.089373 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Oct 28 13:15:58.096796 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Oct 28 13:15:58.098482 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Oct 28 13:15:58.098553 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 28 13:15:58.099570 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 13:15:58.099628 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 13:15:58.100666 systemd[1]: systemd-sysusers.service: Deactivated successfully. Oct 28 13:15:58.100724 systemd[1]: Stopped Create System Users. Oct 28 13:15:58.101541 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Oct 28 13:15:58.101596 systemd[1]: Stopped Remount Root and Kernel File Systems. Oct 28 13:15:58.102593 systemd[1]: Reached target System Shutdown. Oct 28 13:15:58.103395 systemd[1]: Reached target Late Shutdown Services. Oct 28 13:15:58.104272 systemd[1]: systemd-reboot.service: Deactivated successfully. Oct 28 13:15:58.104305 systemd[1]: Finished System Reboot. Oct 28 13:15:58.104990 systemd[1]: Reached target System Reboot. Oct 28 13:15:58.105778 systemd[1]: Shutting down. Oct 28 13:15:58.106000 audit: BPF prog-id=53 op=UNLOAD Oct 28 13:15:58.106000 audit: BPF prog-id=52 op=UNLOAD Oct 28 13:15:58.106000 audit: BPF prog-id=51 op=UNLOAD Oct 28 13:15:58.108201 kernel: audit: type=1334 audit(1761657358.106:362): prog-id=53 op=UNLOAD Oct 28 13:15:58.108000 audit: BPF prog-id=57 op=UNLOAD Oct 28 13:15:58.108000 audit: BPF prog-id=56 op=UNLOAD Oct 28 13:15:58.109000 audit: BPF prog-id=61 op=UNLOAD Oct 28 13:15:58.109000 audit: BPF prog-id=60 op=UNLOAD Oct 28 13:15:58.109000 audit: BPF prog-id=59 op=UNLOAD Oct 28 13:15:58.151202 systemd-shutdown[1]: Syncing filesystems and block devices. Oct 28 13:15:58.157489 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Oct 28 13:15:58.157553 systemd-journald[808]: Journal stopped -- Reboot -- Oct 28 13:16:06.668759 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 28 13:16:06.668775 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 28 13:16:06.668783 kernel: efi: EFI v2.70 by EDK II Oct 28 13:16:06.668789 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 28 13:16:06.668793 kernel: efi: seeding entropy pool Oct 28 13:16:06.668798 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 28 13:16:06.668804 kernel: ACPI: Early table checksum verification disabled Oct 28 13:16:06.668809 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 28 13:16:06.668814 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 28 13:16:06.668819 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:16:06.668825 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:16:06.668830 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:16:06.668835 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:16:06.668840 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:16:06.668846 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:16:06.668851 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:16:06.668858 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:16:06.668863 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:16:06.668869 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 28 13:16:06.668874 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 28 13:16:06.668879 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:16:06.668884 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 28 13:16:06.668890 kernel: Zone ranges: Oct 28 13:16:06.668895 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:16:06.668900 kernel: DMA32 empty Oct 28 13:16:06.668905 kernel: Normal empty Oct 28 13:16:06.668910 kernel: Movable zone start for each node Oct 28 13:16:06.668916 kernel: Early memory node ranges Oct 28 13:16:06.668921 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 28 13:16:06.668926 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 28 13:16:06.668931 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 28 13:16:06.668937 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 28 13:16:06.668942 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 28 13:16:06.668947 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 28 13:16:06.668952 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 28 13:16:06.668957 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 28 13:16:06.668962 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 28 13:16:06.668967 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 28 13:16:06.668973 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 28 13:16:06.668978 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:16:06.668987 kernel: On node 0 totalpages: 643072 Oct 28 13:16:06.668993 kernel: DMA zone: 10048 pages used for memmap Oct 28 13:16:06.668998 kernel: DMA zone: 0 pages reserved Oct 28 13:16:06.669003 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 28 13:16:06.669009 kernel: psci: probing for conduit method from ACPI. Oct 28 13:16:06.669015 kernel: psci: PSCIv1.1 detected in firmware. Oct 28 13:16:06.669020 kernel: psci: Using standard PSCI v0.2 function IDs Oct 28 13:16:06.669026 kernel: psci: Trusted OS migration not required Oct 28 13:16:06.669032 kernel: psci: SMC Calling Convention v1.1 Oct 28 13:16:06.669038 kernel: ACPI: SRAT not present Oct 28 13:16:06.669044 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 28 13:16:06.669049 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 28 13:16:06.669055 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 28 13:16:06.669061 kernel: Detected PIPT I-cache on CPU0 Oct 28 13:16:06.669066 kernel: CPU features: detected: GIC system register CPU interface Oct 28 13:16:06.669072 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 28 13:16:06.669077 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 28 13:16:06.669088 kernel: CPU features: detected: Hardware dirty bit management Oct 28 13:16:06.669094 kernel: CPU features: detected: Spectre-v4 Oct 28 13:16:06.669101 kernel: CPU features: detected: ARM erratum 1418040 Oct 28 13:16:06.669106 kernel: CPU features: detected: Spectre-BHB Oct 28 13:16:06.669112 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 28 13:16:06.669117 kernel: Policy zone: DMA Oct 28 13:16:06.669124 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 28 13:16:06.669135 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 28 13:16:06.669141 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 28 13:16:06.669147 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 28 13:16:06.669154 kernel: Memory: 2452096K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120192K reserved, 0K cma-reserved) Oct 28 13:16:06.669160 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 28 13:16:06.669165 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 28 13:16:06.669172 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 28 13:16:06.669178 kernel: rcu: RCU event tracing is enabled. Oct 28 13:16:06.669183 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 28 13:16:06.669189 kernel: Trampoline variant of Tasks RCU enabled. Oct 28 13:16:06.669203 kernel: Tracing variant of Tasks RCU enabled. Oct 28 13:16:06.669208 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 28 13:16:06.669214 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 28 13:16:06.669219 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 28 13:16:06.669225 kernel: GICv3: 256 SPIs implemented Oct 28 13:16:06.669230 kernel: GICv3: 0 Extended SPIs implemented Oct 28 13:16:06.669236 kernel: GICv3: Distributor has no Range Selector support Oct 28 13:16:06.669241 kernel: GICv3: 16 PPIs implemented Oct 28 13:16:06.669250 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 28 13:16:06.669262 kernel: ACPI: SRAT not present Oct 28 13:16:06.669269 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 28 13:16:06.669275 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 28 13:16:06.669281 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 28 13:16:06.669286 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 28 13:16:06.669292 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 28 13:16:06.669297 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:16:06.669303 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 28 13:16:06.669309 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 28 13:16:06.669337 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 28 13:16:06.669344 kernel: arm-pv: using stolen time PV Oct 28 13:16:06.669351 kernel: Console: colour dummy device 80x25 Oct 28 13:16:06.669357 kernel: ACPI: Core revision 20200925 Oct 28 13:16:06.669363 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 28 13:16:06.669369 kernel: pid_max: default: 32768 minimum: 301 Oct 28 13:16:06.669375 kernel: LSM: Security Framework initializing Oct 28 13:16:06.669380 kernel: SELinux: Initializing. Oct 28 13:16:06.669386 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 13:16:06.669392 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 13:16:06.669398 kernel: rcu: Hierarchical SRCU implementation. Oct 28 13:16:06.669404 kernel: Platform MSI: ITS@0x8080000 domain created Oct 28 13:16:06.669410 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 28 13:16:06.669415 kernel: Remapping and enabling EFI services. Oct 28 13:16:06.669421 kernel: smp: Bringing up secondary CPUs ... Oct 28 13:16:06.669427 kernel: Detected PIPT I-cache on CPU1 Oct 28 13:16:06.669433 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 28 13:16:06.669438 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 28 13:16:06.669444 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:16:06.669450 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 28 13:16:06.669456 kernel: Detected PIPT I-cache on CPU2 Oct 28 13:16:06.669463 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 28 13:16:06.669469 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 28 13:16:06.669475 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:16:06.669480 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 28 13:16:06.669486 kernel: Detected PIPT I-cache on CPU3 Oct 28 13:16:06.669496 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 28 13:16:06.669502 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 28 13:16:06.669509 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:16:06.669515 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 28 13:16:06.669521 kernel: smp: Brought up 1 node, 4 CPUs Oct 28 13:16:06.669527 kernel: SMP: Total of 4 processors activated. Oct 28 13:16:06.669533 kernel: CPU features: detected: Privileged Access Never Oct 28 13:16:06.669538 kernel: CPU features: detected: LSE atomic instructions Oct 28 13:16:06.669544 kernel: CPU features: detected: User Access Override Oct 28 13:16:06.669550 kernel: CPU features: detected: 32-bit EL0 Support Oct 28 13:16:06.669556 kernel: CPU features: detected: Common not Private translations Oct 28 13:16:06.669562 kernel: CPU features: detected: RAS Extension Support Oct 28 13:16:06.669569 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 28 13:16:06.669575 kernel: CPU features: detected: CRC32 instructions Oct 28 13:16:06.669581 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 28 13:16:06.669587 kernel: CPU: All CPU(s) started at EL1 Oct 28 13:16:06.669593 kernel: alternatives: patching kernel code Oct 28 13:16:06.669600 kernel: devtmpfs: initialized Oct 28 13:16:06.669606 kernel: KASLR enabled Oct 28 13:16:06.669612 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 28 13:16:06.669618 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 28 13:16:06.669624 kernel: pinctrl core: initialized pinctrl subsystem Oct 28 13:16:06.669630 kernel: SMBIOS 3.0.0 present. Oct 28 13:16:06.669636 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 28 13:16:06.669648 kernel: NET: Registered protocol family 16 Oct 28 13:16:06.669654 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 28 13:16:06.669661 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 28 13:16:06.669668 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 28 13:16:06.669674 kernel: audit: initializing netlink subsys (disabled) Oct 28 13:16:06.669680 kernel: audit: type=2000 audit(0.029:1): state=initialized audit_enabled=0 res=1 Oct 28 13:16:06.669686 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 28 13:16:06.669692 kernel: cpuidle: using governor menu Oct 28 13:16:06.669698 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 28 13:16:06.669704 kernel: ASID allocator initialised with 32768 entries Oct 28 13:16:06.669710 kernel: ACPI: bus type PCI registered Oct 28 13:16:06.669716 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 28 13:16:06.669723 kernel: Serial: AMBA PL011 UART driver Oct 28 13:16:06.669729 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 28 13:16:06.669735 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 28 13:16:06.669741 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 28 13:16:06.669747 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 28 13:16:06.669753 kernel: cryptd: max_cpu_qlen set to 1000 Oct 28 13:16:06.669759 kernel: ACPI: Added _OSI(Module Device) Oct 28 13:16:06.669765 kernel: ACPI: Added _OSI(Processor Device) Oct 28 13:16:06.669771 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 28 13:16:06.669778 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 28 13:16:06.669784 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 28 13:16:06.669790 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 28 13:16:06.669796 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 28 13:16:06.669802 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 28 13:16:06.669808 kernel: ACPI: Interpreter enabled Oct 28 13:16:06.669813 kernel: ACPI: Using GIC for interrupt routing Oct 28 13:16:06.669819 kernel: ACPI: MCFG table detected, 1 entries Oct 28 13:16:06.669825 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 28 13:16:06.669831 kernel: printk: console [ttyAMA0] enabled Oct 28 13:16:06.669838 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 28 13:16:06.669938 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 28 13:16:06.669997 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 28 13:16:06.670071 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 28 13:16:06.670128 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 28 13:16:06.670200 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 28 13:16:06.670210 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 28 13:16:06.670225 kernel: PCI host bridge to bus 0000:00 Oct 28 13:16:06.670291 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 28 13:16:06.670341 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 28 13:16:06.670390 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 28 13:16:06.670438 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 28 13:16:06.670503 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 28 13:16:06.670564 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 28 13:16:06.670622 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 28 13:16:06.670690 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 28 13:16:06.670746 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 13:16:06.670800 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 13:16:06.670854 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 28 13:16:06.670908 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 28 13:16:06.670957 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 28 13:16:06.671006 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 28 13:16:06.671055 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 28 13:16:06.671063 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 28 13:16:06.671069 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 28 13:16:06.671075 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 28 13:16:06.671081 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 28 13:16:06.671087 kernel: vgaarb: loaded Oct 28 13:16:06.671093 kernel: Registered efivars operations Oct 28 13:16:06.671099 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 28 13:16:06.671107 kernel: VFS: Disk quotas dquot_6.6.0 Oct 28 13:16:06.671113 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 28 13:16:06.671119 kernel: pnp: PnP ACPI init Oct 28 13:16:06.671181 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 28 13:16:06.671242 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 28 13:16:06.671250 kernel: pnp: PnP ACPI: found 1 devices Oct 28 13:16:06.671256 kernel: NET: Registered protocol family 2 Oct 28 13:16:06.671263 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 28 13:16:06.671271 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 28 13:16:06.671277 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 28 13:16:06.671283 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 28 13:16:06.671289 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 28 13:16:06.671296 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 13:16:06.671302 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 13:16:06.671308 kernel: NET: Registered protocol family 1 Oct 28 13:16:06.671314 kernel: PCI: CLS 0 bytes, default 64 Oct 28 13:16:06.671320 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 28 13:16:06.671327 kernel: kvm [1]: HYP mode not available Oct 28 13:16:06.671333 kernel: Initialise system trusted keyrings Oct 28 13:16:06.671339 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 28 13:16:06.671345 kernel: Key type asymmetric registered Oct 28 13:16:06.671351 kernel: Asymmetric key parser 'x509' registered Oct 28 13:16:06.671357 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 28 13:16:06.671363 kernel: io scheduler mq-deadline registered Oct 28 13:16:06.671368 kernel: io scheduler kyber registered Oct 28 13:16:06.671374 kernel: io scheduler bfq registered Oct 28 13:16:06.671381 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 28 13:16:06.671388 kernel: ACPI: Power Button [PWRB] Oct 28 13:16:06.671393 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 28 13:16:06.671452 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 28 13:16:06.671460 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 28 13:16:06.671467 kernel: msm_serial: driver initialized Oct 28 13:16:06.671472 kernel: random: fast init done Oct 28 13:16:06.671479 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 28 13:16:06.671485 kernel: random: crng init done Oct 28 13:16:06.671491 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 28 13:16:06.671498 kernel: thunder_xcv, ver 1.0 Oct 28 13:16:06.671504 kernel: thunder_bgx, ver 1.0 Oct 28 13:16:06.671510 kernel: nicpf, ver 1.0 Oct 28 13:16:06.671516 kernel: nicvf, ver 1.0 Oct 28 13:16:06.671577 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 28 13:16:06.671627 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-28T13:16:06 UTC (1761657366) Oct 28 13:16:06.671635 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 28 13:16:06.671648 kernel: NET: Registered protocol family 10 Oct 28 13:16:06.671655 kernel: Segment Routing with IPv6 Oct 28 13:16:06.671661 kernel: NET: Registered protocol family 17 Oct 28 13:16:06.671667 kernel: Key type dns_resolver registered Oct 28 13:16:06.671673 kernel: registered taskstats version 1 Oct 28 13:16:06.671679 kernel: Loading compiled-in X.509 certificates Oct 28 13:16:06.671685 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 28 13:16:06.671691 kernel: Key type ._fscrypt registered Oct 28 13:16:06.671697 kernel: Key type .fscrypt registered Oct 28 13:16:06.671703 kernel: Key type fscrypt-provisioning registered Oct 28 13:16:06.671710 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 28 13:16:06.671716 kernel: ima: Allocated hash algorithm: sha1 Oct 28 13:16:06.671722 kernel: ima: No architecture policies found Oct 28 13:16:06.671728 kernel: Freeing unused kernel memory: 34240K Oct 28 13:16:06.671734 kernel: Run /init as init process Oct 28 13:16:06.671740 kernel: with arguments: Oct 28 13:16:06.671746 kernel: /init Oct 28 13:16:06.671751 kernel: with environment: Oct 28 13:16:06.671757 kernel: HOME=/ Oct 28 13:16:06.671763 kernel: TERM=linux Oct 28 13:16:06.671769 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 28 13:16:06.671777 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 28 13:16:06.671785 systemd[1]: Detected virtualization kvm. Oct 28 13:16:06.671792 systemd[1]: Detected architecture arm64. Oct 28 13:16:06.671798 systemd[1]: Running in initial RAM disk. Oct 28 13:16:06.671804 systemd[1]: No hostname configured, using default hostname. Oct 28 13:16:06.671811 systemd[1]: Hostname set to . Oct 28 13:16:06.671819 systemd[1]: Initializing machine ID from VM UUID. Oct 28 13:16:06.671825 systemd[1]: Queued start job for default target Initrd Default Target. Oct 28 13:16:06.671832 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 13:16:06.671838 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 13:16:06.671844 systemd[1]: Reached target Path Units. Oct 28 13:16:06.671850 systemd[1]: Reached target Slice Units. Oct 28 13:16:06.671857 systemd[1]: Reached target Swaps. Oct 28 13:16:06.671863 systemd[1]: Reached target Timer Units. Oct 28 13:16:06.671871 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 28 13:16:06.671877 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 28 13:16:06.671884 systemd[1]: Listening on Journal Audit Socket. Oct 28 13:16:06.671890 systemd[1]: Listening on Journal Socket (/dev/log). Oct 28 13:16:06.671896 systemd[1]: Listening on Journal Socket. Oct 28 13:16:06.671903 systemd[1]: Listening on udev Control Socket. Oct 28 13:16:06.671909 systemd[1]: Listening on udev Kernel Socket. Oct 28 13:16:06.671916 systemd[1]: Reached target Socket Units. Oct 28 13:16:06.671922 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 28 13:16:06.671930 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 13:16:06.671936 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 28 13:16:06.671943 systemd[1]: Starting Journal Service... Oct 28 13:16:06.671949 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 13:16:06.671956 systemd[1]: Starting Apply Kernel Variables... Oct 28 13:16:06.671962 systemd[1]: Starting Setup Virtual Console... Oct 28 13:16:06.671968 kernel: SCSI subsystem initialized Oct 28 13:16:06.671974 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 28 13:16:06.671981 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 13:16:06.671987 kernel: Loading iSCSI transport class v2.0-870. Oct 28 13:16:06.671994 systemd[1]: Finished Setup Virtual Console. Oct 28 13:16:06.672001 systemd[1]: Finished Apply Kernel Variables. Oct 28 13:16:06.672013 systemd-journald[270]: Journal started Oct 28 13:16:06.672050 systemd-journald[270]: Runtime Journal (/run/log/journal/fd7e443d971541c8942fa565c71b6154) is 6.0M, max 48.5M, 42.4M free. Oct 28 13:16:06.674221 systemd[1]: Started Journal Service. Oct 28 13:16:06.674968 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 28 13:16:06.676505 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 13:16:06.679367 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 13:16:06.690428 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 28 13:16:06.692018 systemd[1]: Starting dracut cmdline hook... Oct 28 13:16:06.700009 dracut-cmdline[291]: dracut-dracut-053 Oct 28 13:16:06.701916 dracut-cmdline[291]: 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 28 13:16:06.752226 kernel: iscsi: registered transport (tcp) Oct 28 13:16:06.763440 kernel: iscsi: registered transport (qla4xxx) Oct 28 13:16:06.763459 kernel: QLogic iSCSI HBA Driver Oct 28 13:16:06.772478 systemd[1]: Finished dracut cmdline hook. Oct 28 13:16:06.773846 systemd[1]: Starting dracut pre-udev hook... Oct 28 13:16:06.775035 systemd[1]: Starting Open-iSCSI... Oct 28 13:16:06.777094 iscsid[377]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 28 13:16:06.777094 iscsid[377]: 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 28 13:16:06.777094 iscsid[377]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 28 13:16:06.777094 iscsid[377]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 28 13:16:06.777094 iscsid[377]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 28 13:16:06.777094 iscsid[377]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 28 13:16:06.790074 kernel: device-mapper: uevent: version 1.0.3 Oct 28 13:16:06.790090 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 28 13:16:06.781273 systemd[1]: Started Open-iSCSI. Oct 28 13:16:06.822229 kernel: raid6: neonx8 gen() 13784 MB/s Oct 28 13:16:06.839223 kernel: raid6: neonx8 xor() 10757 MB/s Oct 28 13:16:06.856225 kernel: raid6: neonx4 gen() 13627 MB/s Oct 28 13:16:06.873220 kernel: raid6: neonx4 xor() 11564 MB/s Oct 28 13:16:06.890220 kernel: raid6: neonx2 gen() 13010 MB/s Oct 28 13:16:06.907213 kernel: raid6: neonx2 xor() 9871 MB/s Oct 28 13:16:06.924220 kernel: raid6: neonx1 gen() 10917 MB/s Oct 28 13:16:06.941228 kernel: raid6: neonx1 xor() 8827 MB/s Oct 28 13:16:06.959247 kernel: raid6: int64x8 gen() 6810 MB/s Oct 28 13:16:06.975230 kernel: raid6: int64x8 xor() 3786 MB/s Oct 28 13:16:06.992228 kernel: raid6: int64x4 gen() 6900 MB/s Oct 28 13:16:07.009226 kernel: raid6: int64x4 xor() 3824 MB/s Oct 28 13:16:07.026215 kernel: raid6: int64x2 gen() 6177 MB/s Oct 28 13:16:07.043224 kernel: raid6: int64x2 xor() 3309 MB/s Oct 28 13:16:07.060225 kernel: raid6: int64x1 gen() 5002 MB/s Oct 28 13:16:07.077316 kernel: raid6: int64x1 xor() 2594 MB/s Oct 28 13:16:07.077339 kernel: raid6: using algorithm neonx8 gen() 13784 MB/s Oct 28 13:16:07.077355 kernel: raid6: .... xor() 10757 MB/s, rmw enabled Oct 28 13:16:07.078411 kernel: raid6: using neon recovery algorithm Oct 28 13:16:07.088655 kernel: xor: measuring software checksum speed Oct 28 13:16:07.088671 kernel: 8regs : 17152 MB/sec Oct 28 13:16:07.089683 kernel: 32regs : 20760 MB/sec Oct 28 13:16:07.090541 kernel: arm64_neon : 29173 MB/sec Oct 28 13:16:07.090553 kernel: xor: using function: arm64_neon (29173 MB/sec) Oct 28 13:16:07.135219 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 28 13:16:07.144704 systemd[1]: Finished dracut pre-udev hook. Oct 28 13:16:07.145000 audit: BPF prog-id=6 op=LOAD Oct 28 13:16:07.146000 audit: BPF prog-id=7 op=LOAD Oct 28 13:16:07.147715 kernel: audit: type=1334 audit(1761657367.145:2): prog-id=6 op=LOAD Oct 28 13:16:07.147740 kernel: audit: type=1334 audit(1761657367.146:3): prog-id=7 op=LOAD Oct 28 13:16:07.147749 kernel: audit: type=1334 audit(1761657367.147:4): prog-id=8 op=LOAD Oct 28 13:16:07.147000 audit: BPF prog-id=8 op=LOAD Oct 28 13:16:07.147996 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 13:16:07.159426 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 13:16:07.161160 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 13:16:07.162784 systemd[1]: Starting dracut pre-trigger hook... Oct 28 13:16:07.173822 dracut-pre-trigger[415]: rd.md=0: removing MD RAID activation Oct 28 13:16:07.195115 systemd[1]: Finished dracut pre-trigger hook. Oct 28 13:16:07.196522 systemd[1]: Starting Coldplug All udev Devices... Oct 28 13:16:07.205795 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 13:16:07.223673 systemd[1]: Finished Coldplug All udev Devices. Oct 28 13:16:07.225119 systemd[1]: Starting dracut initqueue hook... Oct 28 13:16:07.237213 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 28 13:16:07.237359 kernel: vda: detected capacity change from 0 to 4756340736 Oct 28 13:16:07.246207 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 13:16:07.249334 systemd-udevd[467]: Using default interface naming scheme 'v249'. Oct 28 13:16:07.264225 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 28 13:16:07.266961 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (456) Oct 28 13:16:07.269570 systemd[1]: Reached target Initrd Root Device. Oct 28 13:16:07.273372 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 28 13:16:07.274446 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 28 13:16:07.276966 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 28 13:16:07.278152 systemd[1]: Finished dracut initqueue hook. Oct 28 13:16:07.279752 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 28 13:16:07.279851 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 28 13:16:07.281364 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 13:16:07.282963 systemd[1]: Reached target Preparation for Remote File Systems. Oct 28 13:16:07.284751 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 13:16:07.286397 systemd[1]: Reached target Remote File Systems. Oct 28 13:16:07.288565 systemd[1]: Starting dracut pre-mount hook... Oct 28 13:16:07.289875 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 28 13:16:07.296446 systemd[1]: Finished dracut pre-mount hook. Oct 28 13:16:07.298058 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 28 13:16:07.302208 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 28 13:16:07.308369 systemd-fsck[504]: ROOT: clean, 640/553792 files, 39961/553472 blocks Oct 28 13:16:07.311344 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 28 13:16:07.313060 systemd[1]: Mounting /sysroot... Oct 28 13:16:07.324502 systemd[1]: Found device /dev/mapper/usr. Oct 28 13:16:07.325791 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 28 13:16:07.329632 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 28 13:16:07.334910 systemd-fsck[518]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 28 13:16:07.334910 systemd-fsck[518]: You must have r/w access to the filesystem or be root Oct 28 13:16:07.335717 systemd-fsck[512]: fsck failed with exit status 8. Oct 28 13:16:07.335720 systemd-fsck[512]: Ignoring error. Oct 28 13:16:07.336252 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 28 13:16:07.338109 systemd[1]: Mounting /sysusr/usr... Oct 28 13:16:07.352098 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 28 13:16:07.352123 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 28 13:16:07.352544 systemd[1]: Mounted /sysroot. Oct 28 13:16:07.353212 systemd[1]: Reached target Initrd Root File System. Oct 28 13:16:07.354921 systemd[1]: Starting Reload Configuration from the Real Root... Oct 28 13:16:07.358825 systemd[1]: Reloading. Oct 28 13:16:07.365213 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 28 13:16:07.366000 audit: BPF prog-id=6 op=UNLOAD Oct 28 13:16:07.366000 audit: BPF prog-id=3 op=UNLOAD Oct 28 13:16:07.368268 kernel: audit: type=1334 audit(1761657367.366:5): prog-id=6 op=UNLOAD Oct 28 13:16:07.368290 kernel: audit: type=1334 audit(1761657367.366:6): prog-id=3 op=UNLOAD Oct 28 13:16:07.439000 audit: BPF prog-id=9 op=LOAD Oct 28 13:16:07.440000 audit: BPF prog-id=10 op=LOAD Oct 28 13:16:07.441222 kernel: audit: type=1334 audit(1761657367.439:7): prog-id=9 op=LOAD Oct 28 13:16:07.441248 kernel: audit: type=1334 audit(1761657367.440:8): prog-id=10 op=LOAD Oct 28 13:16:07.441257 kernel: audit: type=1334 audit(1761657367.441:9): prog-id=11 op=LOAD Oct 28 13:16:07.441000 audit: BPF prog-id=11 op=LOAD Oct 28 13:16:07.441000 audit: BPF prog-id=7 op=UNLOAD Oct 28 13:16:07.442849 kernel: audit: type=1334 audit(1761657367.441:10): prog-id=7 op=UNLOAD Oct 28 13:16:07.441000 audit: BPF prog-id=8 op=UNLOAD Oct 28 13:16:07.441000 audit: BPF prog-id=12 op=LOAD Oct 28 13:16:07.442000 audit: BPF prog-id=13 op=LOAD Oct 28 13:16:07.442000 audit: BPF prog-id=14 op=LOAD Oct 28 13:16:07.442000 audit: BPF prog-id=4 op=UNLOAD Oct 28 13:16:07.442000 audit: BPF prog-id=5 op=UNLOAD Oct 28 13:16:07.443929 systemd[1]: Mounted /sysusr/usr. Oct 28 13:16:07.445784 systemd[1]: Reached target Local File Systems. Oct 28 13:16:07.446623 systemd[1]: Reached target System Initialization. Oct 28 13:16:07.447988 systemd[1]: Reached target Basic System. Oct 28 13:16:07.450073 systemd[1]: Mounting /sysroot/usr... Oct 28 13:16:07.452413 systemd[1]: Mounted /sysroot/usr. Oct 28 13:16:07.460105 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 28 13:16:07.460216 systemd[1]: Finished Reload Configuration from the Real Root. Oct 28 13:16:07.462149 systemd[1]: Reached target Initrd File Systems. Oct 28 13:16:07.463692 systemd[1]: Reached target Initrd Default Target. Oct 28 13:16:07.465092 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 28 13:16:07.465655 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 28 13:16:07.475135 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 28 13:16:07.476630 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 28 13:16:07.481619 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 13:16:07.482566 systemd[1]: Stopped target Timer Units. Oct 28 13:16:07.483992 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 28 13:16:07.484088 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 28 13:16:07.485335 systemd[1]: Stopped target Initrd Default Target. Oct 28 13:16:07.487023 systemd[1]: Stopped target Basic System. Oct 28 13:16:07.488446 systemd[1]: Stopped target Initrd Root Device. Oct 28 13:16:07.489840 systemd[1]: Stopped target Path Units. Oct 28 13:16:07.491014 systemd[1]: Stopped target Remote File Systems. Oct 28 13:16:07.492386 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 28 13:16:07.493837 systemd[1]: Stopped target Slice Units. Oct 28 13:16:07.495125 systemd[1]: Stopped target Socket Units. Oct 28 13:16:07.496644 systemd[1]: Stopped target System Initialization. Oct 28 13:16:07.497983 systemd[1]: Stopped target Local File Systems. Oct 28 13:16:07.499163 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 13:16:07.500765 systemd[1]: Stopped target Swaps. Oct 28 13:16:07.501963 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 28 13:16:07.502055 systemd[1]: Stopped dracut pre-mount hook. Oct 28 13:16:07.503627 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 13:16:07.504862 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 13:16:07.511877 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 13:16:07.513100 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 28 13:16:07.513198 systemd[1]: Stopped dracut initqueue hook. Oct 28 13:16:07.516740 iscsid[377]: iscsid shutting down. Oct 28 13:16:07.514929 systemd[1]: Stopping Open-iSCSI... Oct 28 13:16:07.516090 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 13:16:07.516189 systemd[1]: Stopped Apply Kernel Variables. Oct 28 13:16:07.517502 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 28 13:16:07.517584 systemd[1]: Stopped Coldplug All udev Devices. Oct 28 13:16:07.518767 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 28 13:16:07.518847 systemd[1]: Stopped dracut pre-trigger hook. Oct 28 13:16:07.520133 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 28 13:16:07.524382 systemd[1]: iscsid.service: Deactivated successfully. Oct 28 13:16:07.524487 systemd[1]: Stopped Open-iSCSI. Oct 28 13:16:07.526043 systemd[1]: iscsid.socket: Deactivated successfully. Oct 28 13:16:07.526085 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 28 13:16:07.527131 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 28 13:16:07.530157 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 28 13:16:07.539000 audit: BPF prog-id=9 op=UNLOAD Oct 28 13:16:07.530280 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 28 13:16:07.531554 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 28 13:16:07.531661 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 28 13:16:07.533580 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 28 13:16:07.533679 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 28 13:16:07.535608 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 28 13:16:07.535663 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 28 13:16:07.537152 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 28 13:16:07.537187 systemd[1]: Closed udev Control Socket. Oct 28 13:16:07.538465 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 28 13:16:07.538498 systemd[1]: Closed udev Kernel Socket. Oct 28 13:16:07.539884 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 28 13:16:07.539922 systemd[1]: Stopped dracut pre-udev hook. Oct 28 13:16:07.541325 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 28 13:16:07.541362 systemd[1]: Stopped dracut cmdline hook. Oct 28 13:16:07.542670 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 28 13:16:07.542709 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 28 13:16:07.544891 systemd[1]: Starting Cleanup udev Database... Oct 28 13:16:07.545964 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 28 13:16:07.564000 audit: BPF prog-id=12 op=UNLOAD Oct 28 13:16:07.547475 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 13:16:07.547520 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 13:16:07.549041 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 28 13:16:07.549081 systemd[1]: Stopped Create List of Static Device Nodes. Oct 28 13:16:07.550633 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 13:16:07.550685 systemd[1]: Stopped Setup Virtual Console. Oct 28 13:16:07.552137 systemd[1]: rngd.service: Deactivated successfully. Oct 28 13:16:07.552309 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 28 13:16:07.553866 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 28 13:16:07.553957 systemd[1]: Finished Cleanup udev Database. Oct 28 13:16:07.555077 systemd[1]: Reached target Switch Root. Oct 28 13:16:07.557075 systemd[1]: Starting Switch Root... Oct 28 13:16:07.562130 systemd[1]: Switching root. Oct 28 13:16:07.577382 systemd-journald[270]: Journal stopped Oct 28 13:16:09.602001 systemd-journald[270]: Received SIGTERM from PID 1 (systemd). Oct 28 13:16:09.602046 kernel: SELinux: policy capability network_peer_controls=1 Oct 28 13:16:09.602057 kernel: SELinux: policy capability open_perms=1 Oct 28 13:16:09.602072 kernel: SELinux: policy capability extended_socket_class=1 Oct 28 13:16:09.602085 kernel: SELinux: policy capability always_check_network=0 Oct 28 13:16:09.602094 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 28 13:16:09.602105 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 28 13:16:09.602114 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 28 13:16:09.602124 systemd[1]: Successfully loaded SELinux policy in 32.524ms. Oct 28 13:16:09.602137 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 5.908ms. Oct 28 13:16:09.602147 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 28 13:16:09.602158 systemd[1]: Detected virtualization kvm. Oct 28 13:16:09.602169 systemd[1]: Detected architecture arm64. Oct 28 13:16:09.602180 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 28 13:16:09.602205 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 28 13:16:09.602220 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 28 13:16:09.602230 systemd[1]: Stopped Switch Root. Oct 28 13:16:09.602240 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 28 13:16:09.602249 systemd[1]: Created slice Slice /system/addon-config. Oct 28 13:16:09.602259 systemd[1]: Created slice Slice /system/addon-run. Oct 28 13:16:09.602269 systemd[1]: Created slice Slice /system/getty. Oct 28 13:16:09.602278 systemd[1]: Created slice Slice /system/modprobe. Oct 28 13:16:09.602289 systemd[1]: Created slice Slice /system/serial-getty. Oct 28 13:16:09.602299 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 28 13:16:09.602309 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 28 13:16:09.602318 systemd[1]: Created slice User and Session Slice. Oct 28 13:16:09.602327 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 13:16:09.602337 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 28 13:16:09.602393 systemd[1]: Set up automount Boot partition Automount Point. Oct 28 13:16:09.602404 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 28 13:16:09.602414 systemd[1]: Stopped target Switch Root. Oct 28 13:16:09.602427 systemd[1]: Stopped target Initrd File Systems. Oct 28 13:16:09.602458 systemd[1]: Stopped target Initrd Root File System. Oct 28 13:16:09.602479 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 13:16:09.602494 systemd[1]: Reached target Remote File Systems. Oct 28 13:16:09.602507 systemd[1]: Reached target Slice Units. Oct 28 13:16:09.602536 systemd[1]: Reached target Swaps. Oct 28 13:16:09.602550 systemd[1]: Reached target Verify torcx succeeded. Oct 28 13:16:09.602565 systemd[1]: Reached target Local Verity Protected Volumes. Oct 28 13:16:09.602580 systemd[1]: Listening on Process Core Dump Socket. Oct 28 13:16:09.602589 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 28 13:16:09.602602 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 13:16:09.602612 systemd[1]: Listening on udev Control Socket. Oct 28 13:16:09.602622 systemd[1]: Listening on udev Kernel Socket. Oct 28 13:16:09.602641 systemd[1]: Mounting Huge Pages File System... Oct 28 13:16:09.602653 systemd[1]: Mounting POSIX Message Queue File System... Oct 28 13:16:09.602663 systemd[1]: Mounting External Media Directory... Oct 28 13:16:09.602693 systemd[1]: Mounting Kernel Debug File System... Oct 28 13:16:09.602710 systemd[1]: Mounting Kernel Trace File System... Oct 28 13:16:09.602720 systemd[1]: Mounting Temporary Directory /tmp... Oct 28 13:16:09.602730 systemd[1]: Starting Create missing system files... Oct 28 13:16:09.602741 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 13:16:09.602751 systemd[1]: Starting Load Kernel Module configfs... Oct 28 13:16:09.602762 systemd[1]: Starting Load Kernel Module drm... Oct 28 13:16:09.602777 systemd[1]: Starting Load Kernel Module fuse... Oct 28 13:16:09.602787 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 28 13:16:09.602797 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 28 13:16:09.602807 systemd[1]: Stopped File System Check on Root Device. Oct 28 13:16:09.602816 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 28 13:16:09.602826 systemd[1]: Stopped systemd-fsck-usr.service. Oct 28 13:16:09.602837 kernel: fuse: init (API version 7.32) Oct 28 13:16:09.602846 systemd[1]: Stopped Journal Service. Oct 28 13:16:09.602856 systemd[1]: Starting Journal Service... Oct 28 13:16:09.602865 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 13:16:09.602875 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 28 13:16:09.602884 systemd[1]: Starting Apply Kernel Variables... Oct 28 13:16:09.602894 systemd[1]: Starting Coldplug All udev Devices... Oct 28 13:16:09.602904 systemd[1]: verity-setup.service: Deactivated successfully. Oct 28 13:16:09.602913 systemd[1]: Stopped verity-setup.service. Oct 28 13:16:09.602924 systemd-journald[694]: Journal started Oct 28 13:16:09.602964 systemd-journald[694]: Runtime Journal (/run/log/journal/fd7e443d971541c8942fa565c71b6154) is 6.0M, max 48.5M, 42.4M free. Oct 28 13:16:07.646000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 28 13:16:07.673000 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 28 13:16:07.673000 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 28 13:16:07.673000 audit: BPF prog-id=15 op=LOAD Oct 28 13:16:07.673000 audit: BPF prog-id=15 op=UNLOAD Oct 28 13:16:07.673000 audit: BPF prog-id=16 op=LOAD Oct 28 13:16:07.673000 audit: BPF prog-id=16 op=UNLOAD Oct 28 13:16:07.704000 audit[647]: AVC avc: denied { associate } for pid=647 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 28 13:16:09.479000 audit: BPF prog-id=17 op=LOAD Oct 28 13:16:09.479000 audit: BPF prog-id=18 op=LOAD Oct 28 13:16:09.479000 audit: BPF prog-id=19 op=LOAD Oct 28 13:16:09.479000 audit: BPF prog-id=13 op=UNLOAD Oct 28 13:16:09.479000 audit: BPF prog-id=14 op=UNLOAD Oct 28 13:16:09.490000 audit: BPF prog-id=20 op=LOAD Oct 28 13:16:09.490000 audit: BPF prog-id=17 op=UNLOAD Oct 28 13:16:09.490000 audit: BPF prog-id=21 op=LOAD Oct 28 13:16:09.490000 audit: BPF prog-id=22 op=LOAD Oct 28 13:16:09.490000 audit: BPF prog-id=18 op=UNLOAD Oct 28 13:16:09.490000 audit: BPF prog-id=19 op=UNLOAD Oct 28 13:16:09.490000 audit: BPF prog-id=23 op=LOAD Oct 28 13:16:09.490000 audit: BPF prog-id=20 op=UNLOAD Oct 28 13:16:09.490000 audit: BPF prog-id=24 op=LOAD Oct 28 13:16:09.490000 audit: BPF prog-id=25 op=LOAD Oct 28 13:16:09.490000 audit: BPF prog-id=21 op=UNLOAD Oct 28 13:16:09.490000 audit: BPF prog-id=22 op=UNLOAD Oct 28 13:16:09.502000 audit: BPF prog-id=23 op=UNLOAD Oct 28 13:16:09.588000 audit: BPF prog-id=26 op=LOAD Oct 28 13:16:09.588000 audit: BPF prog-id=27 op=LOAD Oct 28 13:16:09.588000 audit: BPF prog-id=28 op=LOAD Oct 28 13:16:09.588000 audit: BPF prog-id=24 op=UNLOAD Oct 28 13:16:09.588000 audit: BPF prog-id=25 op=UNLOAD Oct 28 13:16:09.600000 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 28 13:16:09.479122 systemd[1]: Queued start job for default target Multi-User System. Oct 28 13:16:07.702935 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3033.2.4 /usr/share/oem/torcx/store /var/lib/torcx/store/3033.2.4 /var/lib/torcx/store]" Oct 28 13:16:09.491445 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 28 13:16:07.703237 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 13:16:07.703256 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 13:16:07.703582 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 28 13:16:07.703595 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 28 13:16:07.703630 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 28 13:16:07.703652 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 28 13:16:07.704124 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 28 13:16:07.704176 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 13:16:07.704204 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 13:16:07.704547 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Oct 28 13:16:07.704581 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Oct 28 13:16:07.704600 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3033.2.4: no such file or directory" path=/usr/share/oem/torcx/store/3033.2.4 Oct 28 13:16:07.704616 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 28 13:16:09.604785 systemd[1]: Started Journal Service. Oct 28 13:16:07.704718 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3033.2.4: no such file or directory" path=/var/lib/torcx/store/3033.2.4 Oct 28 13:16:07.704734 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:07Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 28 13:16:09.394681 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:09Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 13:16:09.394939 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:09Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 13:16:09.395045 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:09Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 13:16:09.395233 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:09Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 13:16:09.395327 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:09Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 28 13:16:09.395385 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-28T13:16:09Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Oct 28 13:16:09.605299 systemd[1]: Mounted Huge Pages File System. Oct 28 13:16:09.606151 systemd[1]: Mounted POSIX Message Queue File System. Oct 28 13:16:09.607183 systemd[1]: Mounted External Media Directory. Oct 28 13:16:09.608079 systemd[1]: Mounted Kernel Debug File System. Oct 28 13:16:09.609038 systemd[1]: Mounted Kernel Trace File System. Oct 28 13:16:09.609982 systemd[1]: Mounted Temporary Directory /tmp. Oct 28 13:16:09.611134 systemd[1]: Finished Create missing system files. Oct 28 13:16:09.612354 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 13:16:09.613441 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 28 13:16:09.613615 systemd[1]: Finished Load Kernel Module configfs. Oct 28 13:16:09.614683 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 13:16:09.614858 systemd[1]: Finished Load Kernel Module drm. Oct 28 13:16:09.615897 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 28 13:16:09.616072 systemd[1]: Finished Load Kernel Module fuse. Oct 28 13:16:09.617189 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 28 13:16:09.618428 systemd[1]: Finished Apply Kernel Variables. Oct 28 13:16:09.638728 systemd[1]: Mounting FUSE Control File System... Oct 28 13:16:09.640550 systemd[1]: Mounting Kernel Configuration File System... Oct 28 13:16:09.641405 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 28 13:16:09.642278 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 28 13:16:09.643187 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 28 13:16:09.644099 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 28 13:16:09.645021 systemd[1]: Starting Load/Save Random Seed... Oct 28 13:16:09.648492 systemd-journald[694]: Time spent on flushing to /var/log/journal/fd7e443d971541c8942fa565c71b6154 is 11.509ms for 666 entries. Oct 28 13:16:09.648492 systemd-journald[694]: System Journal (/var/log/journal/fd7e443d971541c8942fa565c71b6154) is 8.0M, max 203.0M, 195.0M free. Oct 28 13:16:09.669000 audit: BPF prog-id=29 op=LOAD Oct 28 13:16:09.669000 audit: BPF prog-id=30 op=LOAD Oct 28 13:16:09.669000 audit: BPF prog-id=31 op=LOAD Oct 28 13:16:09.669000 audit: BPF prog-id=10 op=UNLOAD Oct 28 13:16:09.669000 audit: BPF prog-id=11 op=UNLOAD Oct 28 13:16:09.645890 systemd[1]: Condition check resulted in Create System Users being skipped. Oct 28 13:16:09.646927 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 13:16:09.648620 systemd[1]: Mounted FUSE Control File System. Oct 28 13:16:09.650848 systemd[1]: Mounted Kernel Configuration File System. Oct 28 13:16:09.653392 systemd[1]: Finished Load/Save Random Seed. Oct 28 13:16:09.654751 systemd[1]: Condition check resulted in First Boot Complete being skipped. Oct 28 13:16:09.657358 systemd[1]: Finished Coldplug All udev Devices. Oct 28 13:16:09.666065 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 28 13:16:09.667947 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 13:16:09.670364 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 13:16:09.672234 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 28 13:16:09.695231 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 13:16:09.697000 audit: BPF prog-id=32 op=LOAD Oct 28 13:16:09.698576 systemd[1]: Starting Network Configuration... Oct 28 13:16:09.724443 systemd-networkd[717]: lo: Link UP Oct 28 13:16:09.724452 systemd-networkd[717]: lo: Gained carrier Oct 28 13:16:09.724758 systemd-networkd[717]: Enumeration completed Oct 28 13:16:09.724843 systemd[1]: Started Network Configuration. Oct 28 13:16:09.739280 systemd-udevd[724]: Using default interface naming scheme 'v249'. Oct 28 13:16:09.759520 udevadm[707]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 28 13:16:09.773517 systemd-networkd[717]: eth0: Link UP Oct 28 13:16:09.779484 systemd-networkd[717]: eth0: Gained carrier Oct 28 13:16:09.789534 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 28 13:16:09.799760 systemd-networkd[717]: eth0: DHCPv4 address 10.0.0.4/16 via 10.0.0.1 Oct 28 13:16:09.809931 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 13:16:09.819172 lvm[735]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 13:16:09.847143 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 13:16:09.848284 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 13:16:09.867364 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 13:16:09.870912 lvm[736]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 13:16:09.901946 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 13:16:09.903332 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 13:16:09.904423 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 28 13:16:09.904449 systemd[1]: Reached target Containers. Oct 28 13:16:09.915659 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 28 13:16:09.926896 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 28 13:16:09.928981 systemd[1]: Mounting /usr/share/oem... Oct 28 13:16:09.935215 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 13:16:09.935266 kernel: BTRFS info (device vda6): has skinny extents Oct 28 13:16:09.937391 systemd[1]: Mounted /usr/share/oem. Oct 28 13:16:09.938173 systemd[1]: Reached target Local File Systems. Oct 28 13:16:09.939072 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Oct 28 13:16:09.939431 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 28 13:16:09.939466 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 28 13:16:09.939494 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 28 13:16:09.954824 systemd[1]: Starting Create Volatile Files and Directories... Oct 28 13:16:09.960899 systemd-tmpfiles[759]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 28 13:16:09.962037 systemd-tmpfiles[759]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 28 13:16:09.988568 systemd-tmpfiles[759]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 13:16:09.988579 systemd-tmpfiles[759]: Skipping /boot Oct 28 13:16:09.993977 systemd-tmpfiles[759]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 13:16:09.993997 systemd-tmpfiles[759]: Skipping /boot Oct 28 13:16:10.021965 systemd[1]: Finished Create Volatile Files and Directories. Oct 28 13:16:10.031094 systemd[1]: Starting Load Security Auditing Rules... Oct 28 13:16:10.032861 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 28 13:16:10.034065 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Oct 28 13:16:10.034000 audit: BPF prog-id=33 op=LOAD Oct 28 13:16:10.035424 systemd[1]: Starting Network Name Resolution... Oct 28 13:16:10.036000 audit: BPF prog-id=34 op=LOAD Oct 28 13:16:10.037538 systemd[1]: Starting Network Time Synchronization... Oct 28 13:16:10.038409 systemd[1]: Condition check resulted in Update is Completed being skipped. Oct 28 13:16:10.039319 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 28 13:16:10.040734 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 28 13:16:10.042046 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 28 13:16:10.049517 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 28 13:16:10.053967 augenrules[780]: No rules Oct 28 13:16:10.053000 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 28 13:16:10.064507 systemd[1]: Finished Load Security Auditing Rules. Oct 28 13:16:10.072644 systemd-resolved[763]: Positive Trust Anchors: Oct 28 13:16:10.072657 systemd-resolved[763]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 13:16:10.072684 systemd-resolved[763]: 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 28 13:16:09.046237 systemd-resolved[763]: Defaulting to hostname 'linux'. Oct 28 13:16:09.046265 systemd-timesyncd[769]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 28 13:16:09.051109 systemd[1]: Started Network Time Synchronization. Oct 28 13:16:09.052230 systemd[1]: Started Network Name Resolution. Oct 28 13:16:09.053236 systemd[1]: Reached target Network. Oct 28 13:16:09.054057 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 13:16:09.056648 systemd[1]: Reached target System Initialization. Oct 28 13:16:09.057658 systemd[1]: Started Watch for update engine configuration changes. Oct 28 13:16:09.058943 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 13:16:09.060098 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 28 13:16:09.061088 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 28 13:16:09.061122 systemd[1]: Reached target Path Units. Oct 28 13:16:09.061830 systemd[1]: Reached target System Time Set. Oct 28 13:16:09.062915 systemd[1]: Started Daily Log Rotation. Oct 28 13:16:09.063827 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 28 13:16:09.064964 systemd[1]: Reached target Timer Units. Oct 28 13:16:09.066097 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 28 13:16:09.085402 systemd[1]: Starting Docker Socket for the API... Oct 28 13:16:09.089277 systemd[1]: Listening on OpenSSH Server Socket. Oct 28 13:16:09.090565 systemd[1]: Listening on Docker Socket for the API. Oct 28 13:16:09.091548 systemd[1]: Reached target Socket Units. Oct 28 13:16:09.092334 systemd[1]: Reached target Basic System. Oct 28 13:16:09.093130 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 28 13:16:09.093161 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 28 13:16:09.094017 systemd[1]: Started D-Bus System Message Bus. Oct 28 13:16:09.097007 systemd[1]: Starting Extend Filesystems... Oct 28 13:16:09.097836 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 28 13:16:09.098790 systemd[1]: Starting Generate /run/flatcar/motd... Oct 28 13:16:09.100611 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 28 13:16:09.102638 systemd[1]: Starting Generate sshd host keys... Oct 28 13:16:09.106537 extend-filesystems[791]: Found vda Oct 28 13:16:09.107375 extend-filesystems[791]: Found vda1 Oct 28 13:16:09.107375 extend-filesystems[791]: Found vda2 Oct 28 13:16:09.107375 extend-filesystems[791]: Found vda3 Oct 28 13:16:09.107375 extend-filesystems[791]: Found usr Oct 28 13:16:09.107375 extend-filesystems[791]: Found vda4 Oct 28 13:16:09.107375 extend-filesystems[791]: Found vda6 Oct 28 13:16:09.107375 extend-filesystems[791]: Found vda7 Oct 28 13:16:09.107375 extend-filesystems[791]: Found vda9 Oct 28 13:16:09.107375 extend-filesystems[791]: Checking size of /dev/vda9 Oct 28 13:16:09.106840 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 28 13:16:09.106867 systemd[1]: Reached target Load system-provided cloud configs. Oct 28 13:16:09.114697 systemd[1]: Starting User Login Management... Oct 28 13:16:09.116187 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 28 13:16:09.116816 systemd[1]: Starting Update Engine... Oct 28 13:16:09.117657 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 28 13:16:09.117681 systemd[1]: Reached target Load user-provided cloud configs. Oct 28 13:16:09.119360 systemd[1]: motdgen.service: Deactivated successfully. Oct 28 13:16:09.119594 systemd[1]: Finished Generate /run/flatcar/motd. Oct 28 13:16:09.120709 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 28 13:16:09.120933 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 28 13:16:09.137542 extend-filesystems[791]: Old size kept for /dev/vda9 Oct 28 13:16:09.138049 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 28 13:16:09.138283 systemd[1]: Finished Extend Filesystems. Oct 28 13:16:09.147849 systemd-logind[808]: Watching system buttons on /dev/input/event0 (Power Button) Oct 28 13:16:09.148057 systemd-logind[808]: New seat seat0. Oct 28 13:16:09.149654 systemd[1]: Started User Login Management. Oct 28 13:16:09.164813 update_engine[809]: I1028 13:16:09.164513 809 main.cc:89] Flatcar Update Engine starting Oct 28 13:16:09.165846 update_engine[809]: I1028 13:16:09.165825 809 payload_state.cc:360] Current Response Signature = Oct 28 13:16:09.165846 update_engine[809]: NumURLs = 1 Oct 28 13:16:09.165846 update_engine[809]: Url0 = http://10.0.0.3:34567/packages/update.gz Oct 28 13:16:09.165846 update_engine[809]: Payload Size = 435526319 Oct 28 13:16:09.165846 update_engine[809]: Payload Sha256 Hash = MWe7Cz0hHAZPhG3RiToog9DXtPRhV9ko4O7ML90dZWg= Oct 28 13:16:09.165846 update_engine[809]: Is Delta Payload = 0 Oct 28 13:16:09.165846 update_engine[809]: Max Failure Count Per Url = 10 Oct 28 13:16:09.165846 update_engine[809]: Disable Payload Backoff = 1 Oct 28 13:16:09.166377 update_engine[809]: I1028 13:16:09.166357 809 payload_state.cc:381] Payload Attempt Number = 0 Oct 28 13:16:09.166501 systemd[1]: Finished Generate sshd host keys. Oct 28 13:16:09.166774 update_engine[809]: I1028 13:16:09.166755 809 payload_state.cc:404] Current URL Index = 0 Oct 28 13:16:09.167094 update_engine[809]: I1028 13:16:09.167078 809 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 28 13:16:09.167409 update_engine[809]: I1028 13:16:09.167376 809 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 28 13:16:09.169390 update_engine[809]: I1028 13:16:09.169363 809 update_check_scheduler.cc:74] Next update check in 8m23s Oct 28 13:16:09.184445 systemd[1]: Starting Generate /run/issue... Oct 28 13:16:09.185750 systemd[1]: Started Update Engine. Oct 28 13:16:09.188929 systemd[1]: issuegen.service: Deactivated successfully. Oct 28 13:16:09.189174 systemd[1]: Finished Generate /run/issue. Oct 28 13:16:09.191192 systemd[1]: Starting Permit User Sessions... Oct 28 13:16:09.195422 systemd[1]: Finished Permit User Sessions. Oct 28 13:16:09.197423 systemd[1]: Started Getty on tty1. Oct 28 13:16:09.199350 systemd[1]: Started Serial Getty on ttyAMA0. Oct 28 13:16:09.200329 systemd[1]: Reached target Login Prompts. Oct 28 13:16:09.201206 systemd[1]: Reached target Multi-User System. Oct 28 13:16:09.203174 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 28 13:16:09.207727 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 28 13:16:09.207937 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 28 13:16:09.209000 systemd[1]: Startup finished in 685ms (kernel) + 1.056s (initrd) + 2.623s (userspace) = 4.364s. Oct 28 13:16:09.931525 systemd-networkd[717]: eth0: Gained IPv6LL Oct 28 13:16:18.961478 systemd[1]: Created slice Slice /system/sshd. Oct 28 13:16:18.962688 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38782). Oct 28 13:16:19.005557 sshd[830]: Accepted publickey for core from 10.0.0.1 port 38782 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:16:19.007754 sshd[830]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:16:19.026308 systemd[1]: Created slice User Slice of UID 500. Oct 28 13:16:19.027701 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 28 13:16:19.029657 systemd-logind[808]: New session 1 of user core. Oct 28 13:16:19.033731 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 28 13:16:19.034828 systemd[1]: Starting User Manager for UID 500... Oct 28 13:16:19.036943 systemd[833]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:16:19.086657 systemd[833]: Queued start job for default target Main User Target. Oct 28 13:16:19.086795 systemd[833]: Reached target Paths. Oct 28 13:16:19.086809 systemd[833]: Reached target Sockets. Oct 28 13:16:19.086820 systemd[833]: Reached target Timers. Oct 28 13:16:19.086830 systemd[833]: Reached target Basic System. Oct 28 13:16:19.086875 systemd[833]: Reached target Main User Target. Oct 28 13:16:19.086887 systemd[833]: Startup finished in 46ms. Oct 28 13:16:19.087158 systemd[1]: Started User Manager for UID 500. Oct 28 13:16:19.102286 systemd[1]: Started Session 1 of User core. Oct 28 13:16:19.167333 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38794). Oct 28 13:16:19.207740 sshd[842]: Accepted publickey for core from 10.0.0.1 port 38794 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:16:19.208975 sshd[842]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:16:19.211552 systemd-logind[808]: New session 2 of user core. Oct 28 13:16:19.227425 systemd[1]: Started Session 2 of User core. Oct 28 13:16:19.281896 sshd[842]: pam_unix(sshd:session): session closed for user core Oct 28 13:16:19.298195 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54734). Oct 28 13:16:19.298626 systemd[1]: sshd@1-10.0.0.4:22-10.0.0.1:38794.service: Deactivated successfully. Oct 28 13:16:19.299279 systemd[1]: session-2.scope: Deactivated successfully. Oct 28 13:16:19.299818 systemd-logind[808]: Session 2 logged out. Waiting for processes to exit. Oct 28 13:16:19.300414 systemd-logind[808]: Removed session 2. Oct 28 13:16:19.337936 sshd[847]: Accepted publickey for core from 10.0.0.1 port 54734 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:16:19.339134 sshd[847]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:16:19.341651 systemd-logind[808]: New session 3 of user core. Oct 28 13:16:19.357274 systemd[1]: Started Session 3 of User core. Oct 28 13:16:19.406256 sshd[847]: pam_unix(sshd:session): session closed for user core Oct 28 13:16:19.419424 systemd[1]: sshd@2-10.0.0.4:22-10.0.0.1:54734.service: Deactivated successfully. Oct 28 13:16:19.419993 systemd[1]: session-3.scope: Deactivated successfully. Oct 28 13:16:19.420539 systemd-logind[808]: Session 3 logged out. Waiting for processes to exit. Oct 28 13:16:19.421439 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54746). Oct 28 13:16:19.421860 systemd-logind[808]: Removed session 3. Oct 28 13:16:19.458377 sshd[855]: Accepted publickey for core from 10.0.0.1 port 54746 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:16:19.459525 sshd[855]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:16:19.461757 systemd-logind[808]: New session 4 of user core. Oct 28 13:16:19.471418 systemd[1]: Started Session 4 of User core. Oct 28 13:16:19.523790 sshd[855]: pam_unix(sshd:session): session closed for user core Oct 28 13:16:19.539811 systemd[1]: sshd@3-10.0.0.4:22-10.0.0.1:54746.service: Deactivated successfully. Oct 28 13:16:19.540606 systemd[1]: session-4.scope: Deactivated successfully. Oct 28 13:16:19.541270 systemd-logind[808]: Session 4 logged out. Waiting for processes to exit. Oct 28 13:16:19.542813 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54756). Oct 28 13:16:19.543589 systemd-logind[808]: Removed session 4. Oct 28 13:16:19.585541 sshd[861]: Accepted publickey for core from 10.0.0.1 port 54756 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:16:19.587370 sshd[861]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:16:19.589910 systemd-logind[808]: New session 5 of user core. Oct 28 13:16:19.600428 systemd[1]: Started Session 5 of User core. Oct 28 13:16:19.658469 sudo[864]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 28 13:16:19.658869 sudo[864]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:16:19.670636 sudo[864]: pam_unix(sudo:session): session closed for user root Oct 28 13:16:19.672240 sshd[861]: pam_unix(sshd:session): session closed for user core Oct 28 13:16:19.694118 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54758). Oct 28 13:16:19.696847 dbus-daemon[790]: [system] Reloaded configuration Oct 28 13:16:19.699510 systemd[1]: sshd@4-10.0.0.4:22-10.0.0.1:54756.service: Deactivated successfully. Oct 28 13:16:19.700089 systemd[1]: session-5.scope: Deactivated successfully. Oct 28 13:16:19.700710 systemd-logind[808]: Session 5 logged out. Waiting for processes to exit. Oct 28 13:16:19.701502 systemd-logind[808]: Removed session 5. Oct 28 13:16:19.733542 sshd[867]: Accepted publickey for core from 10.0.0.1 port 54758 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:16:19.734895 sshd[867]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:16:19.737435 systemd-logind[808]: New session 6 of user core. Oct 28 13:16:19.748148 systemd[1]: Started Session 6 of User core. Oct 28 13:16:19.800074 sudo[872]: 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 28 13:16:19.800268 sudo[872]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:16:19.802649 sudo[872]: pam_unix(sudo:session): session closed for user root Oct 28 13:16:19.806198 sudo[871]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 28 13:16:19.806398 sudo[871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:16:19.824368 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 13:16:19.824000 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 28 13:16:19.826153 auditctl[875]: No rules Oct 28 13:16:19.826394 kernel: kauditd_printk_skb: 49 callbacks suppressed Oct 28 13:16:19.826428 kernel: audit: type=1305 audit(1761657379.824:60): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 28 13:16:19.826448 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 13:16:19.826688 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 13:16:19.828059 systemd[1]: Starting Load Security Auditing Rules... Oct 28 13:16:19.841916 augenrules[892]: No rules Oct 28 13:16:19.842582 systemd[1]: Finished Load Security Auditing Rules. Oct 28 13:16:19.843620 sudo[871]: pam_unix(sudo:session): session closed for user root Oct 28 13:16:19.844797 sshd[867]: pam_unix(sshd:session): session closed for user core Oct 28 13:16:19.855743 systemd[1]: sshd@5-10.0.0.4:22-10.0.0.1:54758.service: Deactivated successfully. Oct 28 13:16:19.856311 systemd[1]: session-6.scope: Deactivated successfully. Oct 28 13:16:19.856891 systemd-logind[808]: Session 6 logged out. Waiting for processes to exit. Oct 28 13:16:19.857837 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54774). Oct 28 13:16:19.859188 systemd-logind[808]: Removed session 6. Oct 28 13:16:19.898270 sshd[898]: Accepted publickey for core from 10.0.0.1 port 54774 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:16:19.899199 sshd[898]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:16:19.901040 kernel: audit: type=1006 audit(1761657379.897:61): pid=898 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 28 13:16:19.903505 systemd-logind[808]: New session 7 of user core. Oct 28 13:16:19.921056 systemd[1]: Started Session 7 of User core. Oct 28 13:16:19.971092 sshd[898]: pam_unix(sshd:session): session closed for user core Oct 28 13:16:19.986535 systemd[1]: sshd@6-10.0.0.4:22-10.0.0.1:54774.service: Deactivated successfully. Oct 28 13:16:19.987060 systemd[1]: session-7.scope: Deactivated successfully. Oct 28 13:16:19.987627 systemd-logind[808]: Session 7 logged out. Waiting for processes to exit. Oct 28 13:16:19.988543 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54786). Oct 28 13:16:19.989188 systemd-logind[808]: Removed session 7. Oct 28 13:16:20.027489 sshd[904]: Accepted publickey for core from 10.0.0.1 port 54786 ssh2: RSA SHA256:vC1VMl2NL/J5oejjNEyxRsWcjctkl6dL9Gnf09jx1Ao Oct 28 13:16:20.029012 sshd[904]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:16:20.032052 kernel: audit: type=1006 audit(1761657380.027:62): pid=904 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 28 13:16:20.033730 systemd-logind[808]: New session 8 of user core. Oct 28 13:16:20.051324 systemd[1]: Started Session 8 of User core. Oct 28 13:16:20.102095 sshd[904]: pam_unix(sshd:session): session closed for user core Oct 28 13:16:20.104202 systemd[1]: sshd@7-10.0.0.4:22-10.0.0.1:54786.service: Deactivated successfully. Oct 28 13:16:20.104828 systemd[1]: session-8.scope: Deactivated successfully. Oct 28 13:16:20.105493 systemd-logind[808]: Session 8 logged out. Waiting for processes to exit. Oct 28 13:16:20.106064 systemd-logind[808]: Removed session 8.