Oct 28 13:08:37.673879 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 28 13:08:37.673897 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:08:37.673906 kernel: efi: EFI v2.70 by EDK II Oct 28 13:08:37.673912 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 28 13:08:37.673916 kernel: efi: seeding entropy pool Oct 28 13:08:37.673921 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 28 13:08:37.673927 kernel: ACPI: Early table checksum verification disabled Oct 28 13:08:37.673932 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 28 13:08:37.673937 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 28 13:08:37.673942 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:08:37.673948 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:08:37.673953 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:08:37.674028 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:08:37.674034 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:08:37.674041 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:08:37.674046 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:08:37.674053 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:08:37.674059 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:08:37.674064 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 28 13:08:37.674069 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 28 13:08:37.674074 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:08:37.674080 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 28 13:08:37.674085 kernel: Zone ranges: Oct 28 13:08:37.674090 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:08:37.674096 kernel: DMA32 empty Oct 28 13:08:37.674101 kernel: Normal empty Oct 28 13:08:37.674106 kernel: Movable zone start for each node Oct 28 13:08:37.674112 kernel: Early memory node ranges Oct 28 13:08:37.674117 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 28 13:08:37.674122 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 28 13:08:37.674128 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 28 13:08:37.674133 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 28 13:08:37.674138 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 28 13:08:37.674143 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 28 13:08:37.674148 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 28 13:08:37.674154 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 28 13:08:37.674159 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 28 13:08:37.674164 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 28 13:08:37.674169 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 28 13:08:37.674174 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:08:37.674182 kernel: On node 0 totalpages: 643072 Oct 28 13:08:37.674188 kernel: DMA zone: 10048 pages used for memmap Oct 28 13:08:37.674194 kernel: DMA zone: 0 pages reserved Oct 28 13:08:37.674199 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 28 13:08:37.674204 kernel: psci: probing for conduit method from ACPI. Oct 28 13:08:37.674210 kernel: psci: PSCIv1.1 detected in firmware. Oct 28 13:08:37.674215 kernel: psci: Using standard PSCI v0.2 function IDs Oct 28 13:08:37.674221 kernel: psci: Trusted OS migration not required Oct 28 13:08:37.674227 kernel: psci: SMC Calling Convention v1.1 Oct 28 13:08:37.674233 kernel: ACPI: SRAT not present Oct 28 13:08:37.674238 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 28 13:08:37.674244 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 28 13:08:37.674249 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 28 13:08:37.674255 kernel: Detected PIPT I-cache on CPU0 Oct 28 13:08:37.674260 kernel: CPU features: detected: GIC system register CPU interface Oct 28 13:08:37.674266 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 28 13:08:37.674271 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 28 13:08:37.674277 kernel: CPU features: detected: Hardware dirty bit management Oct 28 13:08:37.674282 kernel: CPU features: detected: Spectre-v4 Oct 28 13:08:37.674289 kernel: CPU features: detected: ARM erratum 1418040 Oct 28 13:08:37.674294 kernel: CPU features: detected: Spectre-BHB Oct 28 13:08:37.674300 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 28 13:08:37.674305 kernel: Policy zone: DMA Oct 28 13:08:37.674312 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:08:37.674318 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 28 13:08:37.674324 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 28 13:08:37.674329 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 28 13:08:37.674335 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 28 13:08:37.674341 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 28 13:08:37.674347 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 28 13:08:37.674353 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 28 13:08:37.674359 kernel: rcu: RCU event tracing is enabled. Oct 28 13:08:37.674365 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 28 13:08:37.674371 kernel: Trampoline variant of Tasks RCU enabled. Oct 28 13:08:37.674377 kernel: Tracing variant of Tasks RCU enabled. Oct 28 13:08:37.674382 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 28 13:08:37.674388 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 28 13:08:37.674393 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 28 13:08:37.674399 kernel: GICv3: 256 SPIs implemented Oct 28 13:08:37.674404 kernel: GICv3: 0 Extended SPIs implemented Oct 28 13:08:37.674410 kernel: GICv3: Distributor has no Range Selector support Oct 28 13:08:37.674415 kernel: GICv3: 16 PPIs implemented Oct 28 13:08:37.674422 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 28 13:08:37.674427 kernel: ACPI: SRAT not present Oct 28 13:08:37.674432 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 28 13:08:37.674438 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 28 13:08:37.674444 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 28 13:08:37.674449 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 28 13:08:37.674455 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 28 13:08:37.674461 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:08:37.674466 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 28 13:08:37.674472 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 28 13:08:37.674478 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 28 13:08:37.674484 kernel: arm-pv: using stolen time PV Oct 28 13:08:37.674490 kernel: Console: colour dummy device 80x25 Oct 28 13:08:37.674496 kernel: ACPI: Core revision 20200925 Oct 28 13:08:37.674502 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 28 13:08:37.674508 kernel: pid_max: default: 32768 minimum: 301 Oct 28 13:08:37.674514 kernel: LSM: Security Framework initializing Oct 28 13:08:37.674519 kernel: SELinux: Initializing. Oct 28 13:08:37.674525 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 13:08:37.674531 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 13:08:37.674537 kernel: rcu: Hierarchical SRCU implementation. Oct 28 13:08:37.674543 kernel: Platform MSI: ITS@0x8080000 domain created Oct 28 13:08:37.674549 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 28 13:08:37.674555 kernel: Remapping and enabling EFI services. Oct 28 13:08:37.674561 kernel: smp: Bringing up secondary CPUs ... Oct 28 13:08:37.674566 kernel: Detected PIPT I-cache on CPU1 Oct 28 13:08:37.674572 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 28 13:08:37.674578 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 28 13:08:37.674584 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:08:37.674590 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 28 13:08:37.674596 kernel: Detected PIPT I-cache on CPU2 Oct 28 13:08:37.674602 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 28 13:08:37.674608 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 28 13:08:37.674614 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:08:37.674620 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 28 13:08:37.674626 kernel: Detected PIPT I-cache on CPU3 Oct 28 13:08:37.674635 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 28 13:08:37.674641 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 28 13:08:37.674648 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:08:37.674654 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 28 13:08:37.674660 kernel: smp: Brought up 1 node, 4 CPUs Oct 28 13:08:37.674666 kernel: SMP: Total of 4 processors activated. Oct 28 13:08:37.674672 kernel: CPU features: detected: Privileged Access Never Oct 28 13:08:37.674678 kernel: CPU features: detected: LSE atomic instructions Oct 28 13:08:37.674684 kernel: CPU features: detected: User Access Override Oct 28 13:08:37.674690 kernel: CPU features: detected: 32-bit EL0 Support Oct 28 13:08:37.674696 kernel: CPU features: detected: Common not Private translations Oct 28 13:08:37.674702 kernel: CPU features: detected: RAS Extension Support Oct 28 13:08:37.674709 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 28 13:08:37.674715 kernel: CPU features: detected: CRC32 instructions Oct 28 13:08:37.674721 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 28 13:08:37.674727 kernel: CPU: All CPU(s) started at EL1 Oct 28 13:08:37.674733 kernel: alternatives: patching kernel code Oct 28 13:08:37.674740 kernel: devtmpfs: initialized Oct 28 13:08:37.674746 kernel: KASLR enabled Oct 28 13:08:37.674752 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 28 13:08:37.674758 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 28 13:08:37.674764 kernel: pinctrl core: initialized pinctrl subsystem Oct 28 13:08:37.674770 kernel: SMBIOS 3.0.0 present. Oct 28 13:08:37.674776 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 28 13:08:37.674782 kernel: NET: Registered protocol family 16 Oct 28 13:08:37.674788 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 28 13:08:37.674794 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 28 13:08:37.674801 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 28 13:08:37.674807 kernel: audit: initializing netlink subsys (disabled) Oct 28 13:08:37.674814 kernel: audit: type=2000 audit(0.029:1): state=initialized audit_enabled=0 res=1 Oct 28 13:08:37.674820 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 28 13:08:37.674826 kernel: cpuidle: using governor menu Oct 28 13:08:37.674832 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 28 13:08:37.674838 kernel: ASID allocator initialised with 32768 entries Oct 28 13:08:37.674844 kernel: ACPI: bus type PCI registered Oct 28 13:08:37.674850 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 28 13:08:37.674857 kernel: Serial: AMBA PL011 UART driver Oct 28 13:08:37.674863 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 28 13:08:37.674876 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 28 13:08:37.674884 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 28 13:08:37.674890 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 28 13:08:37.674896 kernel: cryptd: max_cpu_qlen set to 1000 Oct 28 13:08:37.674902 kernel: ACPI: Added _OSI(Module Device) Oct 28 13:08:37.674908 kernel: ACPI: Added _OSI(Processor Device) Oct 28 13:08:37.674914 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 28 13:08:37.674922 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 28 13:08:37.674928 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 28 13:08:37.674934 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 28 13:08:37.674940 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 28 13:08:37.674946 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 28 13:08:37.674952 kernel: ACPI: Interpreter enabled Oct 28 13:08:37.674964 kernel: ACPI: Using GIC for interrupt routing Oct 28 13:08:37.674971 kernel: ACPI: MCFG table detected, 1 entries Oct 28 13:08:37.674977 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 28 13:08:37.674983 kernel: printk: console [ttyAMA0] enabled Oct 28 13:08:37.674990 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 28 13:08:37.675090 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 28 13:08:37.675148 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 28 13:08:37.675202 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 28 13:08:37.675254 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 28 13:08:37.675311 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 28 13:08:37.675319 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 28 13:08:37.675327 kernel: PCI host bridge to bus 0000:00 Oct 28 13:08:37.675392 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 28 13:08:37.675441 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 28 13:08:37.675488 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 28 13:08:37.675537 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 28 13:08:37.675605 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 28 13:08:37.675668 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 28 13:08:37.675728 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 28 13:08:37.675784 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 28 13:08:37.675838 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 13:08:37.675903 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 13:08:37.675967 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 28 13:08:37.676023 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 28 13:08:37.676071 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 28 13:08:37.676120 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 28 13:08:37.676168 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 28 13:08:37.676177 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 28 13:08:37.676183 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 28 13:08:37.676189 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 28 13:08:37.676195 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 28 13:08:37.676201 kernel: vgaarb: loaded Oct 28 13:08:37.676207 kernel: Registered efivars operations Oct 28 13:08:37.676213 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 28 13:08:37.676220 kernel: VFS: Disk quotas dquot_6.6.0 Oct 28 13:08:37.676227 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 28 13:08:37.676233 kernel: pnp: PnP ACPI init Oct 28 13:08:37.676294 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 28 13:08:37.676343 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 28 13:08:37.676351 kernel: pnp: PnP ACPI: found 1 devices Oct 28 13:08:37.676357 kernel: NET: Registered protocol family 2 Oct 28 13:08:37.676364 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 28 13:08:37.676371 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 28 13:08:37.676377 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 28 13:08:37.676384 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 28 13:08:37.676390 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 28 13:08:37.676396 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 13:08:37.676402 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 13:08:37.676408 kernel: NET: Registered protocol family 1 Oct 28 13:08:37.676414 kernel: PCI: CLS 0 bytes, default 64 Oct 28 13:08:37.676420 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 28 13:08:37.676428 kernel: kvm [1]: HYP mode not available Oct 28 13:08:37.676434 kernel: Initialise system trusted keyrings Oct 28 13:08:37.676440 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 28 13:08:37.676446 kernel: Key type asymmetric registered Oct 28 13:08:37.676452 kernel: Asymmetric key parser 'x509' registered Oct 28 13:08:37.676458 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 28 13:08:37.676464 kernel: io scheduler mq-deadline registered Oct 28 13:08:37.676470 kernel: io scheduler kyber registered Oct 28 13:08:37.676476 kernel: io scheduler bfq registered Oct 28 13:08:37.676483 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 28 13:08:37.676489 kernel: ACPI: Power Button [PWRB] Oct 28 13:08:37.676495 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 28 13:08:37.676549 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 28 13:08:37.676557 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 28 13:08:37.676563 kernel: msm_serial: driver initialized Oct 28 13:08:37.676569 kernel: random: fast init done Oct 28 13:08:37.676575 kernel: random: crng init done Oct 28 13:08:37.676581 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 28 13:08:37.676587 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 28 13:08:37.676594 kernel: thunder_xcv, ver 1.0 Oct 28 13:08:37.676600 kernel: thunder_bgx, ver 1.0 Oct 28 13:08:37.676606 kernel: nicpf, ver 1.0 Oct 28 13:08:37.676612 kernel: nicvf, ver 1.0 Oct 28 13:08:37.676671 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 28 13:08:37.676721 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-28T13:08:37 UTC (1761656917) Oct 28 13:08:37.676730 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 28 13:08:37.676736 kernel: NET: Registered protocol family 10 Oct 28 13:08:37.676743 kernel: Segment Routing with IPv6 Oct 28 13:08:37.676750 kernel: NET: Registered protocol family 17 Oct 28 13:08:37.676755 kernel: Key type dns_resolver registered Oct 28 13:08:37.676761 kernel: registered taskstats version 1 Oct 28 13:08:37.676767 kernel: Loading compiled-in X.509 certificates Oct 28 13:08:37.676773 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 28 13:08:37.676780 kernel: Key type ._fscrypt registered Oct 28 13:08:37.676786 kernel: Key type .fscrypt registered Oct 28 13:08:37.676792 kernel: Key type fscrypt-provisioning registered Oct 28 13:08:37.676799 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 28 13:08:37.676805 kernel: ima: Allocated hash algorithm: sha1 Oct 28 13:08:37.676811 kernel: ima: No architecture policies found Oct 28 13:08:37.676817 kernel: Freeing unused kernel memory: 34240K Oct 28 13:08:37.676823 kernel: Run /init as init process Oct 28 13:08:37.676829 kernel: with arguments: Oct 28 13:08:37.676835 kernel: /init Oct 28 13:08:37.676841 kernel: with environment: Oct 28 13:08:37.676847 kernel: HOME=/ Oct 28 13:08:37.676852 kernel: TERM=linux Oct 28 13:08:37.676859 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 28 13:08:37.676867 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:08:37.676884 systemd[1]: Detected virtualization kvm. Oct 28 13:08:37.676891 systemd[1]: Detected architecture arm64. Oct 28 13:08:37.676897 systemd[1]: Running in initial RAM disk. Oct 28 13:08:37.676903 systemd[1]: No hostname configured, using default hostname. Oct 28 13:08:37.676910 systemd[1]: Hostname set to . Oct 28 13:08:37.676918 systemd[1]: Initializing machine ID from VM UUID. Oct 28 13:08:37.676925 systemd[1]: Queued start job for default target Initrd Default Target. Oct 28 13:08:37.676931 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 13:08:37.676938 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 13:08:37.676944 systemd[1]: Reached target Path Units. Oct 28 13:08:37.676950 systemd[1]: Reached target Slice Units. Oct 28 13:08:37.676963 systemd[1]: Reached target Swaps. Oct 28 13:08:37.676970 systemd[1]: Reached target Timer Units. Oct 28 13:08:37.676979 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 28 13:08:37.676985 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 28 13:08:37.676992 systemd[1]: Listening on Journal Audit Socket. Oct 28 13:08:37.676998 systemd[1]: Listening on Journal Socket (/dev/log). Oct 28 13:08:37.677004 systemd[1]: Listening on Journal Socket. Oct 28 13:08:37.677011 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 13:08:37.677017 systemd[1]: Listening on udev Control Socket. Oct 28 13:08:37.677024 systemd[1]: Listening on udev Kernel Socket. Oct 28 13:08:37.677030 systemd[1]: Reached target Socket Units. Oct 28 13:08:37.677037 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 13:08:37.677044 systemd[1]: Finished Network Cleanup. Oct 28 13:08:37.677050 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 28 13:08:37.677057 systemd[1]: Starting Journal Service... Oct 28 13:08:37.677063 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 13:08:37.677070 systemd[1]: Starting Apply Kernel Variables... Oct 28 13:08:37.677076 systemd[1]: Starting Setup Virtual Console... Oct 28 13:08:37.677083 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 13:08:37.677089 systemd[1]: Finished Apply Kernel Variables. Oct 28 13:08:37.677096 systemd[1]: Finished Setup Virtual Console. Oct 28 13:08:37.677103 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 28 13:08:37.677115 systemd-journald[278]: Journal started Oct 28 13:08:37.677150 systemd-journald[278]: Runtime Journal (/run/log/journal/57604dadc2db40c688f6ae75d55b33be) is 6.0M, max 48.5M, 42.4M free. Oct 28 13:08:37.679464 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 13:08:37.680978 systemd[1]: Started Journal Service. Oct 28 13:08:37.681139 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 13:08:37.690752 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 28 13:08:37.692372 systemd[1]: Starting dracut cmdline hook... Oct 28 13:08:37.700642 dracut-cmdline[295]: dracut-dracut-053 Oct 28 13:08:37.702771 dracut-cmdline[295]: 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:08:37.757981 kernel: SCSI subsystem initialized Oct 28 13:08:37.761972 kernel: Loading iSCSI transport class v2.0-870. Oct 28 13:08:37.766979 kernel: iscsi: registered transport (tcp) Oct 28 13:08:37.778142 kernel: iscsi: registered transport (qla4xxx) Oct 28 13:08:37.778156 kernel: QLogic iSCSI HBA Driver Oct 28 13:08:37.787487 systemd[1]: Finished dracut cmdline hook. Oct 28 13:08:37.788803 systemd[1]: Starting dracut pre-udev hook... Oct 28 13:08:37.801610 kernel: device-mapper: uevent: version 1.0.3 Oct 28 13:08:37.801637 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 28 13:08:37.835982 kernel: raid6: neonx8 gen() 13750 MB/s Oct 28 13:08:37.852980 kernel: raid6: neonx8 xor() 10713 MB/s Oct 28 13:08:37.869986 kernel: raid6: neonx4 gen() 13608 MB/s Oct 28 13:08:37.886988 kernel: raid6: neonx4 xor() 11594 MB/s Oct 28 13:08:37.903990 kernel: raid6: neonx2 gen() 13007 MB/s Oct 28 13:08:37.920988 kernel: raid6: neonx2 xor() 9892 MB/s Oct 28 13:08:37.937990 kernel: raid6: neonx1 gen() 10992 MB/s Oct 28 13:08:37.954981 kernel: raid6: neonx1 xor() 8843 MB/s Oct 28 13:08:37.971982 kernel: raid6: int64x8 gen() 6837 MB/s Oct 28 13:08:37.988986 kernel: raid6: int64x8 xor() 3801 MB/s Oct 28 13:08:38.005993 kernel: raid6: int64x4 gen() 6916 MB/s Oct 28 13:08:38.022979 kernel: raid6: int64x4 xor() 3836 MB/s Oct 28 13:08:38.039990 kernel: raid6: int64x2 gen() 6191 MB/s Oct 28 13:08:38.056979 kernel: raid6: int64x2 xor() 3315 MB/s Oct 28 13:08:38.073989 kernel: raid6: int64x1 gen() 5015 MB/s Oct 28 13:08:38.091016 kernel: raid6: int64x1 xor() 2583 MB/s Oct 28 13:08:38.091036 kernel: raid6: using algorithm neonx8 gen() 13750 MB/s Oct 28 13:08:38.091051 kernel: raid6: .... xor() 10713 MB/s, rmw enabled Oct 28 13:08:38.092028 kernel: raid6: using neon recovery algorithm Oct 28 13:08:38.102109 kernel: xor: measuring software checksum speed Oct 28 13:08:38.102124 kernel: 8regs : 17148 MB/sec Oct 28 13:08:38.103072 kernel: 32regs : 20776 MB/sec Oct 28 13:08:38.104490 kernel: arm64_neon : 29173 MB/sec Oct 28 13:08:38.104501 kernel: xor: using function: arm64_neon (29173 MB/sec) Oct 28 13:08:38.148979 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 28 13:08:38.158050 systemd[1]: Finished dracut pre-udev hook. Oct 28 13:08:38.158000 audit: BPF prog-id=6 op=LOAD Oct 28 13:08:38.159699 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 13:08:38.162587 kernel: audit: type=1334 audit(1761656918.158:2): prog-id=6 op=LOAD Oct 28 13:08:38.162603 kernel: audit: type=1334 audit(1761656918.158:3): prog-id=7 op=LOAD Oct 28 13:08:38.162611 kernel: audit: type=1334 audit(1761656918.158:4): prog-id=8 op=LOAD Oct 28 13:08:38.158000 audit: BPF prog-id=7 op=LOAD Oct 28 13:08:38.158000 audit: BPF prog-id=8 op=LOAD Oct 28 13:08:38.172336 systemd-udevd[414]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 13:08:38.174281 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 13:08:38.175918 systemd[1]: Starting dracut pre-trigger hook... Oct 28 13:08:38.181000 audit: BPF prog-id=9 op=LOAD Oct 28 13:08:38.183334 kernel: audit: type=1334 audit(1761656918.181:5): prog-id=9 op=LOAD Oct 28 13:08:38.182435 systemd[1]: Starting Network Configuration... Oct 28 13:08:38.188422 dracut-pre-trigger[421]: rd.md=0: removing MD RAID activation Oct 28 13:08:38.199703 systemd-networkd[430]: lo: Link UP Oct 28 13:08:38.199710 systemd-networkd[430]: lo: Gained carrier Oct 28 13:08:38.199988 systemd-networkd[430]: Enumeration completed Oct 28 13:08:38.200057 systemd[1]: Started Network Configuration. Oct 28 13:08:38.200000 audit: BPF prog-id=10 op=LOAD Oct 28 13:08:38.202001 systemd[1]: Starting Network Name Resolution... Oct 28 13:08:38.205077 kernel: audit: type=1334 audit(1761656918.200:6): prog-id=10 op=LOAD Oct 28 13:08:38.215689 systemd[1]: Finished dracut pre-trigger hook. Oct 28 13:08:38.217052 systemd[1]: Starting Coldplug All udev Devices... Oct 28 13:08:38.226209 systemd-udevd[414]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 13:08:38.230304 systemd-resolved[448]: Positive Trust Anchors: Oct 28 13:08:38.230317 systemd-resolved[448]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 13:08:38.230345 systemd-resolved[448]: 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:08:38.230602 systemd-resolved[448]: Defaulting to hostname 'linux'. Oct 28 13:08:38.231200 systemd[1]: Started Network Name Resolution. Oct 28 13:08:38.231985 systemd[1]: Reached target Network. Oct 28 13:08:38.248067 iscsid[483]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 28 13:08:38.248067 iscsid[483]: 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:08:38.248067 iscsid[483]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 28 13:08:38.248067 iscsid[483]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 28 13:08:38.248067 iscsid[483]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 28 13:08:38.248067 iscsid[483]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 28 13:08:38.232603 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 13:08:38.234103 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 28 13:08:38.241327 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 28 13:08:38.244614 systemd[1]: Starting Open-iSCSI... Oct 28 13:08:38.246617 systemd[1]: Finished Coldplug All udev Devices. Oct 28 13:08:38.250487 systemd[1]: Started Open-iSCSI. Oct 28 13:08:38.256185 systemd[1]: Starting dracut initqueue hook... Oct 28 13:08:38.281379 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 28 13:08:38.281513 kernel: vda: detected capacity change from 0 to 4756340736 Oct 28 13:08:38.289095 systemd-udevd[473]: Using default interface naming scheme 'v249'. Oct 28 13:08:38.293510 systemd-networkd[430]: eth0: Link UP Oct 28 13:08:38.295978 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 13:08:38.315055 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 28 13:08:38.318251 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (478) Oct 28 13:08:38.318325 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 28 13:08:38.321262 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 28 13:08:38.327550 systemd[1]: Finished dracut initqueue hook. Oct 28 13:08:38.330116 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Oct 28 13:08:38.332760 systemd[1]: Found device /dev/disk/by-label/OEM. Oct 28 13:08:38.333625 systemd[1]: Reached target Initrd Root Device. Oct 28 13:08:38.334895 systemd[1]: Reached target Preparation for Remote File Systems. Oct 28 13:08:38.336439 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 13:08:38.337936 systemd[1]: Reached target Remote File Systems. Oct 28 13:08:38.339978 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 28 13:08:38.341430 systemd[1]: Starting dracut pre-mount hook... Oct 28 13:08:38.349988 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 13:08:38.349431 systemd[1]: Finished dracut pre-mount hook. Oct 28 13:08:39.339989 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 28 13:08:39.340019 systemd-networkd[430]: eth0: Gained carrier Oct 28 13:08:39.353353 systemd-networkd[430]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 28 13:08:39.357977 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 13:08:39.358197 disk-uuid[504]: The operation has completed successfully. Oct 28 13:08:39.383920 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 28 13:08:39.384083 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 28 13:08:39.386531 systemd[1]: Starting Ignition (setup)... Oct 28 13:08:39.394085 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 13:08:39.394125 kernel: BTRFS info (device vda6): has skinny extents Oct 28 13:08:39.399806 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 28 13:08:39.410308 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 28 13:08:39.410427 systemd[1]: Finished Ignition (setup). Oct 28 13:08:39.412507 systemd[1]: Starting Ignition (disks)... Oct 28 13:08:39.422220 ignition[541]: Ignition v0.36.1-15-gde4e6cc9 Oct 28 13:08:39.422236 ignition[541]: Stage: disks Oct 28 13:08:39.422246 ignition[541]: reading system config file "/usr/lib/ignition/base.ign" Oct 28 13:08:39.422257 ignition[541]: no config at "/usr/lib/ignition/base.ign" Oct 28 13:08:39.422299 ignition[541]: parsed url from cmdline: "" Oct 28 13:08:39.422302 ignition[541]: no config URL provided Oct 28 13:08:39.422307 ignition[541]: reading system config file "/usr/lib/ignition/user.ign" Oct 28 13:08:39.422314 ignition[541]: no config at "/usr/lib/ignition/user.ign" Oct 28 13:08:39.422333 ignition[541]: op(1): [started] loading QEMU firmware config module Oct 28 13:08:39.422338 ignition[541]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 28 13:08:39.423458 ignition[541]: op(1): [finished] loading QEMU firmware config module Oct 28 13:08:39.436819 ignition[541]: parsing config with SHA512: 5c1698740502687a523089e9dea415e7a4f194d96c257b46a69a55b8ae19b36f0974189ec5e1cc49b3cea6370ae5f7d45d79e61a4abe036a4f2d7dbaa5e601f3 Oct 28 13:08:39.438798 ignition[541]: disks: disks passed Oct 28 13:08:39.438810 ignition[541]: Ignition finished successfully Oct 28 13:08:39.439659 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 28 13:08:39.439776 systemd[1]: Finished Ignition (disks). Oct 28 13:08:39.440949 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 13:08:39.443328 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 28 13:08:39.445552 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 28 13:08:39.453234 systemd-fsck[554]: ROOT: clean, 528/553792 files, 37752/553472 blocks Oct 28 13:08:39.457128 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 28 13:08:39.460162 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 28 13:08:39.459887 systemd[1]: Mounting /sysroot... Oct 28 13:08:39.474445 systemd[1]: Found device /dev/mapper/usr. Oct 28 13:08:39.476223 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 28 13:08:39.478076 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 28 13:08:39.485273 systemd-fsck[571]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 28 13:08:39.485273 systemd-fsck[571]: You must have r/w access to the filesystem or be root Oct 28 13:08:39.488646 systemd-fsck[566]: fsck failed with exit status 8. Oct 28 13:08:39.488659 systemd-fsck[566]: Ignoring error. Oct 28 13:08:39.489715 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 28 13:08:39.492468 systemd[1]: Mounting /sysusr/usr... Oct 28 13:08:39.499871 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 28 13:08:39.499905 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 28 13:08:39.500651 systemd[1]: Mounted /sysroot. Oct 28 13:08:39.501891 systemd[1]: Reached target Initrd Root File System. Oct 28 13:08:39.507980 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 28 13:08:39.508412 systemd[1]: Mounted /sysusr/usr. Oct 28 13:08:39.509691 systemd[1]: Reached target Local File Systems. Oct 28 13:08:39.510460 systemd[1]: Reached target System Initialization. Oct 28 13:08:39.511730 systemd[1]: Reached target Basic System. Oct 28 13:08:39.514226 systemd[1]: Mounting /sysroot/usr... Oct 28 13:08:39.516149 systemd[1]: Mounted /sysroot/usr. Oct 28 13:08:39.517342 systemd[1]: Starting Root filesystem setup... Oct 28 13:08:39.539846 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 28 13:08:39.539983 systemd[1]: Finished Root filesystem setup. Oct 28 13:08:39.542112 systemd[1]: Starting Ignition (files)... Oct 28 13:08:39.543254 systemd[1]: Starting /sysroot/boot... Oct 28 13:08:39.545875 ignition[586]: Ignition v0.36.1-15-gde4e6cc9 Oct 28 13:08:39.545889 ignition[586]: Stage: files Oct 28 13:08:39.545898 ignition[586]: reading system config file "/usr/lib/ignition/base.ign" Oct 28 13:08:39.545928 ignition[586]: no config at "/usr/lib/ignition/base.ign" Oct 28 13:08:39.546731 ignition[586]: files: compiled without relabeling support, skipping Oct 28 13:08:39.562638 systemd[1]: Finished /sysroot/boot. Oct 28 13:08:39.565713 ignition[586]: files: createUsers: op(1): [started] creating or modifying user "core" Oct 28 13:08:39.565726 ignition[586]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Oct 28 13:08:39.567395 ignition[586]: files: createUsers: op(1): [finished] creating or modifying user "core" Oct 28 13:08:39.567407 ignition[586]: files: createUsers: op(2): [started] adding ssh keys to user "core" Oct 28 13:08:39.570161 ignition[586]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Oct 28 13:08:39.570192 ignition[586]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Oct 28 13:08:39.571381 ignition[586]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Oct 28 13:08:39.571388 ignition[586]: files: op(4): [started] processing unit "coreos-metadata.service" Oct 28 13:08:39.573560 systemd[1]: ignition-files.service: Deactivated successfully. Oct 28 13:08:39.571478 ignition[586]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 28 13:08:39.573661 systemd[1]: Finished Ignition (files). Oct 28 13:08:39.572988 ignition[586]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 28 13:08:39.575043 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Oct 28 13:08:39.582000 audit: BPF prog-id=9 op=UNLOAD Oct 28 13:08:39.584994 kernel: audit: type=1334 audit(1761656919.582:7): prog-id=9 op=UNLOAD Oct 28 13:08:39.584000 audit: BPF prog-id=6 op=UNLOAD Oct 28 13:08:39.572993 ignition[586]: files: op(4): [finished] processing unit "coreos-metadata.service" Oct 28 13:08:39.587685 kernel: audit: type=1334 audit(1761656919.584:8): prog-id=6 op=UNLOAD Oct 28 13:08:39.587701 kernel: audit: type=1334 audit(1761656919.585:9): prog-id=10 op=UNLOAD Oct 28 13:08:39.585000 audit: BPF prog-id=10 op=UNLOAD Oct 28 13:08:39.575609 systemd[1]: Starting Ignition (record completion)... Oct 28 13:08:39.589299 kernel: audit: type=1334 audit(1761656919.587:10): prog-id=3 op=UNLOAD Oct 28 13:08:39.587000 audit: BPF prog-id=3 op=UNLOAD Oct 28 13:08:39.572998 ignition[586]: files: files passed Oct 28 13:08:39.577183 systemd[1]: Starting Reload Configuration from the Real Root... Oct 28 13:08:39.573001 ignition[586]: Ignition finished successfully Oct 28 13:08:39.578662 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 28 13:08:39.578771 systemd[1]: Finished Ignition (record completion). Oct 28 13:08:39.581997 systemd[1]: Reloading. Oct 28 13:08:39.666000 audit: BPF prog-id=11 op=LOAD Oct 28 13:08:39.667000 audit: BPF prog-id=12 op=LOAD Oct 28 13:08:39.667000 audit: BPF prog-id=13 op=LOAD Oct 28 13:08:39.667000 audit: BPF prog-id=14 op=LOAD Oct 28 13:08:39.667000 audit: BPF prog-id=7 op=UNLOAD Oct 28 13:08:39.667000 audit: BPF prog-id=8 op=UNLOAD Oct 28 13:08:39.667000 audit: BPF prog-id=15 op=LOAD Oct 28 13:08:39.667000 audit: BPF prog-id=16 op=LOAD Oct 28 13:08:39.667000 audit: BPF prog-id=17 op=LOAD Oct 28 13:08:39.667000 audit: BPF prog-id=18 op=LOAD Oct 28 13:08:39.667000 audit: BPF prog-id=4 op=UNLOAD Oct 28 13:08:39.667000 audit: BPF prog-id=5 op=UNLOAD Oct 28 13:08:39.685817 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 28 13:08:39.685937 systemd[1]: Finished Reload Configuration from the Real Root. Oct 28 13:08:39.687764 systemd[1]: Reached target Initrd File Systems. Oct 28 13:08:39.689162 systemd[1]: Reached target Initrd Default Target. Oct 28 13:08:39.690539 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 28 13:08:39.691207 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 28 13:08:39.701208 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 28 13:08:39.702632 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 28 13:08:39.708355 systemd[1]: Stopped target Host and Network Name Lookups. Oct 28 13:08:39.709287 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 13:08:39.710756 systemd[1]: Stopped target Timer Units. Oct 28 13:08:39.712058 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 28 13:08:39.712163 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 28 13:08:39.713564 systemd[1]: Stopped target Initrd Default Target. Oct 28 13:08:39.714993 systemd[1]: Stopped target Basic System. Oct 28 13:08:39.716325 systemd[1]: Stopped target Initrd Root Device. Oct 28 13:08:39.717653 systemd[1]: Stopped target Path Units. Oct 28 13:08:39.718809 systemd[1]: Stopped target Remote File Systems. Oct 28 13:08:39.720177 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 28 13:08:39.721567 systemd[1]: Stopped target Slice Units. Oct 28 13:08:39.722904 systemd[1]: Stopped target Socket Units. Oct 28 13:08:39.724393 systemd[1]: Stopped target System Initialization. Oct 28 13:08:39.725771 systemd[1]: Stopped target Local File Systems. Oct 28 13:08:39.726992 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 13:08:39.728517 systemd[1]: Stopped target Swaps. Oct 28 13:08:39.729623 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 28 13:08:39.729717 systemd[1]: Stopped dracut pre-mount hook. Oct 28 13:08:39.731074 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 13:08:39.732285 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 13:08:39.736854 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 13:08:39.738134 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 28 13:08:39.738226 systemd[1]: Stopped dracut initqueue hook. Oct 28 13:08:39.741535 iscsid[483]: iscsid shutting down. Oct 28 13:08:39.739781 systemd[1]: Stopping Open-iSCSI... Oct 28 13:08:39.741485 systemd[1]: Stopping /sysroot/boot... Oct 28 13:08:39.742075 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 28 13:08:39.742189 systemd[1]: Stopped Coldplug All udev Devices. Oct 28 13:08:39.743328 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 28 13:08:39.743406 systemd[1]: Stopped dracut pre-trigger hook. Oct 28 13:08:39.745346 systemd[1]: iscsid.service: Deactivated successfully. Oct 28 13:08:39.745458 systemd[1]: Stopped Open-iSCSI. Oct 28 13:08:39.746928 systemd[1]: iscsid.socket: Deactivated successfully. Oct 28 13:08:39.747021 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 28 13:08:39.748154 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 28 13:08:39.751156 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 28 13:08:39.751265 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 28 13:08:39.752562 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 28 13:08:39.752663 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 28 13:08:39.754042 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 28 13:08:39.754150 systemd[1]: Stopped /sysroot/boot. Oct 28 13:08:39.755538 systemd[1]: Stopped target Network. Oct 28 13:08:39.756269 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 28 13:08:39.756328 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 28 13:08:39.757595 systemd[1]: Stopping Network Name Resolution... Oct 28 13:08:39.764133 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 28 13:08:39.764241 systemd[1]: Stopped Network Name Resolution. Oct 28 13:08:39.765375 systemd[1]: Stopping Network Configuration... Oct 28 13:08:39.770058 systemd-networkd[430]: eth0: DHCP lease lost Oct 28 13:08:39.771000 audit: BPF prog-id=15 op=UNLOAD Oct 28 13:08:39.775011 systemd-networkd[430]: eth0: DHCPv6 lease lost Oct 28 13:08:39.775950 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 28 13:08:39.776073 systemd[1]: Stopped Network Configuration. Oct 28 13:08:39.777690 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 28 13:08:39.777718 systemd[1]: Closed Network Service Netlink Socket. Oct 28 13:08:39.779336 systemd[1]: Stopping Network Cleanup... Oct 28 13:08:39.780233 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 13:08:39.780292 systemd[1]: Stopped Apply Kernel Variables. Oct 28 13:08:39.785000 audit: BPF prog-id=11 op=UNLOAD Oct 28 13:08:39.781647 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 28 13:08:39.786597 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 28 13:08:39.786708 systemd[1]: Stopped Network Cleanup. Oct 28 13:08:39.789564 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 28 13:08:39.789679 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 28 13:08:39.791457 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 28 13:08:39.791491 systemd[1]: Closed udev Control Socket. Oct 28 13:08:39.792742 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 28 13:08:39.796000 audit: BPF prog-id=12 op=UNLOAD Oct 28 13:08:39.792771 systemd[1]: Closed udev Kernel Socket. Oct 28 13:08:39.794160 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 28 13:08:39.794198 systemd[1]: Stopped dracut pre-udev hook. Oct 28 13:08:39.795330 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 28 13:08:39.795367 systemd[1]: Stopped dracut cmdline hook. Oct 28 13:08:39.796736 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 28 13:08:39.796775 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 28 13:08:39.798771 systemd[1]: Starting Cleanup udev Database... Oct 28 13:08:39.799680 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 28 13:08:39.800899 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 13:08:39.800951 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 13:08:39.802502 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 28 13:08:39.802541 systemd[1]: Stopped Create List of Static Device Nodes. Oct 28 13:08:39.803838 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 13:08:39.803890 systemd[1]: Stopped Setup Virtual Console. Oct 28 13:08:39.805542 systemd[1]: rngd.service: Deactivated successfully. Oct 28 13:08:39.805646 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 28 13:08:39.816000 audit: BPF prog-id=16 op=UNLOAD Oct 28 13:08:39.807039 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 28 13:08:39.807133 systemd[1]: Finished Cleanup udev Database. Oct 28 13:08:39.808289 systemd[1]: Reached target Switch Root. Oct 28 13:08:39.810146 systemd[1]: Starting Switch Root... Oct 28 13:08:39.814758 systemd[1]: Switching root. Oct 28 13:08:39.830946 systemd-journald[278]: Journal stopped Oct 28 13:08:41.975784 systemd-journald[278]: Received SIGTERM from PID 1 (systemd). Oct 28 13:08:41.975838 kernel: SELinux: policy capability network_peer_controls=1 Oct 28 13:08:41.975859 kernel: SELinux: policy capability open_perms=1 Oct 28 13:08:41.975871 kernel: SELinux: policy capability extended_socket_class=1 Oct 28 13:08:41.975880 kernel: SELinux: policy capability always_check_network=0 Oct 28 13:08:41.975889 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 28 13:08:41.975899 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 28 13:08:41.975908 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 28 13:08:41.975918 systemd[1]: Successfully loaded SELinux policy in 34.520ms. Oct 28 13:08:41.975936 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.181ms. Oct 28 13:08:41.975946 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:08:41.975971 systemd[1]: Detected virtualization kvm. Oct 28 13:08:41.975982 systemd[1]: Detected architecture arm64. Oct 28 13:08:41.975992 systemd[1]: Detected first boot. Oct 28 13:08:41.976001 systemd[1]: Initializing machine ID from VM UUID. Oct 28 13:08:41.976011 systemd[1]: Populated /etc with preset unit settings. Oct 28 13:08:41.976022 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:08:41.976035 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:08:41.976045 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 28 13:08:41.976054 systemd[1]: Stopped Switch Root. Oct 28 13:08:41.976064 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 28 13:08:41.976074 systemd[1]: Created slice Slice /system/addon-config. Oct 28 13:08:41.976083 systemd[1]: Created slice Slice /system/addon-run. Oct 28 13:08:41.976093 systemd[1]: Created slice Slice /system/getty. Oct 28 13:08:41.976102 systemd[1]: Created slice Slice /system/modprobe. Oct 28 13:08:41.976113 systemd[1]: Created slice Slice /system/serial-getty. Oct 28 13:08:41.976126 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 28 13:08:41.976136 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 28 13:08:41.976145 systemd[1]: Created slice User and Session Slice. Oct 28 13:08:41.976155 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 13:08:41.976165 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 28 13:08:41.976174 systemd[1]: Set up automount Boot partition Automount Point. Oct 28 13:08:41.976184 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 28 13:08:41.976194 systemd[1]: Stopped target Switch Root. Oct 28 13:08:41.976203 systemd[1]: Stopped target Initrd File Systems. Oct 28 13:08:41.976214 systemd[1]: Stopped target Initrd Root File System. Oct 28 13:08:41.976224 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 13:08:41.976233 systemd[1]: Reached target Remote File Systems. Oct 28 13:08:41.976242 systemd[1]: Reached target Slice Units. Oct 28 13:08:41.976252 systemd[1]: Reached target Swaps. Oct 28 13:08:41.976261 systemd[1]: Reached target Verify torcx succeeded. Oct 28 13:08:41.976270 systemd[1]: Reached target Local Verity Protected Volumes. Oct 28 13:08:41.976280 systemd[1]: Listening on Process Core Dump Socket. Oct 28 13:08:41.976290 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 28 13:08:41.976300 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 13:08:41.976309 systemd[1]: Listening on udev Control Socket. Oct 28 13:08:41.976319 systemd[1]: Listening on udev Kernel Socket. Oct 28 13:08:41.976328 systemd[1]: Mounting Huge Pages File System... Oct 28 13:08:41.976338 systemd[1]: Mounting POSIX Message Queue File System... Oct 28 13:08:41.976348 systemd[1]: Mounting External Media Directory... Oct 28 13:08:41.976357 systemd[1]: Mounting Kernel Debug File System... Oct 28 13:08:41.976366 systemd[1]: Mounting Kernel Trace File System... Oct 28 13:08:41.976376 systemd[1]: Mounting Temporary Directory /tmp... Oct 28 13:08:41.976385 systemd[1]: Starting Create missing system files... Oct 28 13:08:41.976396 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 13:08:41.976406 systemd[1]: Starting Load Kernel Module configfs... Oct 28 13:08:41.976415 systemd[1]: Starting Load Kernel Module drm... Oct 28 13:08:41.976424 systemd[1]: Starting Load Kernel Module fuse... Oct 28 13:08:41.976434 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 28 13:08:41.976444 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 28 13:08:41.976453 systemd[1]: Stopped File System Check on Root Device. Oct 28 13:08:41.976462 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 28 13:08:41.976472 systemd[1]: Stopped systemd-fsck-usr.service. Oct 28 13:08:41.976482 systemd[1]: Stopped Journal Service. Oct 28 13:08:41.976491 kernel: fuse: init (API version 7.32) Oct 28 13:08:41.976500 kernel: kauditd_printk_skb: 30 callbacks suppressed Oct 28 13:08:41.976510 kernel: audit: type=1334 audit(1761656921.957:41): prog-id=24 op=LOAD Oct 28 13:08:41.976519 kernel: audit: type=1334 audit(1761656921.957:42): prog-id=25 op=LOAD Oct 28 13:08:41.976528 systemd[1]: Starting Journal Service... Oct 28 13:08:41.976537 kernel: audit: type=1334 audit(1761656921.958:43): prog-id=26 op=LOAD Oct 28 13:08:41.976546 kernel: audit: type=1334 audit(1761656921.958:44): prog-id=22 op=UNLOAD Oct 28 13:08:41.976555 kernel: audit: type=1334 audit(1761656921.958:45): prog-id=23 op=UNLOAD Oct 28 13:08:41.976564 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 13:08:41.976574 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 28 13:08:41.976584 systemd[1]: Starting Apply Kernel Variables... Oct 28 13:08:41.976594 systemd[1]: Starting Coldplug All udev Devices... Oct 28 13:08:41.976603 systemd[1]: verity-setup.service: Deactivated successfully. Oct 28 13:08:41.976613 systemd[1]: Stopped verity-setup.service. Oct 28 13:08:41.976622 kernel: audit: type=1305 audit(1761656921.974: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:08:41.976633 systemd-journald[801]: Journal started Oct 28 13:08:41.976667 systemd-journald[801]: Runtime Journal (/run/log/journal/57604dadc2db40c688f6ae75d55b33be) is 6.0M, max 48.5M, 42.4M free. Oct 28 13:08:39.898000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 28 13:08:39.928000 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:08:39.928000 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:08:39.929000 audit: BPF prog-id=19 op=LOAD Oct 28 13:08:39.929000 audit: BPF prog-id=19 op=UNLOAD Oct 28 13:08:39.929000 audit: BPF prog-id=20 op=LOAD Oct 28 13:08:39.929000 audit: BPF prog-id=20 op=UNLOAD Oct 28 13:08:39.959000 audit[750]: AVC avc: denied { associate } for pid=750 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:08:41.859000 audit: BPF prog-id=21 op=LOAD Oct 28 13:08:41.859000 audit: BPF prog-id=22 op=LOAD Oct 28 13:08:41.859000 audit: BPF prog-id=23 op=LOAD Oct 28 13:08:41.859000 audit: BPF prog-id=17 op=UNLOAD Oct 28 13:08:41.859000 audit: BPF prog-id=18 op=UNLOAD Oct 28 13:08:41.870000 audit: BPF prog-id=21 op=UNLOAD Oct 28 13:08:41.957000 audit: BPF prog-id=24 op=LOAD Oct 28 13:08:41.957000 audit: BPF prog-id=25 op=LOAD Oct 28 13:08:41.958000 audit: BPF prog-id=26 op=LOAD Oct 28 13:08:41.958000 audit: BPF prog-id=22 op=UNLOAD Oct 28 13:08:41.958000 audit: BPF prog-id=23 op=UNLOAD Oct 28 13:08:41.974000 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:08:41.846006 systemd[1]: Queued start job for default target Multi-User System. Oct 28 13:08:39.959073 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" 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:08:41.861683 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 28 13:08:39.959365 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 13:08:39.959384 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 13:08:39.959506 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 28 13:08:39.959517 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 28 13:08:39.959547 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 28 13:08:39.959560 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 28 13:08:39.959743 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 28 13:08:39.959776 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 13:08:39.959791 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 13:08:39.960219 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" 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:08:39.960279 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" 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:08:39.960301 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" 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:08:39.960315 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" 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:08:39.960335 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" 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:08:39.960349 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:39Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 28 13:08:41.675995 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:41Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 13:08:41.676268 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:41Z" 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:08:41.676368 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:41Z" 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:08:41.676485 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:41Z" 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:08:41.676537 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:41Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 28 13:08:41.676592 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T13:08:41Z" 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:08:41.979601 systemd[1]: Started Journal Service. Oct 28 13:08:41.980242 systemd[1]: Mounted Huge Pages File System. Oct 28 13:08:41.981150 systemd[1]: Mounted POSIX Message Queue File System. Oct 28 13:08:41.982066 systemd[1]: Mounted External Media Directory. Oct 28 13:08:41.982896 systemd[1]: Mounted Kernel Debug File System. Oct 28 13:08:41.983805 systemd[1]: Mounted Kernel Trace File System. Oct 28 13:08:41.984711 systemd[1]: Mounted Temporary Directory /tmp. Oct 28 13:08:41.985824 systemd[1]: Finished Create missing system files. Oct 28 13:08:41.986983 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 13:08:41.988058 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 28 13:08:41.988237 systemd[1]: Finished Load Kernel Module configfs. Oct 28 13:08:41.989236 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 13:08:41.989413 systemd[1]: Finished Load Kernel Module drm. Oct 28 13:08:42.007272 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 28 13:08:42.007457 systemd[1]: Finished Load Kernel Module fuse. Oct 28 13:08:42.008533 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 28 13:08:42.009721 systemd[1]: Finished Apply Kernel Variables. Oct 28 13:08:42.012368 systemd[1]: Mounting FUSE Control File System... Oct 28 13:08:42.014088 systemd[1]: Mounting Kernel Configuration File System... Oct 28 13:08:42.014868 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 28 13:08:42.016311 systemd[1]: Starting Rebuild Hardware Database... Oct 28 13:08:42.018202 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 28 13:08:42.019119 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 28 13:08:42.022058 systemd-journald[801]: Time spent on flushing to /var/log/journal/57604dadc2db40c688f6ae75d55b33be is 11.189ms for 766 entries. Oct 28 13:08:42.022058 systemd-journald[801]: System Journal (/var/log/journal/57604dadc2db40c688f6ae75d55b33be) is 8.0M, max 203.0M, 195.0M free. Oct 28 13:08:42.020209 systemd[1]: Starting Load/Save Random Seed... Oct 28 13:08:42.022106 systemd[1]: Starting Create System Users... Oct 28 13:08:42.025678 systemd[1]: Mounted FUSE Control File System. Oct 28 13:08:42.026700 systemd[1]: Mounted Kernel Configuration File System. Oct 28 13:08:42.029476 systemd[1]: Finished Load/Save Random Seed. Oct 28 13:08:42.030403 systemd[1]: Reached target First Boot Complete. Oct 28 13:08:42.032104 systemd[1]: Finished Coldplug All udev Devices. Oct 28 13:08:42.033199 systemd-sysusers[813]: Creating group sgx with gid 999. Oct 28 13:08:42.037832 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 28 13:08:42.039610 systemd-sysusers[813]: Creating group systemd-oom with gid 998. Oct 28 13:08:42.040108 systemd-sysusers[813]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Oct 28 13:08:42.040722 systemd-sysusers[813]: Creating group systemd-timesync with gid 997. Oct 28 13:08:42.041221 systemd-sysusers[813]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Oct 28 13:08:42.041884 systemd-sysusers[813]: Creating group systemd-coredump with gid 996. Oct 28 13:08:42.042441 systemd-sysusers[813]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Oct 28 13:08:42.047559 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 28 13:08:42.055256 systemd[1]: Finished Create System Users. Oct 28 13:08:42.056955 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 13:08:42.069250 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 13:08:42.257290 systemd[1]: Finished Rebuild Hardware Database. Oct 28 13:08:42.267000 audit: BPF prog-id=27 op=LOAD Oct 28 13:08:42.269000 audit: BPF prog-id=28 op=LOAD Oct 28 13:08:42.270639 kernel: audit: type=1334 audit(1761656922.267:47): prog-id=27 op=LOAD Oct 28 13:08:42.270677 kernel: audit: type=1334 audit(1761656922.269:48): prog-id=28 op=LOAD Oct 28 13:08:42.270695 kernel: audit: type=1334 audit(1761656922.270:49): prog-id=29 op=LOAD Oct 28 13:08:42.270000 audit: BPF prog-id=29 op=LOAD Oct 28 13:08:42.271257 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 13:08:42.271526 kernel: audit: type=1334 audit(1761656922.270:50): prog-id=13 op=UNLOAD Oct 28 13:08:42.270000 audit: BPF prog-id=13 op=UNLOAD Oct 28 13:08:42.270000 audit: BPF prog-id=14 op=UNLOAD Oct 28 13:08:42.294485 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 13:08:42.302000 audit: BPF prog-id=30 op=LOAD Oct 28 13:08:42.304095 systemd[1]: Starting Network Configuration... Oct 28 13:08:42.324586 systemd-udevd[822]: Using default interface naming scheme 'v249'. Oct 28 13:08:42.335475 systemd-networkd[837]: lo: Link UP Oct 28 13:08:42.335485 systemd-networkd[837]: lo: Gained carrier Oct 28 13:08:42.335776 systemd-networkd[837]: Enumeration completed Oct 28 13:08:42.335870 systemd[1]: Started Network Configuration. Oct 28 13:08:42.337534 systemd-networkd[837]: eth0: Link UP Oct 28 13:08:42.345064 systemd-networkd[837]: eth0: Gained carrier Oct 28 13:08:42.355137 systemd-networkd[837]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 28 13:08:42.359781 udevadm[815]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 28 13:08:42.387050 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 28 13:08:42.397819 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 13:08:42.405795 lvm[845]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 13:08:42.437649 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 13:08:42.439103 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 13:08:42.457589 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 13:08:42.461386 lvm[846]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 13:08:42.492703 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 13:08:42.493812 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 13:08:42.494846 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 28 13:08:42.494880 systemd[1]: Reached target Containers. Oct 28 13:08:42.506310 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 28 13:08:42.518903 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 28 13:08:42.538501 systemd[1]: Mounting /usr/share/oem... Oct 28 13:08:42.545433 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 13:08:42.545481 kernel: BTRFS info (device vda6): has skinny extents Oct 28 13:08:42.547621 systemd[1]: Mounted /usr/share/oem. Oct 28 13:08:42.548422 systemd[1]: Reached target Local File Systems. Oct 28 13:08:42.550159 systemd[1]: Starting Rebuild Dynamic Linker Cache... Oct 28 13:08:42.551314 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 28 13:08:42.551356 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 28 13:08:42.552513 systemd[1]: Starting Commit a transient machine-id on disk... Oct 28 13:08:42.554631 systemd[1]: Starting Create Volatile Files and Directories... Oct 28 13:08:42.561922 systemd-tmpfiles[871]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 28 13:08:42.563656 systemd-tmpfiles[871]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 28 13:08:42.568993 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 28 13:08:42.569521 systemd[1]: Finished Commit a transient machine-id on disk. Oct 28 13:08:42.599436 systemd-tmpfiles[871]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 13:08:42.599445 systemd-tmpfiles[871]: Skipping /boot Oct 28 13:08:42.606396 systemd-tmpfiles[871]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 13:08:42.606429 systemd-tmpfiles[871]: Skipping /boot Oct 28 13:08:42.626067 systemd[1]: Finished Rebuild Dynamic Linker Cache. Oct 28 13:08:42.657705 systemd[1]: Finished Create Volatile Files and Directories. Oct 28 13:08:42.659718 systemd[1]: Starting Load Security Auditing Rules... Oct 28 13:08:42.661414 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 28 13:08:42.663237 systemd[1]: Starting Rebuild Journal Catalog... Oct 28 13:08:42.663000 audit: BPF prog-id=31 op=LOAD Oct 28 13:08:42.665352 systemd[1]: Starting Network Name Resolution... Oct 28 13:08:42.665000 audit: BPF prog-id=32 op=LOAD Oct 28 13:08:42.668793 systemd[1]: Starting Network Time Synchronization... Oct 28 13:08:42.670663 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 28 13:08:42.672118 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 28 13:08:42.673339 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 28 13:08:42.675939 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 28 13:08:42.680144 systemd[1]: Finished Rebuild Journal Catalog. Oct 28 13:08:42.681781 systemd[1]: Starting Update is Completed... Oct 28 13:08:42.686532 systemd[1]: Finished Update is Completed. Oct 28 13:08:42.690000 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:08:42.692094 augenrules[894]: No rules Oct 28 13:08:42.692758 systemd[1]: Finished Load Security Auditing Rules. Oct 28 13:08:42.704295 systemd[1]: Started Network Time Synchronization. Oct 28 13:08:42.241911 systemd-timesyncd[883]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 28 13:08:42.242087 systemd[1]: Reached target System Initialization. Oct 28 13:08:42.243123 systemd[1]: Started Watch for update engine configuration changes. Oct 28 13:08:42.244288 systemd-resolved[880]: Positive Trust Anchors: Oct 28 13:08:42.244292 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 13:08:42.244295 systemd-resolved[880]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 13:08:42.244322 systemd-resolved[880]: 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:08:42.245571 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 28 13:08:42.246849 systemd-resolved[880]: Defaulting to hostname 'linux'. Oct 28 13:08:42.247430 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 28 13:08:42.247465 systemd[1]: Reached target Path Units. Oct 28 13:08:42.248187 systemd[1]: Reached target System Time Set. Oct 28 13:08:42.249244 systemd[1]: Started Daily Log Rotation. Oct 28 13:08:42.250118 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 28 13:08:42.251187 systemd[1]: Reached target Timer Units. Oct 28 13:08:42.252195 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 28 13:08:42.267239 systemd[1]: Starting Docker Socket for the API... Oct 28 13:08:42.270154 systemd[1]: Listening on OpenSSH Server Socket. Oct 28 13:08:42.271331 systemd[1]: Started Network Name Resolution. Oct 28 13:08:42.272229 systemd[1]: Listening on Docker Socket for the API. Oct 28 13:08:42.273108 systemd[1]: Reached target Network. Oct 28 13:08:42.273774 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 13:08:42.274603 systemd[1]: Reached target Socket Units. Oct 28 13:08:42.275288 systemd[1]: Reached target Basic System. Oct 28 13:08:42.276073 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 28 13:08:42.276101 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 28 13:08:42.277005 systemd[1]: Started D-Bus System Message Bus. Oct 28 13:08:42.279971 systemd[1]: Starting Extend Filesystems... Oct 28 13:08:42.280763 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 28 13:08:42.281661 systemd[1]: Starting Generate /run/flatcar/motd... Oct 28 13:08:42.283342 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 28 13:08:42.286001 systemd[1]: Starting Generate sshd host keys... Oct 28 13:08:42.286790 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 28 13:08:42.286820 systemd[1]: Reached target Load system-provided cloud configs. Oct 28 13:08:42.290637 extend-filesystems[904]: Found vda Oct 28 13:08:42.291376 extend-filesystems[904]: Found vda1 Oct 28 13:08:42.291376 extend-filesystems[904]: Found vda2 Oct 28 13:08:42.291376 extend-filesystems[904]: Found vda3 Oct 28 13:08:42.291376 extend-filesystems[904]: Found usr Oct 28 13:08:42.291376 extend-filesystems[904]: Found vda4 Oct 28 13:08:42.291376 extend-filesystems[904]: Found vda6 Oct 28 13:08:42.291376 extend-filesystems[904]: Found vda7 Oct 28 13:08:42.291376 extend-filesystems[904]: Found vda9 Oct 28 13:08:42.291376 extend-filesystems[904]: Checking size of /dev/vda9 Oct 28 13:08:42.290787 systemd[1]: Starting User Login Management... Oct 28 13:08:42.292283 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 28 13:08:42.293370 systemd[1]: Starting Update Engine... Oct 28 13:08:42.294578 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 28 13:08:42.294608 systemd[1]: Reached target Load user-provided cloud configs. Oct 28 13:08:42.297086 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 28 13:08:42.297316 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 28 13:08:42.302418 systemd[1]: motdgen.service: Deactivated successfully. Oct 28 13:08:42.302647 systemd[1]: Finished Generate /run/flatcar/motd. Oct 28 13:08:42.305036 extend-filesystems[904]: Old size kept for /dev/vda9 Oct 28 13:08:42.313988 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 28 13:08:42.314208 systemd[1]: Finished Extend Filesystems. Oct 28 13:08:42.330385 systemd-logind[916]: Watching system buttons on /dev/input/event0 (Power Button) Oct 28 13:08:42.330801 update_engine[919]: I1028 13:08:42.330554 919 main.cc:89] Flatcar Update Engine starting Oct 28 13:08:42.332485 systemd-logind[916]: New seat seat0. Oct 28 13:08:42.332966 systemd[1]: Started Update Engine. Oct 28 13:08:42.333050 update_engine[919]: I1028 13:08:42.333024 919 update_check_scheduler.cc:74] Next update check in 10m1s Oct 28 13:08:42.343706 systemd[1]: Started Cluster reboot manager. Oct 28 13:08:42.344901 systemd[1]: Started User Login Management. Oct 28 13:08:42.368847 locksmithd[928]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 28 13:08:42.867685 sshd_keygen[924]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Oct 28 13:08:42.885006 systemd[1]: Finished Generate sshd host keys. Oct 28 13:08:42.898366 systemd[1]: Starting Generate /run/issue... Oct 28 13:08:42.902861 systemd[1]: issuegen.service: Deactivated successfully. Oct 28 13:08:42.903070 systemd[1]: Finished Generate /run/issue. Oct 28 13:08:42.904917 systemd[1]: Starting Permit User Sessions... Oct 28 13:08:42.908957 systemd[1]: Finished Permit User Sessions. Oct 28 13:08:42.910791 systemd[1]: Started Getty on tty1. Oct 28 13:08:42.912441 systemd[1]: Started Serial Getty on ttyAMA0. Oct 28 13:08:42.913366 systemd[1]: Reached target Login Prompts. Oct 28 13:08:42.914230 systemd[1]: Reached target Multi-User System. Oct 28 13:08:42.916018 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 28 13:08:42.920588 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 28 13:08:42.920828 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 28 13:08:42.921745 systemd[1]: Startup finished in 684ms (kernel) + 2.304s (initrd) + 3.521s (userspace) = 6.511s. Oct 28 13:08:43.419108 systemd-networkd[837]: eth0: Gained IPv6LL Oct 28 13:08:48.981738 systemd[1]: Created slice Slice /system/sshd. Oct 28 13:08:48.982863 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36008). Oct 28 13:08:49.021462 sshd[949]: Accepted publickey for core from 10.0.0.1 port 36008 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:08:49.023049 sshd[949]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:08:49.035029 systemd[1]: Created slice User Slice of UID 500. Oct 28 13:08:49.035883 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 28 13:08:49.037473 systemd-logind[916]: New session 1 of user core. Oct 28 13:08:49.041364 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 28 13:08:49.042411 systemd[1]: Starting User Manager for UID 500... Oct 28 13:08:49.044395 systemd[952]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:08:49.089371 systemd[952]: Queued start job for default target Main User Target. Oct 28 13:08:49.089516 systemd[952]: Reached target Paths. Oct 28 13:08:49.089531 systemd[952]: Reached target Sockets. Oct 28 13:08:49.089541 systemd[952]: Reached target Timers. Oct 28 13:08:49.089551 systemd[952]: Reached target Basic System. Oct 28 13:08:49.089592 systemd[952]: Reached target Main User Target. Oct 28 13:08:49.089604 systemd[952]: Startup finished in 41ms. Oct 28 13:08:49.089702 systemd[1]: Started User Manager for UID 500. Oct 28 13:08:49.094817 systemd[1]: Started Session 1 of User core. Oct 28 13:08:49.156832 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36016). Oct 28 13:08:49.196731 sshd[961]: Accepted publickey for core from 10.0.0.1 port 36016 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:08:49.197888 sshd[961]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:08:49.200435 systemd-logind[916]: New session 2 of user core. Oct 28 13:08:49.210824 systemd[1]: Started Session 2 of User core. Oct 28 13:08:49.264081 sshd[961]: pam_unix(sshd:session): session closed for user core Oct 28 13:08:49.276094 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:36016.service: Deactivated successfully. Oct 28 13:08:49.276729 systemd[1]: session-2.scope: Deactivated successfully. Oct 28 13:08:49.277351 systemd-logind[916]: Session 2 logged out. Waiting for processes to exit. Oct 28 13:08:49.278217 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45522). Oct 28 13:08:49.278899 systemd-logind[916]: Removed session 2. Oct 28 13:08:49.314109 sshd[967]: Accepted publickey for core from 10.0.0.1 port 45522 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:08:49.315842 sshd[967]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:08:49.318467 systemd-logind[916]: New session 3 of user core. Oct 28 13:08:49.328825 systemd[1]: Started Session 3 of User core. Oct 28 13:08:49.377588 sshd[967]: pam_unix(sshd:session): session closed for user core Oct 28 13:08:49.386015 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:45522.service: Deactivated successfully. Oct 28 13:08:49.386582 systemd[1]: session-3.scope: Deactivated successfully. Oct 28 13:08:49.387174 systemd-logind[916]: Session 3 logged out. Waiting for processes to exit. Oct 28 13:08:49.388038 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45532). Oct 28 13:08:49.388729 systemd-logind[916]: Removed session 3. Oct 28 13:08:49.423873 sshd[973]: Accepted publickey for core from 10.0.0.1 port 45532 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:08:49.424781 sshd[973]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:08:49.427228 systemd-logind[916]: New session 4 of user core. Oct 28 13:08:49.444752 systemd[1]: Started Session 4 of User core. Oct 28 13:08:49.497971 sshd[973]: pam_unix(sshd:session): session closed for user core Oct 28 13:08:49.512058 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:45532.service: Deactivated successfully. Oct 28 13:08:49.512615 systemd[1]: session-4.scope: Deactivated successfully. Oct 28 13:08:49.513201 systemd-logind[916]: Session 4 logged out. Waiting for processes to exit. Oct 28 13:08:49.514092 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45548). Oct 28 13:08:49.515047 systemd-logind[916]: Removed session 4. Oct 28 13:08:49.551597 sshd[979]: Accepted publickey for core from 10.0.0.1 port 45548 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:08:49.552846 sshd[979]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:08:49.555568 systemd-logind[916]: New session 5 of user core. Oct 28 13:08:49.569600 systemd[1]: Started Session 5 of User core. Oct 28 13:08:49.626380 sudo[982]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 28 13:08:49.626593 sudo[982]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:08:49.635347 sudo[982]: pam_unix(sudo:session): session closed for user root Oct 28 13:08:49.637939 sshd[979]: pam_unix(sshd:session): session closed for user core Oct 28 13:08:49.651762 dbus-daemon[903]: [system] Reloaded configuration Oct 28 13:08:49.652003 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45560). Oct 28 13:08:49.654136 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:45548.service: Deactivated successfully. Oct 28 13:08:49.654732 systemd[1]: session-5.scope: Deactivated successfully. Oct 28 13:08:49.655274 systemd-logind[916]: Session 5 logged out. Waiting for processes to exit. Oct 28 13:08:49.655926 systemd-logind[916]: Removed session 5. Oct 28 13:08:49.686800 sshd[985]: Accepted publickey for core from 10.0.0.1 port 45560 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:08:49.687612 sshd[985]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:08:49.689866 systemd-logind[916]: New session 6 of user core. Oct 28 13:08:49.699808 systemd[1]: Started Session 6 of User core. Oct 28 13:08:49.750925 sudo[990]: 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:08:49.751131 sudo[990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:08:49.753446 sudo[990]: pam_unix(sudo:session): session closed for user root Oct 28 13:08:49.756872 sudo[989]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 28 13:08:49.757069 sudo[989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:08:49.774464 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 13:08:49.775000 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:08:49.775990 auditctl[993]: No rules Oct 28 13:08:49.776238 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 13:08:49.776450 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 13:08:49.777706 systemd[1]: Starting Load Security Auditing Rules... Oct 28 13:08:49.778150 kernel: kauditd_printk_skb: 5 callbacks suppressed Oct 28 13:08:49.778184 kernel: audit: type=1305 audit(1761656929.775: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:08:49.791843 augenrules[1010]: No rules Oct 28 13:08:49.792481 systemd[1]: Finished Load Security Auditing Rules. Oct 28 13:08:49.793230 sudo[989]: pam_unix(sudo:session): session closed for user root Oct 28 13:08:49.794443 sshd[985]: pam_unix(sshd:session): session closed for user core Oct 28 13:08:49.803507 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:45560.service: Deactivated successfully. Oct 28 13:08:49.804026 systemd[1]: session-6.scope: Deactivated successfully. Oct 28 13:08:49.804655 systemd-logind[916]: Session 6 logged out. Waiting for processes to exit. Oct 28 13:08:49.805600 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45570). Oct 28 13:08:49.806235 systemd-logind[916]: Removed session 6. Oct 28 13:08:49.845724 sshd[1016]: Accepted publickey for core from 10.0.0.1 port 45570 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:08:49.848656 kernel: audit: type=1006 audit(1761656929.845:57): pid=1016 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:08:49.848755 sshd[1016]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:08:49.851125 systemd-logind[916]: New session 7 of user core. Oct 28 13:08:49.856812 systemd[1]: Started Session 7 of User core. Oct 28 13:08:49.906238 sudo[1019]: 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:08:52.745234 update_engine[1266]: Oct 28 13:08:52.745234 update_engine[1266]: Oct 28 13:08:52.745234 update_engine[1266]: Oct 28 13:08:52.745234 update_engine[1266]: Oct 28 13:08:52.745234 update_engine[1266]: Oct 28 13:08:52.745234 update_engine[1266]: Oct 28 13:08:52.745234 update_engine[1266]: Oct 28 13:08:52.745234 update_engine[1266]: Oct 28 13:08:52.745234 update_engine[1266]: I1028 13:08:52.745230 1266 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 28 13:08:52.748835 update_engine[1266]: I1028 13:08:52.748813 1266 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 28 13:08:52.749120 update_engine[1266]: I1028 13:08:52.749097 1266 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 28 13:08:52.755268 update_engine[1266]: I1028 13:08:52.755223 1266 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 28 13:08:52.756803 update_engine[1266]: I1028 13:08:52.756774 1266 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Oct 28 13:08:52.756803 update_engine[1266]: I1028 13:08:52.756796 1266 omaha_request_action.cc:619] Omaha request response: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.756803 update_engine[1266]: Oct 28 13:08:52.758925 update_engine[1266]: I1028 13:08:52.758894 1266 omaha_request_action.cc:447] Omaha Response manifest version = Oct 28 13:08:52.758985 update_engine[1266]: I1028 13:08:52.758929 1266 omaha_request_action.cc:470] Found 1 url(s) Oct 28 13:08:52.758985 update_engine[1266]: I1028 13:08:52.758944 1266 omaha_request_action.cc:506] Processing first of 1 package(s) Oct 28 13:08:52.758985 update_engine[1266]: I1028 13:08:52.758947 1266 omaha_request_action.cc:513] Omaha Response package name = update.gz Oct 28 13:08:52.758985 update_engine[1266]: I1028 13:08:52.758950 1266 omaha_request_action.cc:529] Url0: http://10.0.0.5:34567/packages/update.gz Oct 28 13:08:52.758985 update_engine[1266]: I1028 13:08:52.758958 1266 omaha_request_action.cc:541] Payload size = 435526319 bytes Oct 28 13:08:52.758985 update_engine[1266]: I1028 13:08:52.758968 1266 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Oct 28 13:08:52.758985 update_engine[1266]: I1028 13:08:52.758980 1266 payload_state.cc:51] Resetting all persisted state as this is a new response Oct 28 13:08:52.758985 update_engine[1266]: I1028 13:08:52.758984 1266 payload_state.cc:360] Current Response Signature = Oct 28 13:08:52.758985 update_engine[1266]: NumURLs = 1 Oct 28 13:08:52.758985 update_engine[1266]: Url0 = http://10.0.0.5:34567/packages/update.gz Oct 28 13:08:52.758985 update_engine[1266]: Payload Size = 435526319 Oct 28 13:08:52.758985 update_engine[1266]: Payload Sha256 Hash = MWe7Cz0hHAZPhG3RiToog9DXtPRhV9ko4O7ML90dZWg= Oct 28 13:08:52.758985 update_engine[1266]: Is Delta Payload = 0 Oct 28 13:08:52.758985 update_engine[1266]: Max Failure Count Per Url = 10 Oct 28 13:08:52.758985 update_engine[1266]: Disable Payload Backoff = 1 Oct 28 13:08:52.759263 update_engine[1266]: I1028 13:08:52.759092 1266 payload_state.cc:381] Payload Attempt Number = 0 Oct 28 13:08:52.759263 update_engine[1266]: I1028 13:08:52.759135 1266 payload_state.cc:404] Current URL Index = 0 Oct 28 13:08:52.759263 update_engine[1266]: I1028 13:08:52.759163 1266 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Oct 28 13:08:52.759263 update_engine[1266]: I1028 13:08:52.759189 1266 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Oct 28 13:08:52.759263 update_engine[1266]: I1028 13:08:52.759193 1266 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 28 13:08:52.759263 update_engine[1266]: I1028 13:08:52.759223 1266 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Oct 28 13:08:52.759263 update_engine[1266]: I1028 13:08:52.759239 1266 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Oct 28 13:08:52.759263 update_engine[1266]: I1028 13:08:52.759244 1266 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Oct 28 13:08:52.759263 update_engine[1266]: I1028 13:08:52.759258 1266 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Oct 28 13:08:52.759263 update_engine[1266]: E1028 13:08:52.759261 1266 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Oct 28 13:08:52.760108 update_engine[1266]: I1028 13:08:52.760071 1266 omaha_response_handler_action.cc:85] Using this install plan: Oct 28 13:08:52.760108 update_engine[1266]: I1028 13:08:52.760087 1266 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.5: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:08:52.760175 update_engine[1266]: I1028 13:08:52.760164 1266 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Oct 28 13:08:52.761397 update_engine[1266]: I1028 13:08:52.761369 1266 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Oct 28 13:08:52.784845 sshd[1281]: Accepted publickey for core from 10.0.0.1 port 45734 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:08:52.785957 sshd[1281]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:08:52.788519 systemd-logind[916]: New session 25 of user core. Oct 28 13:08:52.797793 systemd[1]: Started Session 25 of User core. Oct 28 13:08:52.851601 sshd[1281]: pam_unix(sshd:session): session closed for user core Oct 28 13:08:52.853456 systemd[1]: sshd@24-10.0.0.6:22-10.0.0.1:45734.service: Deactivated successfully. Oct 28 13:08:52.854122 systemd[1]: session-25.scope: Deactivated successfully. Oct 28 13:08:52.855782 systemd-logind[916]: Session 25 logged out. Waiting for processes to exit. Oct 28 13:08:52.856459 systemd-logind[916]: Removed session 25. Oct 28 13:08:54.306644 update_engine[1266]: I1028 13:08:54.306591 1266 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Oct 28 13:08:54.307095 update_engine[1266]: I1028 13:08:54.307075 1266 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Oct 28 13:08:54.376026 update_engine[1266]: E1028 13:08:54.375988 1266 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Oct 28 13:08:54.376167 update_engine[1266]: I1028 13:08:54.376156 1266 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Oct 28 13:08:54.376212 update_engine[1266]: I1028 13:08:54.376204 1266 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Oct 28 13:08:54.376259 update_engine[1266]: I1028 13:08:54.376250 1266 update_attempter.cc:302] Processing Done. Oct 28 13:08:54.376352 update_engine[1266]: E1028 13:08:54.376340 1266 update_attempter.cc:615] Update failed. Oct 28 13:08:54.376402 update_engine[1266]: I1028 13:08:54.376390 1266 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Oct 28 13:08:54.376446 update_engine[1266]: I1028 13:08:54.376437 1266 payload_state.cc:276] Incrementing the URL failure count Oct 28 13:08:54.376512 update_engine[1266]: I1028 13:08:54.376500 1266 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 28 13:08:54.376811 update_engine[1266]: I1028 13:08:54.376789 1266 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 28 13:08:54.376907 update_engine[1266]: I1028 13:08:54.376894 1266 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.5:34567/v1/update Oct 28 13:08:54.376955 update_engine[1266]: I1028 13:08:54.376945 1266 omaha_request_action.cc:269] Request: Oct 28 13:08:54.376955 update_engine[1266]: Oct 28 13:08:54.376955 update_engine[1266]: Oct 28 13:08:54.376955 update_engine[1266]: Oct 28 13:08:54.376955 update_engine[1266]: Oct 28 13:08:54.376955 update_engine[1266]: Oct 28 13:08:54.376955 update_engine[1266]: Oct 28 13:08:54.377097 update_engine[1266]: I1028 13:08:54.377087 1266 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 28 13:08:54.377199 update_engine[1266]: I1028 13:08:54.377188 1266 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 28 13:08:54.377362 update_engine[1266]: I1028 13:08:54.377347 1266 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 28 13:08:54.555831 update_engine[1266]: I1028 13:08:54.555773 1266 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 28 13:08:54.555975 update_engine[1266]: I1028 13:08:54.555858 1266 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Oct 28 13:08:54.555975 update_engine[1266]: I1028 13:08:54.555867 1266 omaha_request_action.cc:619] Omaha request response: Oct 28 13:08:54.555975 update_engine[1266]: Oct 28 13:08:54.555975 update_engine[1266]: Oct 28 13:08:54.555975 update_engine[1266]: Oct 28 13:08:54.555975 update_engine[1266]: Oct 28 13:08:54.555975 update_engine[1266]: Oct 28 13:08:54.555975 update_engine[1266]: Oct 28 13:08:54.555975 update_engine[1266]: E1028 13:08:54.555881 1266 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Oct 28 13:08:54.555975 update_engine[1266]: I1028 13:08:54.555886 1266 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 28 13:08:54.555975 update_engine[1266]: I1028 13:08:54.555889 1266 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 28 13:08:54.555975 update_engine[1266]: I1028 13:08:54.555892 1266 update_attempter.cc:302] Processing Done. Oct 28 13:08:54.555975 update_engine[1266]: I1028 13:08:54.555897 1266 update_attempter.cc:306] Error event sent. Oct 28 13:09:02.861398 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58534). Oct 28 13:09:02.898571 sshd[1300]: Accepted publickey for core from 10.0.0.1 port 58534 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:02.899782 kernel: kauditd_printk_skb: 287 callbacks suppressed Oct 28 13:09:02.899822 kernel: audit: type=1006 audit(1761656942.898:353): pid=1300 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:09:02.900131 sshd[1300]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:02.902723 systemd-logind[916]: New session 26 of user core. Oct 28 13:09:02.917880 systemd[1]: Started Session 26 of User core. Oct 28 13:09:02.975175 sshd[1300]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:02.983155 systemd[1]: sshd@25-10.0.0.6:22-10.0.0.1:58534.service: Deactivated successfully. Oct 28 13:09:02.983807 systemd[1]: session-26.scope: Deactivated successfully. Oct 28 13:09:02.984394 systemd-logind[916]: Session 26 logged out. Waiting for processes to exit. Oct 28 13:09:02.985329 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58544). Oct 28 13:09:02.986043 systemd-logind[916]: Removed session 26. Oct 28 13:09:03.022361 sshd[1307]: Accepted publickey for core from 10.0.0.1 port 58544 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:03.025646 kernel: audit: type=1006 audit(1761656943.022:354): pid=1307 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:09:03.025854 sshd[1307]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:03.028255 systemd-logind[916]: New session 27 of user core. Oct 28 13:09:03.039778 systemd[1]: Started Session 27 of User core. Oct 28 13:09:03.095075 sshd[1307]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:03.112896 systemd[1]: sshd@26-10.0.0.6:22-10.0.0.1:58544.service: Deactivated successfully. Oct 28 13:09:03.113586 systemd[1]: session-27.scope: Deactivated successfully. Oct 28 13:09:03.114358 systemd-logind[916]: Session 27 logged out. Waiting for processes to exit. Oct 28 13:09:03.115583 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58558). Oct 28 13:09:03.116314 systemd-logind[916]: Removed session 27. Oct 28 13:09:03.152703 sshd[1315]: Accepted publickey for core from 10.0.0.1 port 58558 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:03.153963 sshd[1315]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:03.156663 kernel: audit: type=1006 audit(1761656943.152:355): pid=1315 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:09:03.156795 systemd-logind[916]: New session 28 of user core. Oct 28 13:09:03.165615 systemd[1]: Started Session 28 of User core. Oct 28 13:09:03.215553 sshd[1315]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:03.227147 systemd[1]: sshd@27-10.0.0.6:22-10.0.0.1:58558.service: Deactivated successfully. Oct 28 13:09:03.227676 systemd[1]: session-28.scope: Deactivated successfully. Oct 28 13:09:03.228218 systemd-logind[916]: Session 28 logged out. Waiting for processes to exit. Oct 28 13:09:03.229144 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58568). Oct 28 13:09:03.229864 systemd-logind[916]: Removed session 28. Oct 28 13:09:03.264451 sshd[1321]: Accepted publickey for core from 10.0.0.1 port 58568 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:03.265493 sshd[1321]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:03.267666 kernel: audit: type=1006 audit(1761656943.264:356): pid=1321 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:09:03.269418 systemd-logind[916]: New session 29 of user core. Oct 28 13:09:03.278588 systemd[1]: Started Session 29 of User core. Oct 28 13:09:03.327711 sshd[1321]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:03.339192 systemd[1]: sshd@28-10.0.0.6:22-10.0.0.1:58568.service: Deactivated successfully. Oct 28 13:09:03.339718 systemd[1]: session-29.scope: Deactivated successfully. Oct 28 13:09:03.340311 systemd-logind[916]: Session 29 logged out. Waiting for processes to exit. Oct 28 13:09:03.341269 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58584). Oct 28 13:09:03.341971 systemd-logind[916]: Removed session 29. Oct 28 13:09:03.378655 sshd[1327]: Accepted publickey for core from 10.0.0.1 port 58584 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:03.380571 sshd[1327]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:03.382654 kernel: audit: type=1006 audit(1761656943.379:357): pid=1327 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:09:03.384718 systemd-logind[916]: New session 30 of user core. Oct 28 13:09:03.397234 systemd[1]: Started Session 30 of User core. Oct 28 13:09:03.450899 sudo[1331]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Oct 28 13:09:03.451108 sudo[1331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:09:03.456615 systemd[1]: sshd.socket: Deactivated successfully. Oct 28 13:09:03.456953 systemd[1]: Closed OpenSSH Server Socket. Oct 28 13:09:03.458002 sudo[1331]: pam_unix(sudo:session): session closed for user root Oct 28 13:09:03.461353 sudo[1330]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Oct 28 13:09:03.461571 sudo[1330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:09:03.475875 sshd[949]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:03.476153 systemd[1]: Stopping Session 1 of User core... Oct 28 13:09:03.476706 sshd[949]: pam_systemd(sshd:session): Failed to release session: Interrupted system call Oct 28 13:09:03.477087 systemd[1]: Stopping Session 30 of User core... Oct 28 13:09:03.477327 sshd[1327]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:03.478067 systemd[1]: Removed slice Slice /system/addon-config. Oct 28 13:09:03.478971 sudo[1330]: pam_unix(sudo:session): session closed for user root Oct 28 13:09:03.479315 systemd[1]: Removed slice Slice /system/addon-run. Oct 28 13:09:03.480483 systemd[1]: Removed slice Slice /system/modprobe. Oct 28 13:09:03.481705 systemd[1]: Removed slice Slice /system/system-cloudinit. Oct 28 13:09:03.482658 systemd[1]: Stopped target Multi-User System. Oct 28 13:09:03.483436 systemd[1]: Stopped target Login Prompts. Oct 28 13:09:03.484318 systemd[1]: Stopped target Containers. Oct 28 13:09:03.485065 systemd[1]: Stopped target Host and Network Name Lookups. Oct 28 13:09:03.486036 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 13:09:03.486907 systemd[1]: Stopped target Timer Units. Oct 28 13:09:03.487583 systemd[1]: logrotate.timer: Deactivated successfully. Oct 28 13:09:03.487651 systemd[1]: Stopped Daily Log Rotation. Oct 28 13:09:03.488315 systemd[1]: mdadm.timer: Deactivated successfully. Oct 28 13:09:03.488355 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Oct 28 13:09:03.489471 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Oct 28 13:09:03.489514 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Oct 28 13:09:03.490494 systemd[1]: Stopped target System Time Set. Oct 28 13:09:03.491298 systemd[1]: Stopped target Load user-provided cloud configs. Oct 28 13:09:03.492248 systemd[1]: Stopped target Load system-provided cloud configs. Oct 28 13:09:03.493441 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 28 13:09:03.493532 systemd[1]: Closed Process Core Dump Socket. Oct 28 13:09:03.495032 systemd[1]: Unmounting Boot partition... Oct 28 13:09:03.496192 systemd[1]: Stopping Getty on tty1... Oct 28 13:09:03.496952 systemd[1]: Stopping Serial Getty on ttyAMA0... Oct 28 13:09:03.497793 systemd[1]: Stopping OpenSSH per-connection server daemon... Oct 28 13:09:03.498606 sshd[1327]: pam_systemd(sshd:session): Failed to release session: Interrupted system call Oct 28 13:09:03.498690 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:58584)... Oct 28 13:09:03.499568 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Oct 28 13:09:03.499730 systemd[1]: Stopped Commit a transient machine-id on disk. Oct 28 13:09:03.500693 systemd[1]: Stopped target First Boot Complete. Oct 28 13:09:03.502438 systemd[1]: Stopping Load/Save Random Seed... Oct 28 13:09:03.503363 systemd[1]: Stopping Update Engine... Oct 28 13:09:03.506664 systemd[1]: getty@tty1.service: Deactivated successfully. Oct 28 13:09:03.506862 systemd[1]: Stopped Getty on tty1. Oct 28 13:09:03.507980 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Oct 28 13:09:03.508169 systemd[1]: Stopped Serial Getty on ttyAMA0. Oct 28 13:09:03.509384 systemd[1]: sshd@0-10.0.0.6:22-10.0.0.1:36008.service: Deactivated successfully. Oct 28 13:09:03.509593 systemd[1]: Stopped OpenSSH per-connection server daemon. Oct 28 13:09:03.510985 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 28 13:09:03.511058 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 28 13:09:03.511302 systemd[1]: Stopped Update Engine. Oct 28 13:09:03.512083 systemd[1]: update-engine.service: Consumed 2.329s CPU time. Oct 28 13:09:03.512310 systemd[1]: sshd@29-10.0.0.6:22-10.0.0.1:58584.service: Deactivated successfully. Oct 28 13:09:03.512503 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:58584). Oct 28 13:09:03.525312 systemd[1]: systemd-random-seed.service: Deactivated successfully. Oct 28 13:09:03.525542 systemd[1]: Stopped Load/Save Random Seed. Oct 28 13:09:03.526624 systemd[1]: session-30.scope: Deactivated successfully. Oct 28 13:09:03.526859 systemd[1]: Stopped Session 30 of User core. Oct 28 13:09:03.527906 systemd[1]: boot.mount: Deactivated successfully. Oct 28 13:09:03.528150 systemd[1]: Unmounted Boot partition. Oct 28 13:09:03.529118 systemd[1]: session-1.scope: Deactivated successfully. Oct 28 13:09:03.529357 systemd[1]: Stopped Session 1 of User core. Oct 28 13:09:03.530708 systemd-logind[916]: Session 1 logged out. Waiting for processes to exit. Oct 28 13:09:03.531651 systemd-logind[916]: Session 30 logged out. Waiting for processes to exit. Oct 28 13:09:03.531887 systemd[1]: Removed slice Slice /system/getty. Oct 28 13:09:03.532992 systemd[1]: Removed slice Slice /system/serial-getty. Oct 28 13:09:03.534115 systemd[1]: Removed slice Slice /system/sshd. Oct 28 13:09:03.535286 systemd[1]: sshd-keygen.service: Deactivated successfully. Oct 28 13:09:03.535390 systemd[1]: Stopped Generate sshd host keys. Oct 28 13:09:03.536430 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Oct 28 13:09:03.536553 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Oct 28 13:09:03.537835 systemd[1]: Stopping User Login Management... Oct 28 13:09:03.538648 systemd[1]: Stopping User Manager for UID 500... Oct 28 13:09:03.539471 systemd[952]: Stopped target Main User Target. Oct 28 13:09:03.539494 systemd[952]: Stopped target Basic System. Oct 28 13:09:03.539505 systemd[952]: Stopped target Paths. Oct 28 13:09:03.539512 systemd[952]: Stopped target Sockets. Oct 28 13:09:03.539528 systemd[952]: Reached target Shutdown. Oct 28 13:09:03.539535 systemd[952]: Stopped target Timers. Oct 28 13:09:03.539661 systemd[952]: Finished Exit the Session. Oct 28 13:09:03.539686 systemd[952]: Reached target Exit the Session. Oct 28 13:09:03.540742 systemd-logind[916]: Removed session 1. Oct 28 13:09:03.541903 systemd[1]: user@500.service: Deactivated successfully. Oct 28 13:09:03.542083 systemd[1]: Stopped User Manager for UID 500. Oct 28 13:09:03.543850 systemd[1]: Stopping User Runtime Directory /run/user/500... Oct 28 13:09:03.548897 systemd[1]: run-user-500.mount: Deactivated successfully. Oct 28 13:09:03.548962 systemd[1]: Unmounted /run/user/500. Oct 28 13:09:03.550011 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Oct 28 13:09:03.550232 systemd[1]: Stopped User Runtime Directory /run/user/500. Oct 28 13:09:03.551977 systemd[1]: Removed slice User Slice of UID 500. Oct 28 13:09:03.553535 systemd[1]: Stopping D-Bus System Message Bus... Oct 28 13:09:03.569787 systemd[1]: Stopping Permit User Sessions... Oct 28 13:09:03.571179 systemd[1]: dbus.service: Deactivated successfully. Oct 28 13:09:03.571451 systemd[1]: Stopped D-Bus System Message Bus. Oct 28 13:09:03.572502 systemd[1]: systemd-logind.service: Deactivated successfully. Oct 28 13:09:03.572781 systemd[1]: Stopped User Login Management. Oct 28 13:09:03.574138 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Oct 28 13:09:03.574346 systemd[1]: Stopped Permit User Sessions. Oct 28 13:09:03.575182 systemd[1]: Stopped target Basic System. Oct 28 13:09:03.575996 systemd[1]: Stopped target Network. Oct 28 13:09:03.576619 systemd[1]: Stopped target Path Units. Oct 28 13:09:03.577274 systemd[1]: motdgen.path: Deactivated successfully. Oct 28 13:09:03.579697 systemd[1]: Stopped Watch for update engine configuration changes. Oct 28 13:09:03.580619 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Oct 28 13:09:03.580000 audit: BPF prog-id=53 op=UNLOAD Oct 28 13:09:03.581644 kernel: audit: type=1334 audit(1761656943.580:358): prog-id=53 op=UNLOAD Oct 28 13:09:03.586815 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 13:09:03.588873 systemd[1]: Stopped target Remote File Systems. Oct 28 13:09:03.589871 systemd[1]: Stopped target Slice Units. Oct 28 13:09:03.590925 systemd[1]: Removed slice User and Session Slice. Oct 28 13:09:03.591736 systemd[1]: Stopped target Socket Units. Oct 28 13:09:03.592453 systemd[1]: dbus.socket: Deactivated successfully. Oct 28 13:09:03.592514 systemd[1]: Closed D-Bus System Message Bus Socket. Oct 28 13:09:03.593525 systemd[1]: docker.socket: Deactivated successfully. Oct 28 13:09:03.593790 systemd[1]: Closed Docker Socket for the API. Oct 28 13:09:03.594519 systemd[1]: Stopped target System Initialization. Oct 28 13:09:03.595345 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Oct 28 13:09:03.595489 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Oct 28 13:09:03.596546 systemd[1]: Stopped target Local Verity Protected Volumes. Oct 28 13:09:03.598208 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 13:09:03.599207 systemd[1]: Stopping Network Name Resolution... Oct 28 13:09:03.600066 systemd[1]: Stopping Network Time Synchronization... Oct 28 13:09:03.600843 systemd[1]: systemd-update-done.service: Deactivated successfully. Oct 28 13:09:03.600918 systemd[1]: Stopped Update is Completed. Oct 28 13:09:03.601190 auditctl[1345]: No rules Oct 28 13:09:03.601605 systemd[1]: ldconfig.service: Deactivated successfully. Oct 28 13:09:03.601681 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Oct 28 13:09:03.602452 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Oct 28 13:09:03.602513 systemd[1]: Stopped Rebuild Hardware Database. Oct 28 13:09:03.603399 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Oct 28 13:09:03.603475 systemd[1]: Stopped Rebuild Journal Catalog. Oct 28 13:09:03.605032 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Oct 28 13:09:03.607350 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 28 13:09:03.607608 systemd[1]: Stopped Network Name Resolution. Oct 28 13:09:03.608694 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Oct 28 13:09:03.608922 systemd[1]: Stopped Network Time Synchronization. Oct 28 13:09:03.610020 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 13:09:03.610227 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 13:09:03.612463 systemd[1]: Stopping Network Configuration... Oct 28 13:09:03.621698 systemd-networkd[837]: eth0: DHCPv6 lease lost Oct 28 13:09:03.621000 audit: BPF prog-id=51 op=UNLOAD Oct 28 13:09:03.622183 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Oct 28 13:09:03.622449 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Oct 28 13:09:03.621000 audit: BPF prog-id=52 op=UNLOAD Oct 28 13:09:03.623945 kernel: audit: type=1334 audit(1761656943.621:359): prog-id=51 op=UNLOAD Oct 28 13:09:03.623998 kernel: audit: type=1334 audit(1761656943.621:360): prog-id=52 op=UNLOAD Oct 28 13:09:03.624867 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 28 13:09:03.625110 systemd[1]: Stopped Network Configuration. Oct 28 13:09:03.626556 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 28 13:09:03.626670 systemd[1]: Closed Network Service Netlink Socket. Oct 28 13:09:03.627445 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 13:09:03.627505 systemd[1]: Stopped Apply Kernel Variables. Oct 28 13:09:03.628276 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 28 13:09:03.628332 systemd[1]: Stopped Create Volatile Files and Directories. Oct 28 13:09:03.629237 systemd[1]: Stopped target Local File Systems. Oct 28 13:09:03.630829 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Oct 28 13:09:03.632196 systemd[1]: Unmounting External Media Directory... Oct 28 13:09:03.633818 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Oct 28 13:09:03.635489 systemd[1]: Unmounting /run/torcx/unpack... Oct 28 13:09:03.635000 audit: BPF prog-id=50 op=UNLOAD Oct 28 13:09:03.638090 kernel: audit: type=1334 audit(1761656943.635:361): prog-id=50 op=UNLOAD Oct 28 13:09:03.637506 systemd[1]: Unmounting Temporary Directory /tmp... Oct 28 13:09:03.638832 systemd[1]: Unmounting /usr/share/oem... Oct 28 13:09:03.640294 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Oct 28 13:09:03.642862 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 28 13:09:03.643105 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Oct 28 13:09:03.644290 systemd[1]: media.mount: Deactivated successfully. Oct 28 13:09:03.644575 systemd[1]: Unmounted External Media Directory. Oct 28 13:09:03.645541 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Oct 28 13:09:03.645804 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Oct 28 13:09:03.646949 systemd[1]: tmp.mount: Deactivated successfully. Oct 28 13:09:03.647204 systemd[1]: Unmounted Temporary Directory /tmp. Oct 28 13:09:03.648118 systemd[1]: usr-share-oem.mount: Deactivated successfully. Oct 28 13:09:03.648367 systemd[1]: Unmounted /usr/share/oem. Oct 28 13:09:03.649246 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 28 13:09:03.649484 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Oct 28 13:09:03.650856 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Oct 28 13:09:03.650929 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Oct 28 13:09:03.652280 systemd[1]: Removed slice Slice /system/systemd-fsck. Oct 28 13:09:03.657238 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Oct 28 13:09:03.657462 systemd[1]: Unmounted /run/torcx/unpack. Oct 28 13:09:03.658518 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 13:09:03.659515 systemd[1]: Stopped target Swaps. Oct 28 13:09:03.660188 systemd[1]: Reached target Unmount All Filesystems. Oct 28 13:09:03.661028 systemd[1]: lvm2-activation.service: Deactivated successfully. Oct 28 13:09:03.661099 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 28 13:09:03.662056 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 13:09:03.662861 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 13:09:03.662919 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 13:09:03.663913 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Oct 28 13:09:03.665697 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Oct 28 13:09:03.666705 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Oct 28 13:09:03.666776 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 28 13:09:03.667603 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 13:09:03.667852 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 13:09:03.668725 systemd[1]: systemd-sysusers.service: Deactivated successfully. Oct 28 13:09:03.668781 systemd[1]: Stopped Create System Users. Oct 28 13:09:03.669495 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Oct 28 13:09:03.669550 systemd[1]: Stopped Remount Root and Kernel File Systems. Oct 28 13:09:03.670497 systemd[1]: Reached target System Shutdown. Oct 28 13:09:03.671331 systemd[1]: Reached target Late Shutdown Services. Oct 28 13:09:03.672229 systemd[1]: systemd-reboot.service: Deactivated successfully. Oct 28 13:09:03.672265 systemd[1]: Finished System Reboot. Oct 28 13:09:03.672956 systemd[1]: Reached target System Reboot. Oct 28 13:09:03.673648 systemd[1]: Shutting down. Oct 28 13:09:03.676000 audit: BPF prog-id=55 op=UNLOAD Oct 28 13:09:03.676000 audit: BPF prog-id=54 op=UNLOAD Oct 28 13:09:03.678652 kernel: audit: type=1334 audit(1761656943.676:362): prog-id=55 op=UNLOAD Oct 28 13:09:03.678000 audit: BPF prog-id=58 op=UNLOAD Oct 28 13:09:03.678000 audit: BPF prog-id=57 op=UNLOAD Oct 28 13:09:03.678000 audit: BPF prog-id=56 op=UNLOAD Oct 28 13:09:03.678000 audit: BPF prog-id=61 op=UNLOAD Oct 28 13:09:03.678000 audit: BPF prog-id=60 op=UNLOAD Oct 28 13:09:03.678000 audit: BPF prog-id=59 op=UNLOAD Oct 28 13:09:03.716650 systemd-shutdown[1]: Syncing filesystems and block devices. Oct 28 13:09:03.721543 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Oct 28 13:09:03.721606 systemd-journald[801]: Journal stopped -- Reboot -- Oct 28 13:09:11.675422 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 28 13:09:11.675440 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:09:11.675449 kernel: efi: EFI v2.70 by EDK II Oct 28 13:09:11.675454 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82d018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 28 13:09:11.675458 kernel: efi: seeding entropy pool Oct 28 13:09:11.675463 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 28 13:09:11.675470 kernel: ACPI: Early table checksum verification disabled Oct 28 13:09:11.675474 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 28 13:09:11.675479 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 28 13:09:11.675484 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:09:11.675490 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:09:11.675495 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:09:11.675500 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:09:11.675505 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:09:11.675511 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:09:11.675516 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:09:11.675523 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:09:11.675528 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 13:09:11.675533 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 28 13:09:11.675539 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 28 13:09:11.675544 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:09:11.675549 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 28 13:09:11.675554 kernel: Zone ranges: Oct 28 13:09:11.675559 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:09:11.675565 kernel: DMA32 empty Oct 28 13:09:11.675569 kernel: Normal empty Oct 28 13:09:11.675574 kernel: Movable zone start for each node Oct 28 13:09:11.675581 kernel: Early memory node ranges Oct 28 13:09:11.675586 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 28 13:09:11.675591 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 28 13:09:11.675597 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 28 13:09:11.675602 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 28 13:09:11.675607 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 28 13:09:11.675612 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 28 13:09:11.675617 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 28 13:09:11.675622 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 28 13:09:11.675627 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 28 13:09:11.675633 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 28 13:09:11.675638 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 28 13:09:11.675644 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 13:09:11.675652 kernel: On node 0 totalpages: 643072 Oct 28 13:09:11.675657 kernel: DMA zone: 10048 pages used for memmap Oct 28 13:09:11.675663 kernel: DMA zone: 0 pages reserved Oct 28 13:09:11.675668 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 28 13:09:11.675673 kernel: psci: probing for conduit method from ACPI. Oct 28 13:09:11.675679 kernel: psci: PSCIv1.1 detected in firmware. Oct 28 13:09:11.675684 kernel: psci: Using standard PSCI v0.2 function IDs Oct 28 13:09:11.675690 kernel: psci: Trusted OS migration not required Oct 28 13:09:11.675696 kernel: psci: SMC Calling Convention v1.1 Oct 28 13:09:11.675702 kernel: ACPI: SRAT not present Oct 28 13:09:11.675707 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 28 13:09:11.675713 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 28 13:09:11.675718 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 28 13:09:11.675723 kernel: Detected PIPT I-cache on CPU0 Oct 28 13:09:11.675729 kernel: CPU features: detected: GIC system register CPU interface Oct 28 13:09:11.675734 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 28 13:09:11.675740 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 28 13:09:11.675753 kernel: CPU features: detected: Hardware dirty bit management Oct 28 13:09:11.675758 kernel: CPU features: detected: Spectre-v4 Oct 28 13:09:11.675765 kernel: CPU features: detected: ARM erratum 1418040 Oct 28 13:09:11.675771 kernel: CPU features: detected: Spectre-BHB Oct 28 13:09:11.675776 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 28 13:09:11.675782 kernel: Policy zone: DMA Oct 28 13:09:11.675788 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:09:11.675794 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 28 13:09:11.675800 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 28 13:09:11.675805 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 28 13:09:11.675811 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 28 13:09:11.675817 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 28 13:09:11.675822 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 28 13:09:11.675829 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 28 13:09:11.675835 kernel: rcu: RCU event tracing is enabled. Oct 28 13:09:11.675841 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 28 13:09:11.675847 kernel: Trampoline variant of Tasks RCU enabled. Oct 28 13:09:11.675852 kernel: Tracing variant of Tasks RCU enabled. Oct 28 13:09:11.675858 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 28 13:09:11.675863 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 28 13:09:11.675869 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 28 13:09:11.675874 kernel: GICv3: 256 SPIs implemented Oct 28 13:09:11.675880 kernel: GICv3: 0 Extended SPIs implemented Oct 28 13:09:11.675885 kernel: GICv3: Distributor has no Range Selector support Oct 28 13:09:11.675890 kernel: GICv3: 16 PPIs implemented Oct 28 13:09:11.675897 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 28 13:09:11.675902 kernel: ACPI: SRAT not present Oct 28 13:09:11.675907 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 28 13:09:11.675913 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 28 13:09:11.675919 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 28 13:09:11.675924 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 28 13:09:11.675930 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 28 13:09:11.675935 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:09:11.675941 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 28 13:09:11.675947 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 28 13:09:11.675952 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 28 13:09:11.675958 kernel: arm-pv: using stolen time PV Oct 28 13:09:11.675965 kernel: Console: colour dummy device 80x25 Oct 28 13:09:11.675970 kernel: ACPI: Core revision 20200925 Oct 28 13:09:11.675976 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 28 13:09:11.675982 kernel: pid_max: default: 32768 minimum: 301 Oct 28 13:09:11.675988 kernel: LSM: Security Framework initializing Oct 28 13:09:11.675993 kernel: SELinux: Initializing. Oct 28 13:09:11.675999 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 13:09:11.676005 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 13:09:11.676011 kernel: rcu: Hierarchical SRCU implementation. Oct 28 13:09:11.676018 kernel: Platform MSI: ITS@0x8080000 domain created Oct 28 13:09:11.676024 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 28 13:09:11.676029 kernel: Remapping and enabling EFI services. Oct 28 13:09:11.676035 kernel: smp: Bringing up secondary CPUs ... Oct 28 13:09:11.676041 kernel: Detected PIPT I-cache on CPU1 Oct 28 13:09:11.676047 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 28 13:09:11.676052 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 28 13:09:11.676058 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:09:11.676064 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 28 13:09:11.676070 kernel: Detected PIPT I-cache on CPU2 Oct 28 13:09:11.676076 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 28 13:09:11.676082 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 28 13:09:11.676088 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:09:11.676094 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 28 13:09:11.676100 kernel: Detected PIPT I-cache on CPU3 Oct 28 13:09:11.676109 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 28 13:09:11.676115 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 28 13:09:11.676122 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 13:09:11.676128 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 28 13:09:11.676134 kernel: smp: Brought up 1 node, 4 CPUs Oct 28 13:09:11.676140 kernel: SMP: Total of 4 processors activated. Oct 28 13:09:11.676146 kernel: CPU features: detected: Privileged Access Never Oct 28 13:09:11.676151 kernel: CPU features: detected: LSE atomic instructions Oct 28 13:09:11.676157 kernel: CPU features: detected: User Access Override Oct 28 13:09:11.676163 kernel: CPU features: detected: 32-bit EL0 Support Oct 28 13:09:11.676169 kernel: CPU features: detected: Common not Private translations Oct 28 13:09:11.676175 kernel: CPU features: detected: RAS Extension Support Oct 28 13:09:11.676182 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 28 13:09:11.676189 kernel: CPU features: detected: CRC32 instructions Oct 28 13:09:11.676195 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 28 13:09:11.676201 kernel: CPU: All CPU(s) started at EL1 Oct 28 13:09:11.676206 kernel: alternatives: patching kernel code Oct 28 13:09:11.676213 kernel: devtmpfs: initialized Oct 28 13:09:11.676219 kernel: KASLR enabled Oct 28 13:09:11.676225 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 28 13:09:11.676231 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 28 13:09:11.676237 kernel: pinctrl core: initialized pinctrl subsystem Oct 28 13:09:11.676243 kernel: SMBIOS 3.0.0 present. Oct 28 13:09:11.676249 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 28 13:09:11.676255 kernel: NET: Registered protocol family 16 Oct 28 13:09:11.676261 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 28 13:09:11.676267 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 28 13:09:11.676274 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 28 13:09:11.676281 kernel: audit: initializing netlink subsys (disabled) Oct 28 13:09:11.676287 kernel: audit: type=2000 audit(0.031:1): state=initialized audit_enabled=0 res=1 Oct 28 13:09:11.676293 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 28 13:09:11.676299 kernel: cpuidle: using governor menu Oct 28 13:09:11.676304 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 28 13:09:11.676310 kernel: ASID allocator initialised with 32768 entries Oct 28 13:09:11.676316 kernel: ACPI: bus type PCI registered Oct 28 13:09:11.676322 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 28 13:09:11.676329 kernel: Serial: AMBA PL011 UART driver Oct 28 13:09:11.676339 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 28 13:09:11.676346 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 28 13:09:11.676352 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 28 13:09:11.676358 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 28 13:09:11.676364 kernel: cryptd: max_cpu_qlen set to 1000 Oct 28 13:09:11.676375 kernel: ACPI: Added _OSI(Module Device) Oct 28 13:09:11.676381 kernel: ACPI: Added _OSI(Processor Device) Oct 28 13:09:11.676387 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 28 13:09:11.676394 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 28 13:09:11.676400 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 28 13:09:11.676406 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 28 13:09:11.676412 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 28 13:09:11.676418 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 28 13:09:11.676424 kernel: ACPI: Interpreter enabled Oct 28 13:09:11.676430 kernel: ACPI: Using GIC for interrupt routing Oct 28 13:09:11.676436 kernel: ACPI: MCFG table detected, 1 entries Oct 28 13:09:11.676442 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 28 13:09:11.676448 kernel: printk: console [ttyAMA0] enabled Oct 28 13:09:11.676456 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 28 13:09:11.676562 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 28 13:09:11.676618 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 28 13:09:11.676669 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 28 13:09:11.676720 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 28 13:09:11.676778 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 28 13:09:11.676787 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 28 13:09:11.676795 kernel: PCI host bridge to bus 0000:00 Oct 28 13:09:11.676854 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 28 13:09:11.676907 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 28 13:09:11.676963 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 28 13:09:11.677009 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 28 13:09:11.677084 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 28 13:09:11.677150 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 28 13:09:11.677207 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 28 13:09:11.677261 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 28 13:09:11.677315 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 13:09:11.677379 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 13:09:11.677435 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 28 13:09:11.677488 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 28 13:09:11.677536 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 28 13:09:11.677585 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 28 13:09:11.677633 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 28 13:09:11.677641 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 28 13:09:11.677647 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 28 13:09:11.677653 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 28 13:09:11.677659 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 28 13:09:11.677665 kernel: vgaarb: loaded Oct 28 13:09:11.677671 kernel: Registered efivars operations Oct 28 13:09:11.677677 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 28 13:09:11.677685 kernel: VFS: Disk quotas dquot_6.6.0 Oct 28 13:09:11.677691 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 28 13:09:11.677697 kernel: pnp: PnP ACPI init Oct 28 13:09:11.677761 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 28 13:09:11.677817 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 28 13:09:11.677825 kernel: pnp: PnP ACPI: found 1 devices Oct 28 13:09:11.677831 kernel: NET: Registered protocol family 2 Oct 28 13:09:11.677838 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 28 13:09:11.677859 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 28 13:09:11.677865 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 28 13:09:11.677871 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 28 13:09:11.677879 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 28 13:09:11.677892 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 13:09:11.677901 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 13:09:11.677907 kernel: NET: Registered protocol family 1 Oct 28 13:09:11.677913 kernel: PCI: CLS 0 bytes, default 64 Oct 28 13:09:11.677919 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 28 13:09:11.677926 kernel: kvm [1]: HYP mode not available Oct 28 13:09:11.677933 kernel: Initialise system trusted keyrings Oct 28 13:09:11.677939 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 28 13:09:11.677945 kernel: Key type asymmetric registered Oct 28 13:09:11.677951 kernel: Asymmetric key parser 'x509' registered Oct 28 13:09:11.677957 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 28 13:09:11.677963 kernel: io scheduler mq-deadline registered Oct 28 13:09:11.677969 kernel: io scheduler kyber registered Oct 28 13:09:11.677975 kernel: io scheduler bfq registered Oct 28 13:09:11.677982 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 28 13:09:11.677988 kernel: ACPI: Power Button [PWRB] Oct 28 13:09:11.677994 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 28 13:09:11.678055 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 28 13:09:11.678063 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 28 13:09:11.678069 kernel: msm_serial: driver initialized Oct 28 13:09:11.678075 kernel: random: fast init done Oct 28 13:09:11.678081 kernel: random: crng init done Oct 28 13:09:11.678087 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 28 13:09:11.678094 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 28 13:09:11.678101 kernel: thunder_xcv, ver 1.0 Oct 28 13:09:11.678108 kernel: thunder_bgx, ver 1.0 Oct 28 13:09:11.678113 kernel: nicpf, ver 1.0 Oct 28 13:09:11.678120 kernel: nicvf, ver 1.0 Oct 28 13:09:11.678185 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 28 13:09:11.678236 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-28T13:09:11 UTC (1761656951) Oct 28 13:09:11.678245 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 28 13:09:11.678251 kernel: NET: Registered protocol family 10 Oct 28 13:09:11.678258 kernel: Segment Routing with IPv6 Oct 28 13:09:11.678264 kernel: NET: Registered protocol family 17 Oct 28 13:09:11.678270 kernel: Key type dns_resolver registered Oct 28 13:09:11.678276 kernel: registered taskstats version 1 Oct 28 13:09:11.678282 kernel: Loading compiled-in X.509 certificates Oct 28 13:09:11.678288 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 28 13:09:11.678295 kernel: Key type ._fscrypt registered Oct 28 13:09:11.678301 kernel: Key type .fscrypt registered Oct 28 13:09:11.678307 kernel: Key type fscrypt-provisioning registered Oct 28 13:09:11.678314 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 28 13:09:11.678320 kernel: ima: Allocated hash algorithm: sha1 Oct 28 13:09:11.678326 kernel: ima: No architecture policies found Oct 28 13:09:11.678332 kernel: Freeing unused kernel memory: 34240K Oct 28 13:09:11.678338 kernel: Run /init as init process Oct 28 13:09:11.678344 kernel: with arguments: Oct 28 13:09:11.678350 kernel: /init Oct 28 13:09:11.678356 kernel: with environment: Oct 28 13:09:11.678361 kernel: HOME=/ Oct 28 13:09:11.678384 kernel: TERM=linux Oct 28 13:09:11.678392 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 28 13:09:11.678400 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:09:11.678408 systemd[1]: Detected virtualization kvm. Oct 28 13:09:11.678414 systemd[1]: Detected architecture arm64. Oct 28 13:09:11.678421 systemd[1]: Running in initial RAM disk. Oct 28 13:09:11.678427 systemd[1]: No hostname configured, using default hostname. Oct 28 13:09:11.678433 systemd[1]: Hostname set to . Oct 28 13:09:11.678442 systemd[1]: Initializing machine ID from VM UUID. Oct 28 13:09:11.678448 systemd[1]: Queued start job for default target Initrd Default Target. Oct 28 13:09:11.678455 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 13:09:11.678461 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 13:09:11.678467 systemd[1]: Reached target Path Units. Oct 28 13:09:11.678473 systemd[1]: Reached target Slice Units. Oct 28 13:09:11.678480 systemd[1]: Reached target Swaps. Oct 28 13:09:11.678486 systemd[1]: Reached target Timer Units. Oct 28 13:09:11.678494 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 28 13:09:11.678500 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 28 13:09:11.678507 systemd[1]: Listening on Journal Audit Socket. Oct 28 13:09:11.678513 systemd[1]: Listening on Journal Socket (/dev/log). Oct 28 13:09:11.678519 systemd[1]: Listening on Journal Socket. Oct 28 13:09:11.678526 systemd[1]: Listening on udev Control Socket. Oct 28 13:09:11.678532 systemd[1]: Listening on udev Kernel Socket. Oct 28 13:09:11.678538 systemd[1]: Reached target Socket Units. Oct 28 13:09:11.678545 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 28 13:09:11.678552 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 13:09:11.678559 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 28 13:09:11.678565 systemd[1]: Starting Journal Service... Oct 28 13:09:11.678572 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 13:09:11.678578 systemd[1]: Starting Apply Kernel Variables... Oct 28 13:09:11.678585 systemd[1]: Starting Setup Virtual Console... Oct 28 13:09:11.678591 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 28 13:09:11.678597 kernel: SCSI subsystem initialized Oct 28 13:09:11.678604 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 13:09:11.678611 systemd[1]: Finished Apply Kernel Variables. Oct 28 13:09:11.678617 kernel: Loading iSCSI transport class v2.0-870. Oct 28 13:09:11.678623 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 13:09:11.678635 systemd-journald[270]: Journal started Oct 28 13:09:11.678670 systemd-journald[270]: Runtime Journal (/run/log/journal/57604dadc2db40c688f6ae75d55b33be) is 6.0M, max 48.5M, 42.4M free. Oct 28 13:09:11.679768 systemd[1]: Started Journal Service. Oct 28 13:09:11.680691 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 13:09:11.681696 systemd[1]: Finished Setup Virtual Console. Oct 28 13:09:11.683542 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 28 13:09:11.697906 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 28 13:09:11.699415 systemd[1]: Starting dracut cmdline hook... Oct 28 13:09:11.707902 dracut-cmdline[289]: dracut-dracut-053 Oct 28 13:09:11.710037 dracut-cmdline[289]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 28 13:09:11.764390 kernel: iscsi: registered transport (tcp) Oct 28 13:09:11.775382 kernel: iscsi: registered transport (qla4xxx) Oct 28 13:09:11.775401 kernel: QLogic iSCSI HBA Driver Oct 28 13:09:11.784479 systemd[1]: Finished dracut cmdline hook. Oct 28 13:09:11.785788 systemd[1]: Starting dracut pre-udev hook... Oct 28 13:09:11.786897 systemd[1]: Starting Open-iSCSI... Oct 28 13:09:11.789125 iscsid[374]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 28 13:09:11.789125 iscsid[374]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Oct 28 13:09:11.789125 iscsid[374]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 28 13:09:11.789125 iscsid[374]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 28 13:09:11.789125 iscsid[374]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 28 13:09:11.798635 iscsid[374]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 28 13:09:11.792768 systemd[1]: Started Open-iSCSI. Oct 28 13:09:11.801887 kernel: device-mapper: uevent: version 1.0.3 Oct 28 13:09:11.801902 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 28 13:09:11.835391 kernel: raid6: neonx8 gen() 13768 MB/s Oct 28 13:09:11.852381 kernel: raid6: neonx8 xor() 10737 MB/s Oct 28 13:09:11.869382 kernel: raid6: neonx4 gen() 13620 MB/s Oct 28 13:09:11.886391 kernel: raid6: neonx4 xor() 11559 MB/s Oct 28 13:09:11.903379 kernel: raid6: neonx2 gen() 12994 MB/s Oct 28 13:09:11.920380 kernel: raid6: neonx2 xor() 9870 MB/s Oct 28 13:09:11.937380 kernel: raid6: neonx1 gen() 10937 MB/s Oct 28 13:09:11.954386 kernel: raid6: neonx1 xor() 8822 MB/s Oct 28 13:09:11.971385 kernel: raid6: int64x8 gen() 6823 MB/s Oct 28 13:09:11.988393 kernel: raid6: int64x8 xor() 3791 MB/s Oct 28 13:09:12.005391 kernel: raid6: int64x4 gen() 6897 MB/s Oct 28 13:09:12.022384 kernel: raid6: int64x4 xor() 3830 MB/s Oct 28 13:09:12.039384 kernel: raid6: int64x2 gen() 6178 MB/s Oct 28 13:09:12.056387 kernel: raid6: int64x2 xor() 3314 MB/s Oct 28 13:09:12.073382 kernel: raid6: int64x1 gen() 5003 MB/s Oct 28 13:09:12.090409 kernel: raid6: int64x1 xor() 2594 MB/s Oct 28 13:09:12.090421 kernel: raid6: using algorithm neonx8 gen() 13768 MB/s Oct 28 13:09:12.090429 kernel: raid6: .... xor() 10737 MB/s, rmw enabled Oct 28 13:09:12.091435 kernel: raid6: using neon recovery algorithm Oct 28 13:09:12.101609 kernel: xor: measuring software checksum speed Oct 28 13:09:12.101623 kernel: 8regs : 17120 MB/sec Oct 28 13:09:12.102578 kernel: 32regs : 20786 MB/sec Oct 28 13:09:12.104004 kernel: arm64_neon : 29142 MB/sec Oct 28 13:09:12.104015 kernel: xor: using function: arm64_neon (29142 MB/sec) Oct 28 13:09:12.148388 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 28 13:09:12.157775 systemd[1]: Finished dracut pre-udev hook. Oct 28 13:09:12.161332 kernel: audit: type=1334 audit(1761656952.158:2): prog-id=6 op=LOAD Oct 28 13:09:12.161378 kernel: audit: type=1334 audit(1761656952.158:3): prog-id=7 op=LOAD Oct 28 13:09:12.161387 kernel: audit: type=1334 audit(1761656952.158:4): prog-id=8 op=LOAD Oct 28 13:09:12.158000 audit: BPF prog-id=6 op=LOAD Oct 28 13:09:12.158000 audit: BPF prog-id=7 op=LOAD Oct 28 13:09:12.158000 audit: BPF prog-id=8 op=LOAD Oct 28 13:09:12.159461 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 13:09:12.171708 systemd-udevd[407]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 13:09:12.173374 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 13:09:12.175265 systemd[1]: Starting dracut pre-trigger hook... Oct 28 13:09:12.185575 dracut-pre-trigger[415]: rd.md=0: removing MD RAID activation Oct 28 13:09:12.206451 systemd[1]: Finished dracut pre-trigger hook. Oct 28 13:09:12.207709 systemd[1]: Starting Coldplug All udev Devices... Oct 28 13:09:12.216746 systemd-udevd[407]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 13:09:12.234482 systemd[1]: Finished Coldplug All udev Devices. Oct 28 13:09:12.235856 systemd[1]: Starting dracut initqueue hook... Oct 28 13:09:12.251499 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 28 13:09:12.251610 kernel: vda: detected capacity change from 0 to 4756340736 Oct 28 13:09:12.258383 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 13:09:12.264169 systemd-udevd[467]: Using default interface naming scheme 'v249'. Oct 28 13:09:12.278386 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (458) Oct 28 13:09:12.279489 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 28 13:09:12.282927 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 28 13:09:12.283769 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 28 13:09:12.289059 systemd[1]: Reached target Initrd Root Device. Oct 28 13:09:12.290441 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 28 13:09:12.292791 systemd[1]: Finished dracut initqueue hook. Oct 28 13:09:12.293668 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 28 13:09:12.293787 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 28 13:09:12.295088 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 13:09:12.296563 systemd[1]: Reached target Preparation for Remote File Systems. Oct 28 13:09:12.298191 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 13:09:12.299705 systemd[1]: Reached target Remote File Systems. Oct 28 13:09:12.301667 systemd[1]: Starting dracut pre-mount hook... Oct 28 13:09:12.302911 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 28 13:09:12.309158 systemd[1]: Finished dracut pre-mount hook. Oct 28 13:09:12.310544 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 28 13:09:12.316387 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 28 13:09:12.319990 systemd-fsck[504]: ROOT: clean, 641/553792 files, 42011/553472 blocks Oct 28 13:09:12.322943 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 28 13:09:12.324726 systemd[1]: Mounting /sysroot... Oct 28 13:09:12.338947 systemd[1]: Found device /dev/mapper/usr. Oct 28 13:09:12.340750 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 28 13:09:12.342519 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 28 13:09:12.351346 systemd-fsck[517]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 28 13:09:12.351346 systemd-fsck[517]: You must have r/w access to the filesystem or be root Oct 28 13:09:12.352969 systemd-fsck[514]: fsck failed with exit status 8. Oct 28 13:09:12.352973 systemd-fsck[514]: Ignoring error. Oct 28 13:09:12.353638 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 28 13:09:12.355114 systemd[1]: Mounting /sysusr/usr... Oct 28 13:09:12.367101 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 28 13:09:12.367131 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 28 13:09:12.367589 systemd[1]: Mounted /sysroot. Oct 28 13:09:12.368207 systemd[1]: Reached target Initrd Root File System. Oct 28 13:09:12.369545 systemd[1]: Starting Reload Configuration from the Real Root... Oct 28 13:09:12.375000 audit: BPF prog-id=3 op=UNLOAD Oct 28 13:09:12.373951 systemd[1]: Reloading. Oct 28 13:09:12.378384 kernel: audit: type=1334 audit(1761656952.375:5): prog-id=3 op=UNLOAD Oct 28 13:09:12.383397 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 28 13:09:12.384000 audit: BPF prog-id=6 op=UNLOAD Oct 28 13:09:12.386387 kernel: audit: type=1334 audit(1761656952.384:6): prog-id=6 op=UNLOAD Oct 28 13:09:12.455000 audit: BPF prog-id=9 op=LOAD Oct 28 13:09:12.459474 kernel: audit: type=1334 audit(1761656952.455:7): prog-id=9 op=LOAD Oct 28 13:09:12.459518 kernel: audit: type=1334 audit(1761656952.456:8): prog-id=10 op=LOAD Oct 28 13:09:12.459528 kernel: audit: type=1334 audit(1761656952.457:9): prog-id=11 op=LOAD Oct 28 13:09:12.459536 kernel: audit: type=1334 audit(1761656952.457:10): prog-id=4 op=UNLOAD Oct 28 13:09:12.456000 audit: BPF prog-id=10 op=LOAD Oct 28 13:09:12.457000 audit: BPF prog-id=11 op=LOAD Oct 28 13:09:12.457000 audit: BPF prog-id=4 op=UNLOAD Oct 28 13:09:12.457000 audit: BPF prog-id=5 op=UNLOAD Oct 28 13:09:12.458000 audit: BPF prog-id=12 op=LOAD Oct 28 13:09:12.459000 audit: BPF prog-id=13 op=LOAD Oct 28 13:09:12.459000 audit: BPF prog-id=14 op=LOAD Oct 28 13:09:12.459000 audit: BPF prog-id=7 op=UNLOAD Oct 28 13:09:12.459000 audit: BPF prog-id=8 op=UNLOAD Oct 28 13:09:12.463041 systemd[1]: Mounted /sysusr/usr. Oct 28 13:09:12.464881 systemd[1]: Reached target Local File Systems. Oct 28 13:09:12.465643 systemd[1]: Reached target System Initialization. Oct 28 13:09:12.466993 systemd[1]: Reached target Basic System. Oct 28 13:09:12.469508 systemd[1]: Mounting /sysroot/usr... Oct 28 13:09:12.471809 systemd[1]: Mounted /sysroot/usr. Oct 28 13:09:12.479946 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 28 13:09:12.480062 systemd[1]: Finished Reload Configuration from the Real Root. Oct 28 13:09:12.481764 systemd[1]: Reached target Initrd File Systems. Oct 28 13:09:12.483169 systemd[1]: Reached target Initrd Default Target. Oct 28 13:09:12.484531 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 28 13:09:12.485125 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 28 13:09:12.494732 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 28 13:09:12.496188 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 28 13:09:12.501385 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 13:09:12.502248 systemd[1]: Stopped target Timer Units. Oct 28 13:09:12.503590 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 28 13:09:12.503689 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 28 13:09:12.504971 systemd[1]: Stopped target Initrd Default Target. Oct 28 13:09:12.506351 systemd[1]: Stopped target Basic System. Oct 28 13:09:12.507728 systemd[1]: Stopped target Initrd Root Device. Oct 28 13:09:12.509048 systemd[1]: Stopped target Path Units. Oct 28 13:09:12.510188 systemd[1]: Stopped target Remote File Systems. Oct 28 13:09:12.511501 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 28 13:09:12.512963 systemd[1]: Stopped target Slice Units. Oct 28 13:09:12.514156 systemd[1]: Stopped target Socket Units. Oct 28 13:09:12.515615 systemd[1]: Stopped target System Initialization. Oct 28 13:09:12.516862 systemd[1]: Stopped target Local File Systems. Oct 28 13:09:12.518101 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 13:09:12.519579 systemd[1]: Stopped target Swaps. Oct 28 13:09:12.520700 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 28 13:09:12.520802 systemd[1]: Stopped dracut pre-mount hook. Oct 28 13:09:12.522172 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 13:09:12.523305 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 13:09:12.526421 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 13:09:12.527427 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 28 13:09:12.527519 systemd[1]: Stopped dracut initqueue hook. Oct 28 13:09:12.530959 iscsid[374]: iscsid shutting down. Oct 28 13:09:12.529197 systemd[1]: Stopping Open-iSCSI... Oct 28 13:09:12.530342 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 13:09:12.530449 systemd[1]: Stopped Apply Kernel Variables. Oct 28 13:09:12.531671 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 28 13:09:12.531765 systemd[1]: Stopped Coldplug All udev Devices. Oct 28 13:09:12.532857 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 28 13:09:12.532937 systemd[1]: Stopped dracut pre-trigger hook. Oct 28 13:09:12.534106 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 28 13:09:12.538845 systemd[1]: iscsid.service: Deactivated successfully. Oct 28 13:09:12.538949 systemd[1]: Stopped Open-iSCSI. Oct 28 13:09:12.540239 systemd[1]: iscsid.socket: Deactivated successfully. Oct 28 13:09:12.540281 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 28 13:09:12.541261 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 28 13:09:12.542850 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 28 13:09:12.542952 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 28 13:09:12.544354 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 28 13:09:12.554000 audit: BPF prog-id=12 op=UNLOAD Oct 28 13:09:12.544458 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 28 13:09:12.545889 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 28 13:09:12.545991 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 28 13:09:12.547926 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 28 13:09:12.547972 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 28 13:09:12.549170 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 28 13:09:12.549205 systemd[1]: Closed udev Control Socket. Oct 28 13:09:12.550437 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 28 13:09:12.550467 systemd[1]: Closed udev Kernel Socket. Oct 28 13:09:12.551687 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 28 13:09:12.551724 systemd[1]: Stopped dracut pre-udev hook. Oct 28 13:09:12.553172 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 28 13:09:12.553206 systemd[1]: Stopped dracut cmdline hook. Oct 28 13:09:12.554704 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 28 13:09:12.554749 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 28 13:09:12.556829 systemd[1]: Starting Cleanup udev Database... Oct 28 13:09:12.557578 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 28 13:09:12.559129 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 13:09:12.575000 audit: BPF prog-id=9 op=UNLOAD Oct 28 13:09:12.559182 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 13:09:12.560761 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 28 13:09:12.560800 systemd[1]: Stopped Create List of Static Device Nodes. Oct 28 13:09:12.562168 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 13:09:12.562206 systemd[1]: Stopped Setup Virtual Console. Oct 28 13:09:12.563667 systemd[1]: rngd.service: Deactivated successfully. Oct 28 13:09:12.563775 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 28 13:09:12.565215 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 28 13:09:12.565306 systemd[1]: Finished Cleanup udev Database. Oct 28 13:09:12.566390 systemd[1]: Reached target Switch Root. Oct 28 13:09:12.568260 systemd[1]: Starting Switch Root... Oct 28 13:09:12.575292 systemd[1]: Switching root. Oct 28 13:09:12.596485 systemd-journald[270]: Journal stopped Oct 28 13:09:14.629041 systemd-journald[270]: Received SIGTERM from PID 1 (systemd). Oct 28 13:09:14.629085 kernel: SELinux: policy capability network_peer_controls=1 Oct 28 13:09:14.629100 kernel: SELinux: policy capability open_perms=1 Oct 28 13:09:14.629112 kernel: SELinux: policy capability extended_socket_class=1 Oct 28 13:09:14.629122 kernel: SELinux: policy capability always_check_network=0 Oct 28 13:09:14.629134 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 28 13:09:14.629143 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 28 13:09:14.629151 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 28 13:09:14.629161 systemd[1]: Successfully loaded SELinux policy in 33.105ms. Oct 28 13:09:14.629173 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 5.880ms. Oct 28 13:09:14.629185 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:09:14.629195 systemd[1]: Detected virtualization kvm. Oct 28 13:09:14.629205 systemd[1]: Detected architecture arm64. Oct 28 13:09:14.629216 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:09:14.629228 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:09:14.629238 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 28 13:09:14.629248 systemd[1]: Stopped Switch Root. Oct 28 13:09:14.629257 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 28 13:09:14.629267 systemd[1]: Created slice Slice /system/addon-config. Oct 28 13:09:14.629277 systemd[1]: Created slice Slice /system/addon-run. Oct 28 13:09:14.629287 systemd[1]: Created slice Slice /system/getty. Oct 28 13:09:14.629298 systemd[1]: Created slice Slice /system/modprobe. Oct 28 13:09:14.629308 systemd[1]: Created slice Slice /system/serial-getty. Oct 28 13:09:14.629318 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 28 13:09:14.629328 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 28 13:09:14.629339 systemd[1]: Created slice User and Session Slice. Oct 28 13:09:14.629349 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 13:09:14.629359 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 28 13:09:14.629392 systemd[1]: Set up automount Boot partition Automount Point. Oct 28 13:09:14.629402 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 28 13:09:14.629414 systemd[1]: Stopped target Switch Root. Oct 28 13:09:14.629425 systemd[1]: Stopped target Initrd File Systems. Oct 28 13:09:14.629434 systemd[1]: Stopped target Initrd Root File System. Oct 28 13:09:14.629444 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 13:09:14.629453 systemd[1]: Reached target Remote File Systems. Oct 28 13:09:14.629464 systemd[1]: Reached target Slice Units. Oct 28 13:09:14.629474 systemd[1]: Reached target Swaps. Oct 28 13:09:14.629484 systemd[1]: Reached target Verify torcx succeeded. Oct 28 13:09:14.629494 systemd[1]: Reached target Local Verity Protected Volumes. Oct 28 13:09:14.629504 systemd[1]: Listening on Process Core Dump Socket. Oct 28 13:09:14.629515 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 28 13:09:14.629525 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 13:09:14.629535 systemd[1]: Listening on udev Control Socket. Oct 28 13:09:14.629545 systemd[1]: Listening on udev Kernel Socket. Oct 28 13:09:14.629555 systemd[1]: Mounting Huge Pages File System... Oct 28 13:09:14.629564 systemd[1]: Mounting POSIX Message Queue File System... Oct 28 13:09:14.629573 systemd[1]: Mounting External Media Directory... Oct 28 13:09:14.629583 systemd[1]: Mounting Kernel Debug File System... Oct 28 13:09:14.629593 systemd[1]: Mounting Kernel Trace File System... Oct 28 13:09:14.629603 systemd[1]: Mounting Temporary Directory /tmp... Oct 28 13:09:14.629613 systemd[1]: Starting Create missing system files... Oct 28 13:09:14.629622 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 13:09:14.629633 systemd[1]: Starting Load Kernel Module configfs... Oct 28 13:09:14.629642 systemd[1]: Starting Load Kernel Module drm... Oct 28 13:09:14.629651 systemd[1]: Starting Load Kernel Module fuse... Oct 28 13:09:14.629661 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 28 13:09:14.629671 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 28 13:09:14.629680 systemd[1]: Stopped File System Check on Root Device. Oct 28 13:09:14.629691 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 28 13:09:14.629700 systemd[1]: Stopped systemd-fsck-usr.service. Oct 28 13:09:14.629710 systemd[1]: Stopped Journal Service. Oct 28 13:09:14.629719 kernel: fuse: init (API version 7.32) Oct 28 13:09:14.629733 systemd[1]: Starting Journal Service... Oct 28 13:09:14.629744 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 13:09:14.629753 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 28 13:09:14.629763 systemd[1]: Starting Apply Kernel Variables... Oct 28 13:09:14.629772 systemd[1]: Starting Coldplug All udev Devices... Oct 28 13:09:14.629782 systemd[1]: verity-setup.service: Deactivated successfully. Oct 28 13:09:14.629793 systemd[1]: Stopped verity-setup.service. Oct 28 13:09:14.629804 systemd-journald[693]: Journal started Oct 28 13:09:14.629838 systemd-journald[693]: Runtime Journal (/run/log/journal/57604dadc2db40c688f6ae75d55b33be) is 6.0M, max 48.5M, 42.4M free. Oct 28 13:09:12.668000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 28 13:09:12.693000 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:09:12.693000 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:09:12.693000 audit: BPF prog-id=15 op=LOAD Oct 28 13:09:12.693000 audit: BPF prog-id=15 op=UNLOAD Oct 28 13:09:12.693000 audit: BPF prog-id=16 op=LOAD Oct 28 13:09:12.693000 audit: BPF prog-id=16 op=UNLOAD Oct 28 13:09:12.728000 audit[646]: AVC avc: denied { associate } for pid=646 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Oct 28 13:09:14.520000 audit: BPF prog-id=17 op=LOAD Oct 28 13:09:14.520000 audit: BPF prog-id=18 op=LOAD Oct 28 13:09:14.520000 audit: BPF prog-id=19 op=LOAD Oct 28 13:09:14.520000 audit: BPF prog-id=10 op=UNLOAD Oct 28 13:09:14.520000 audit: BPF prog-id=11 op=UNLOAD Oct 28 13:09:14.529000 audit: BPF prog-id=17 op=UNLOAD Oct 28 13:09:14.615000 audit: BPF prog-id=20 op=LOAD Oct 28 13:09:14.615000 audit: BPF prog-id=21 op=LOAD Oct 28 13:09:14.615000 audit: BPF prog-id=22 op=LOAD Oct 28 13:09:14.615000 audit: BPF prog-id=18 op=UNLOAD Oct 28 13:09:14.615000 audit: BPF prog-id=19 op=UNLOAD Oct 28 13:09:14.627000 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:09:14.506133 systemd[1]: Queued start job for default target Multi-User System. Oct 28 13:09:12.726715 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" 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:09:14.521250 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 28 13:09:12.727000 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 13:09:12.727019 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 13:09:12.727316 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 28 13:09:12.727330 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 28 13:09:12.727363 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 28 13:09:12.727394 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 28 13:09:12.727700 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 28 13:09:12.727752 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 13:09:12.727768 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 13:09:12.728110 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" 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:09:12.728141 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" 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:09:12.728161 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" 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:09:12.728177 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" 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:09:12.728275 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" 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:09:12.728291 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:12Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 28 13:09:14.421665 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:14Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 13:09:14.421950 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:14Z" 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:09:14.422099 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:14Z" 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:09:14.422222 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:14Z" 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:09:14.422315 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:14Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 28 13:09:14.422390 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-28T13:09:14Z" 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:09:14.631601 systemd[1]: Started Journal Service. Oct 28 13:09:14.632085 systemd[1]: Mounted Huge Pages File System. Oct 28 13:09:14.633022 systemd[1]: Mounted POSIX Message Queue File System. Oct 28 13:09:14.633967 systemd[1]: Mounted External Media Directory. Oct 28 13:09:14.634822 systemd[1]: Mounted Kernel Debug File System. Oct 28 13:09:14.635656 systemd[1]: Mounted Kernel Trace File System. Oct 28 13:09:14.636505 systemd[1]: Mounted Temporary Directory /tmp. Oct 28 13:09:14.637570 systemd[1]: Finished Create missing system files. Oct 28 13:09:14.638643 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 13:09:14.639720 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 28 13:09:14.639921 systemd[1]: Finished Load Kernel Module configfs. Oct 28 13:09:14.640953 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 13:09:14.641120 systemd[1]: Finished Load Kernel Module drm. Oct 28 13:09:14.642111 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 28 13:09:14.642281 systemd[1]: Finished Load Kernel Module fuse. Oct 28 13:09:14.657976 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 28 13:09:14.659525 systemd[1]: Finished Apply Kernel Variables. Oct 28 13:09:14.662173 systemd[1]: Mounting FUSE Control File System... Oct 28 13:09:14.663823 systemd[1]: Mounting Kernel Configuration File System... Oct 28 13:09:14.664622 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 28 13:09:14.665515 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 28 13:09:14.666580 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 28 13:09:14.667504 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 28 13:09:14.668548 systemd[1]: Starting Load/Save Random Seed... Oct 28 13:09:14.669363 systemd[1]: Condition check resulted in Create System Users being skipped. Oct 28 13:09:14.671626 systemd-journald[693]: Time spent on flushing to /var/log/journal/57604dadc2db40c688f6ae75d55b33be is 9.548ms for 655 entries. Oct 28 13:09:14.671626 systemd-journald[693]: System Journal (/var/log/journal/57604dadc2db40c688f6ae75d55b33be) is 16.0M, max 203.0M, 187.0M free. Oct 28 13:09:14.692000 audit: BPF prog-id=23 op=LOAD Oct 28 13:09:14.692000 audit: BPF prog-id=24 op=LOAD Oct 28 13:09:14.692000 audit: BPF prog-id=25 op=LOAD Oct 28 13:09:14.692000 audit: BPF prog-id=13 op=UNLOAD Oct 28 13:09:14.692000 audit: BPF prog-id=14 op=UNLOAD Oct 28 13:09:14.670326 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 13:09:14.672074 systemd[1]: Mounted FUSE Control File System. Oct 28 13:09:14.674145 systemd[1]: Mounted Kernel Configuration File System. Oct 28 13:09:14.677160 systemd[1]: Finished Load/Save Random Seed. Oct 28 13:09:14.678401 systemd[1]: Condition check resulted in First Boot Complete being skipped. Oct 28 13:09:14.682254 systemd[1]: Finished Coldplug All udev Devices. Oct 28 13:09:14.690243 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 28 13:09:14.691521 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 13:09:14.693809 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 13:09:14.695118 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 28 13:09:14.715866 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 13:09:14.722000 audit: BPF prog-id=26 op=LOAD Oct 28 13:09:14.723450 systemd[1]: Starting Network Configuration... Oct 28 13:09:14.746654 systemd-udevd[712]: Using default interface naming scheme 'v249'. Oct 28 13:09:14.751884 systemd-networkd[723]: lo: Link UP Oct 28 13:09:14.751889 systemd-networkd[723]: lo: Gained carrier Oct 28 13:09:14.752181 systemd-networkd[723]: Enumeration completed Oct 28 13:09:14.752274 systemd[1]: Started Network Configuration. Oct 28 13:09:14.754149 systemd-networkd[723]: eth0: Link UP Oct 28 13:09:14.759437 systemd-networkd[723]: eth0: Gained carrier Oct 28 13:09:14.763160 udevadm[705]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 28 13:09:14.764485 systemd-networkd[723]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 28 13:09:14.785927 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 28 13:09:14.802354 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 13:09:14.810630 lvm[733]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 13:09:14.845857 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 13:09:14.847269 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 13:09:14.858543 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 13:09:14.862044 lvm[734]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 13:09:14.883508 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 13:09:14.884432 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 13:09:14.885335 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 28 13:09:14.885363 systemd[1]: Reached target Containers. Oct 28 13:09:14.894623 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 28 13:09:14.905917 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 28 13:09:14.907936 systemd[1]: Mounting /usr/share/oem... Oct 28 13:09:14.913622 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 13:09:14.913750 kernel: BTRFS info (device vda6): has skinny extents Oct 28 13:09:14.915683 systemd[1]: Mounted /usr/share/oem. Oct 28 13:09:14.916404 systemd[1]: Reached target Local File Systems. Oct 28 13:09:14.917200 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Oct 28 13:09:14.917543 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 28 13:09:14.917577 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 28 13:09:14.917605 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 28 13:09:14.918460 systemd[1]: Starting Create Volatile Files and Directories... Oct 28 13:09:14.923970 systemd-tmpfiles[757]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 28 13:09:14.924967 systemd-tmpfiles[757]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 28 13:09:14.951234 systemd-tmpfiles[757]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 13:09:14.951246 systemd-tmpfiles[757]: Skipping /boot Oct 28 13:09:14.956482 systemd-tmpfiles[757]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 13:09:14.956496 systemd-tmpfiles[757]: Skipping /boot Oct 28 13:09:14.986285 systemd[1]: Finished Create Volatile Files and Directories. Oct 28 13:09:15.011744 systemd[1]: Starting Load Security Auditing Rules... Oct 28 13:09:15.013720 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 28 13:09:15.014776 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Oct 28 13:09:15.015000 audit: BPF prog-id=27 op=LOAD Oct 28 13:09:15.016228 systemd[1]: Starting Network Name Resolution... Oct 28 13:09:15.017000 audit: BPF prog-id=28 op=LOAD Oct 28 13:09:15.018678 systemd[1]: Starting Network Time Synchronization... Oct 28 13:09:15.019493 systemd[1]: Condition check resulted in Update is Completed being skipped. Oct 28 13:09:15.020428 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 28 13:09:15.021764 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 28 13:09:15.024678 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 28 13:09:15.032710 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 28 13:09:15.035000 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:09:15.035852 augenrules[778]: No rules Oct 28 13:09:15.038038 systemd[1]: Finished Load Security Auditing Rules. Oct 28 13:09:15.054948 systemd-resolved[761]: Positive Trust Anchors: Oct 28 13:09:15.054963 systemd-resolved[761]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 13:09:15.054991 systemd-resolved[761]: 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:09:15.055745 systemd-resolved[761]: Defaulting to hostname 'linux'. Oct 28 13:09:14.581668 systemd-timesyncd[767]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 28 13:09:14.582024 systemd-resolved[761]: Clock change detected. Flushing caches. Oct 28 13:09:14.582271 systemd[1]: Started Network Time Synchronization. Oct 28 13:09:14.583309 systemd[1]: Started Network Name Resolution. Oct 28 13:09:14.584246 systemd[1]: Reached target Network. Oct 28 13:09:14.584991 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 13:09:14.587427 systemd[1]: Reached target System Initialization. Oct 28 13:09:14.588271 systemd[1]: Started Watch for update engine configuration changes. Oct 28 13:09:14.589251 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 13:09:14.590373 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 28 13:09:14.591248 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 28 13:09:14.591276 systemd[1]: Reached target Path Units. Oct 28 13:09:14.591915 systemd[1]: Reached target System Time Set. Oct 28 13:09:14.592874 systemd[1]: Started Daily Log Rotation. Oct 28 13:09:14.593717 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 28 13:09:14.594774 systemd[1]: Reached target Timer Units. Oct 28 13:09:14.596035 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 28 13:09:14.597821 systemd[1]: Starting Docker Socket for the API... Oct 28 13:09:14.600860 systemd[1]: Listening on OpenSSH Server Socket. Oct 28 13:09:14.602075 systemd[1]: Listening on Docker Socket for the API. Oct 28 13:09:14.602901 systemd[1]: Reached target Socket Units. Oct 28 13:09:14.603655 systemd[1]: Reached target Basic System. Oct 28 13:09:14.604383 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 28 13:09:14.604414 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 28 13:09:14.605347 systemd[1]: Started D-Bus System Message Bus. Oct 28 13:09:14.608288 systemd[1]: Starting Extend Filesystems... Oct 28 13:09:14.609009 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 28 13:09:14.609943 systemd[1]: Starting Generate /run/flatcar/motd... Oct 28 13:09:14.611819 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 28 13:09:14.613783 systemd[1]: Starting Generate sshd host keys... Oct 28 13:09:14.614720 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 28 13:09:14.614758 systemd[1]: Reached target Load system-provided cloud configs. Oct 28 13:09:14.617716 systemd[1]: Starting User Login Management... Oct 28 13:09:14.619819 extend-filesystems[789]: Found vda Oct 28 13:09:14.619819 extend-filesystems[789]: Found vda1 Oct 28 13:09:14.619819 extend-filesystems[789]: Found vda2 Oct 28 13:09:14.619819 extend-filesystems[789]: Found vda3 Oct 28 13:09:14.619819 extend-filesystems[789]: Found usr Oct 28 13:09:14.619819 extend-filesystems[789]: Found vda4 Oct 28 13:09:14.619819 extend-filesystems[789]: Found vda6 Oct 28 13:09:14.619819 extend-filesystems[789]: Found vda7 Oct 28 13:09:14.619819 extend-filesystems[789]: Found vda9 Oct 28 13:09:14.619819 extend-filesystems[789]: Checking size of /dev/vda9 Oct 28 13:09:14.618990 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 28 13:09:14.619951 systemd[1]: Starting Update Engine... Oct 28 13:09:14.620645 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 28 13:09:14.620673 systemd[1]: Reached target Load user-provided cloud configs. Oct 28 13:09:14.622744 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 28 13:09:14.622948 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 28 13:09:14.626396 systemd[1]: motdgen.service: Deactivated successfully. Oct 28 13:09:14.626609 systemd[1]: Finished Generate /run/flatcar/motd. Oct 28 13:09:14.633886 extend-filesystems[789]: Old size kept for /dev/vda9 Oct 28 13:09:14.635312 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 28 13:09:14.635535 systemd[1]: Finished Extend Filesystems. Oct 28 13:09:14.663762 systemd[1]: Finished Generate sshd host keys. Oct 28 13:09:14.675007 systemd[1]: Starting Generate /run/issue... Oct 28 13:09:14.678235 update_engine[805]: I1028 13:09:14.677597 805 main.cc:89] Flatcar Update Engine starting Oct 28 13:09:14.678700 update_engine[805]: I1028 13:09:14.678638 805 payload_state.cc:360] Current Response Signature = Oct 28 13:09:14.678700 update_engine[805]: NumURLs = 1 Oct 28 13:09:14.678700 update_engine[805]: Url0 = http://10.0.0.5:34567/packages/update.gz Oct 28 13:09:14.678700 update_engine[805]: Payload Size = 435526319 Oct 28 13:09:14.678700 update_engine[805]: Payload Sha256 Hash = MWe7Cz0hHAZPhG3RiToog9DXtPRhV9ko4O7ML90dZWg= Oct 28 13:09:14.678700 update_engine[805]: Is Delta Payload = 0 Oct 28 13:09:14.678700 update_engine[805]: Max Failure Count Per Url = 10 Oct 28 13:09:14.678700 update_engine[805]: Disable Payload Backoff = 1 Oct 28 13:09:14.678819 systemd-logind[802]: Watching system buttons on /dev/input/event0 (Power Button) Oct 28 13:09:14.678982 update_engine[805]: I1028 13:09:14.678854 805 payload_state.cc:381] Payload Attempt Number = 0 Oct 28 13:09:14.679607 update_engine[805]: I1028 13:09:14.679049 805 payload_state.cc:404] Current URL Index = 0 Oct 28 13:09:14.679607 update_engine[805]: I1028 13:09:14.679225 805 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 28 13:09:14.679607 update_engine[805]: I1028 13:09:14.679405 805 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 28 13:09:14.679255 systemd-logind[802]: New seat seat0. Oct 28 13:09:14.679772 systemd[1]: issuegen.service: Deactivated successfully. Oct 28 13:09:14.679988 systemd[1]: Finished Generate /run/issue. Oct 28 13:09:14.681842 update_engine[805]: I1028 13:09:14.681500 805 update_check_scheduler.cc:74] Next update check in 4m4s Oct 28 13:09:14.682202 systemd[1]: Starting Permit User Sessions... Oct 28 13:09:14.683151 systemd[1]: Started Update Engine. Oct 28 13:09:14.685640 systemd[1]: Started User Login Management. Oct 28 13:09:14.687959 systemd[1]: Finished Permit User Sessions. Oct 28 13:09:14.689914 systemd[1]: Started Getty on tty1. Oct 28 13:09:14.691730 systemd[1]: Started Serial Getty on ttyAMA0. Oct 28 13:09:14.692713 systemd[1]: Reached target Login Prompts. Oct 28 13:09:14.693542 systemd[1]: Reached target Multi-User System. Oct 28 13:09:14.695354 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 28 13:09:14.700528 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 28 13:09:14.700730 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 28 13:09:14.701720 systemd[1]: Startup finished in 693ms (kernel) + 1.069s (initrd) + 2.543s (userspace) = 4.306s. Oct 28 13:09:15.546624 systemd-networkd[723]: eth0: Gained IPv6LL Oct 28 13:09:24.559534 systemd[1]: Created slice Slice /system/sshd. Oct 28 13:09:24.560572 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54968). Oct 28 13:09:24.599949 sshd[829]: Accepted publickey for core from 10.0.0.1 port 54968 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:24.601993 sshd[829]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:24.616185 systemd[1]: Created slice User Slice of UID 500. Oct 28 13:09:24.617111 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 28 13:09:24.618596 systemd-logind[802]: New session 1 of user core. Oct 28 13:09:24.622634 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 28 13:09:24.623727 systemd[1]: Starting User Manager for UID 500... Oct 28 13:09:24.625819 systemd[832]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:24.670242 systemd[832]: Queued start job for default target Main User Target. Oct 28 13:09:24.670374 systemd[832]: Reached target Paths. Oct 28 13:09:24.670388 systemd[832]: Reached target Sockets. Oct 28 13:09:24.670398 systemd[832]: Reached target Timers. Oct 28 13:09:24.670420 systemd[832]: Reached target Basic System. Oct 28 13:09:24.670461 systemd[832]: Reached target Main User Target. Oct 28 13:09:24.670474 systemd[832]: Startup finished in 41ms. Oct 28 13:09:24.670513 systemd[1]: Started User Manager for UID 500. Oct 28 13:09:24.677544 systemd[1]: Started Session 1 of User core. Oct 28 13:09:24.735503 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54972). Oct 28 13:09:24.775713 sshd[841]: Accepted publickey for core from 10.0.0.1 port 54972 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:24.776644 sshd[841]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:24.779156 systemd-logind[802]: New session 2 of user core. Oct 28 13:09:24.794574 systemd[1]: Started Session 2 of User core. Oct 28 13:09:24.847769 sshd[841]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:24.859844 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:54972.service: Deactivated successfully. Oct 28 13:09:24.860391 systemd[1]: session-2.scope: Deactivated successfully. Oct 28 13:09:24.860927 systemd-logind[802]: Session 2 logged out. Waiting for processes to exit. Oct 28 13:09:24.861827 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54978). Oct 28 13:09:24.863544 systemd-logind[802]: Removed session 2. Oct 28 13:09:24.896766 sshd[847]: Accepted publickey for core from 10.0.0.1 port 54978 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:24.897988 sshd[847]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:24.901594 systemd-logind[802]: New session 3 of user core. Oct 28 13:09:24.912807 systemd[1]: Started Session 3 of User core. Oct 28 13:09:24.965775 sshd[847]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:24.978856 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:54978.service: Deactivated successfully. Oct 28 13:09:24.979342 systemd[1]: session-3.scope: Deactivated successfully. Oct 28 13:09:24.979866 systemd-logind[802]: Session 3 logged out. Waiting for processes to exit. Oct 28 13:09:24.980720 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54984). Oct 28 13:09:24.981234 systemd-logind[802]: Removed session 3. Oct 28 13:09:25.016394 sshd[853]: Accepted publickey for core from 10.0.0.1 port 54984 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:25.017186 sshd[853]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:25.019601 systemd-logind[802]: New session 4 of user core. Oct 28 13:09:25.037695 systemd[1]: Started Session 4 of User core. Oct 28 13:09:25.089556 sshd[853]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:25.101973 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:54984.service: Deactivated successfully. Oct 28 13:09:25.102544 systemd[1]: session-4.scope: Deactivated successfully. Oct 28 13:09:25.103113 systemd-logind[802]: Session 4 logged out. Waiting for processes to exit. Oct 28 13:09:25.103981 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54992). Oct 28 13:09:25.104634 systemd-logind[802]: Removed session 4. Oct 28 13:09:25.143029 sshd[859]: Accepted publickey for core from 10.0.0.1 port 54992 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:25.144133 sshd[859]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:25.146791 systemd-logind[802]: New session 5 of user core. Oct 28 13:09:25.159510 systemd[1]: Started Session 5 of User core. Oct 28 13:09:25.218756 sudo[862]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 28 13:09:25.218949 sudo[862]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:09:25.241113 sudo[862]: pam_unix(sudo:session): session closed for user root Oct 28 13:09:25.243588 sshd[859]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:25.264996 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55002). Oct 28 13:09:25.267278 dbus-daemon[788]: [system] Reloaded configuration Oct 28 13:09:25.269324 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:54992.service: Deactivated successfully. Oct 28 13:09:25.269869 systemd[1]: session-5.scope: Deactivated successfully. Oct 28 13:09:25.270493 systemd-logind[802]: Session 5 logged out. Waiting for processes to exit. Oct 28 13:09:25.271189 systemd-logind[802]: Removed session 5. Oct 28 13:09:25.299637 sshd[865]: Accepted publickey for core from 10.0.0.1 port 55002 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:25.300714 sshd[865]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:25.302938 systemd-logind[802]: New session 6 of user core. Oct 28 13:09:25.315806 systemd[1]: Started Session 6 of User core. Oct 28 13:09:25.368034 sudo[870]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 28 13:09:25.368248 sudo[870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:09:25.370212 sudo[870]: pam_unix(sudo:session): session closed for user root Oct 28 13:09:25.373539 sudo[869]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 28 13:09:25.373715 sudo[869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 13:09:25.391828 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 13:09:25.392000 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:09:25.394263 auditctl[873]: No rules Oct 28 13:09:25.395548 kernel: kauditd_printk_skb: 37 callbacks suppressed Oct 28 13:09:25.395575 kernel: audit: type=1305 audit(1761656965.392:48): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 28 13:09:25.395762 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 13:09:25.395980 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 13:09:25.397210 systemd[1]: Starting Load Security Auditing Rules... Oct 28 13:09:25.411146 augenrules[890]: No rules Oct 28 13:09:25.411775 systemd[1]: Finished Load Security Auditing Rules. Oct 28 13:09:25.412756 sudo[869]: pam_unix(sudo:session): session closed for user root Oct 28 13:09:25.413785 sshd[865]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:25.430736 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:55002.service: Deactivated successfully. Oct 28 13:09:25.431303 systemd[1]: session-6.scope: Deactivated successfully. Oct 28 13:09:25.431895 systemd-logind[802]: Session 6 logged out. Waiting for processes to exit. Oct 28 13:09:25.432761 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55016). Oct 28 13:09:25.433441 systemd-logind[802]: Removed session 6. Oct 28 13:09:25.468591 sshd[897]: Accepted publickey for core from 10.0.0.1 port 55016 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:25.469485 sshd[897]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:25.471109 kernel: audit: type=1006 audit(1761656965.468:49): pid=897 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:09:25.473276 systemd-logind[802]: New session 7 of user core. Oct 28 13:09:25.484019 systemd[1]: Started Session 7 of User core. Oct 28 13:09:25.533764 sshd[897]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:25.542893 systemd[1]: sshd@6-10.0.0.6:22-10.0.0.1:55016.service: Deactivated successfully. Oct 28 13:09:25.543559 systemd[1]: session-7.scope: Deactivated successfully. Oct 28 13:09:25.544194 systemd-logind[802]: Session 7 logged out. Waiting for processes to exit. Oct 28 13:09:25.545322 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55030). Oct 28 13:09:25.545976 systemd-logind[802]: Removed session 7. Oct 28 13:09:25.582912 sshd[903]: Accepted publickey for core from 10.0.0.1 port 55030 ssh2: RSA SHA256:zsKx59z7N0uF+86JNC7swOLVvTHiFObk4TkoPh6KYG0 Oct 28 13:09:25.584267 sshd[903]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 13:09:25.586117 kernel: audit: type=1006 audit(1761656965.582:50): pid=903 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Oct 28 13:09:25.588430 systemd-logind[802]: New session 8 of user core. Oct 28 13:09:25.598160 systemd[1]: Started Session 8 of User core. Oct 28 13:09:25.650664 sshd[903]: pam_unix(sshd:session): session closed for user core Oct 28 13:09:25.652780 systemd[1]: sshd@7-10.0.0.6:22-10.0.0.1:55030.service: Deactivated successfully. Oct 28 13:09:25.653346 systemd[1]: session-8.scope: Deactivated successfully. Oct 28 13:09:25.653880 systemd-logind[802]: Session 8 logged out. Waiting for processes to exit. Oct 28 13:09:25.654527 systemd-logind[802]: Removed session 8.