Oct 31 13:29:22.687513 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 31 13:29:22.687529 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 31 13:29:22.687537 kernel: efi: EFI v2.70 by EDK II Oct 31 13:29:22.687542 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 31 13:29:22.687547 kernel: efi: seeding entropy pool Oct 31 13:29:22.687552 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 31 13:29:22.687558 kernel: ACPI: Early table checksum verification disabled Oct 31 13:29:22.687563 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 31 13:29:22.687568 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 31 13:29:22.687573 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:22.687579 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:22.687584 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:22.687589 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:22.687594 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:22.687600 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:22.687605 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:22.687611 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:22.687616 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:22.687622 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 31 13:29:22.687627 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 31 13:29:22.687632 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 31 13:29:22.687637 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 31 13:29:22.687642 kernel: Zone ranges: Oct 31 13:29:22.687647 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 31 13:29:22.687652 kernel: DMA32 empty Oct 31 13:29:22.687657 kernel: Normal empty Oct 31 13:29:22.687662 kernel: Movable zone start for each node Oct 31 13:29:22.687668 kernel: Early memory node ranges Oct 31 13:29:22.687673 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 31 13:29:22.687678 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 31 13:29:22.687683 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 31 13:29:22.687688 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 31 13:29:22.687693 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 31 13:29:22.687698 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 31 13:29:22.687703 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 31 13:29:22.687708 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 31 13:29:22.687713 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 31 13:29:22.687718 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 31 13:29:22.687723 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 31 13:29:22.687729 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 31 13:29:22.687737 kernel: On node 0 totalpages: 643072 Oct 31 13:29:22.687743 kernel: DMA zone: 10048 pages used for memmap Oct 31 13:29:22.687748 kernel: DMA zone: 0 pages reserved Oct 31 13:29:22.687762 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 31 13:29:22.687767 kernel: psci: probing for conduit method from ACPI. Oct 31 13:29:22.687773 kernel: psci: PSCIv1.1 detected in firmware. Oct 31 13:29:22.687778 kernel: psci: Using standard PSCI v0.2 function IDs Oct 31 13:29:22.687784 kernel: psci: Trusted OS migration not required Oct 31 13:29:22.687791 kernel: psci: SMC Calling Convention v1.1 Oct 31 13:29:22.687796 kernel: ACPI: SRAT not present Oct 31 13:29:22.687802 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 31 13:29:22.687807 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 31 13:29:22.687813 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 31 13:29:22.687818 kernel: Detected PIPT I-cache on CPU0 Oct 31 13:29:22.687823 kernel: CPU features: detected: GIC system register CPU interface Oct 31 13:29:22.687829 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 31 13:29:22.687834 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 31 13:29:22.687840 kernel: CPU features: detected: Hardware dirty bit management Oct 31 13:29:22.687845 kernel: CPU features: detected: Spectre-v4 Oct 31 13:29:22.687851 kernel: CPU features: detected: ARM erratum 1418040 Oct 31 13:29:22.687857 kernel: CPU features: detected: Spectre-BHB Oct 31 13:29:22.687870 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 31 13:29:22.687876 kernel: Policy zone: DMA Oct 31 13:29:22.687883 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 31 13:29:22.687889 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 31 13:29:22.687894 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 31 13:29:22.687900 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 31 13:29:22.687905 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 31 13:29:22.687911 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 31 13:29:22.687916 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 31 13:29:22.687923 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 31 13:29:22.687929 kernel: rcu: RCU event tracing is enabled. Oct 31 13:29:22.687935 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 31 13:29:22.687940 kernel: Trampoline variant of Tasks RCU enabled. Oct 31 13:29:22.687946 kernel: Tracing variant of Tasks RCU enabled. Oct 31 13:29:22.687951 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 31 13:29:22.687957 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 31 13:29:22.687962 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 31 13:29:22.687968 kernel: GICv3: 256 SPIs implemented Oct 31 13:29:22.687973 kernel: GICv3: 0 Extended SPIs implemented Oct 31 13:29:22.687978 kernel: GICv3: Distributor has no Range Selector support Oct 31 13:29:22.687984 kernel: GICv3: 16 PPIs implemented Oct 31 13:29:22.687990 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 31 13:29:22.687996 kernel: ACPI: SRAT not present Oct 31 13:29:22.688001 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 31 13:29:22.688006 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 31 13:29:22.688012 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 31 13:29:22.688018 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 31 13:29:22.688023 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 31 13:29:22.688029 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 31 13:29:22.688034 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 31 13:29:22.688040 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 31 13:29:22.688046 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 31 13:29:22.688051 kernel: arm-pv: using stolen time PV Oct 31 13:29:22.688058 kernel: Console: colour dummy device 80x25 Oct 31 13:29:22.688064 kernel: ACPI: Core revision 20200925 Oct 31 13:29:22.688069 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 31 13:29:22.688075 kernel: pid_max: default: 32768 minimum: 301 Oct 31 13:29:22.688081 kernel: LSM: Security Framework initializing Oct 31 13:29:22.688086 kernel: SELinux: Initializing. Oct 31 13:29:22.688092 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 31 13:29:22.688098 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 31 13:29:22.688103 kernel: rcu: Hierarchical SRCU implementation. Oct 31 13:29:22.688110 kernel: Platform MSI: ITS@0x8080000 domain created Oct 31 13:29:22.688116 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 31 13:29:22.688121 kernel: Remapping and enabling EFI services. Oct 31 13:29:22.688127 kernel: smp: Bringing up secondary CPUs ... Oct 31 13:29:22.688133 kernel: Detected PIPT I-cache on CPU1 Oct 31 13:29:22.688138 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 31 13:29:22.688144 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 31 13:29:22.688150 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 31 13:29:22.688156 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 31 13:29:22.688162 kernel: Detected PIPT I-cache on CPU2 Oct 31 13:29:22.688168 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 31 13:29:22.688174 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 31 13:29:22.688180 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 31 13:29:22.688186 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 31 13:29:22.688191 kernel: Detected PIPT I-cache on CPU3 Oct 31 13:29:22.688201 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 31 13:29:22.688207 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 31 13:29:22.688214 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 31 13:29:22.688219 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 31 13:29:22.688225 kernel: smp: Brought up 1 node, 4 CPUs Oct 31 13:29:22.688231 kernel: SMP: Total of 4 processors activated. Oct 31 13:29:22.688237 kernel: CPU features: detected: Privileged Access Never Oct 31 13:29:22.688243 kernel: CPU features: detected: LSE atomic instructions Oct 31 13:29:22.688249 kernel: CPU features: detected: User Access Override Oct 31 13:29:22.688255 kernel: CPU features: detected: 32-bit EL0 Support Oct 31 13:29:22.688261 kernel: CPU features: detected: Common not Private translations Oct 31 13:29:22.688267 kernel: CPU features: detected: RAS Extension Support Oct 31 13:29:22.688274 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 31 13:29:22.688280 kernel: CPU features: detected: CRC32 instructions Oct 31 13:29:22.688286 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 31 13:29:22.688292 kernel: CPU: All CPU(s) started at EL1 Oct 31 13:29:22.688298 kernel: alternatives: patching kernel code Oct 31 13:29:22.688304 kernel: devtmpfs: initialized Oct 31 13:29:22.688310 kernel: KASLR enabled Oct 31 13:29:22.688316 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 31 13:29:22.688322 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 31 13:29:22.688328 kernel: pinctrl core: initialized pinctrl subsystem Oct 31 13:29:22.688334 kernel: SMBIOS 3.0.0 present. Oct 31 13:29:22.688340 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 31 13:29:22.688346 kernel: NET: Registered protocol family 16 Oct 31 13:29:22.688352 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 31 13:29:22.688357 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 31 13:29:22.688365 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 31 13:29:22.688371 kernel: audit: initializing netlink subsys (disabled) Oct 31 13:29:22.688377 kernel: audit: type=2000 audit(0.031:1): state=initialized audit_enabled=0 res=1 Oct 31 13:29:22.688383 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 31 13:29:22.688388 kernel: cpuidle: using governor menu Oct 31 13:29:22.688394 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 31 13:29:22.688400 kernel: ASID allocator initialised with 32768 entries Oct 31 13:29:22.688406 kernel: ACPI: bus type PCI registered Oct 31 13:29:22.688412 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 31 13:29:22.688419 kernel: Serial: AMBA PL011 UART driver Oct 31 13:29:22.688425 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 31 13:29:22.688431 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 31 13:29:22.688437 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 31 13:29:22.688443 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 31 13:29:22.688449 kernel: cryptd: max_cpu_qlen set to 1000 Oct 31 13:29:22.688455 kernel: ACPI: Added _OSI(Module Device) Oct 31 13:29:22.688461 kernel: ACPI: Added _OSI(Processor Device) Oct 31 13:29:22.688467 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 31 13:29:22.688474 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 31 13:29:22.688480 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 31 13:29:22.688486 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 31 13:29:22.688492 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 31 13:29:22.688498 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 31 13:29:22.688503 kernel: ACPI: Interpreter enabled Oct 31 13:29:22.688509 kernel: ACPI: Using GIC for interrupt routing Oct 31 13:29:22.688515 kernel: ACPI: MCFG table detected, 1 entries Oct 31 13:29:22.688521 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 31 13:29:22.688527 kernel: printk: console [ttyAMA0] enabled Oct 31 13:29:22.688534 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 31 13:29:22.688639 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 31 13:29:22.688697 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 31 13:29:22.688756 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 31 13:29:22.688819 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 31 13:29:22.688897 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 31 13:29:22.688906 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 31 13:29:22.688915 kernel: PCI host bridge to bus 0000:00 Oct 31 13:29:22.688989 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 31 13:29:22.689045 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 31 13:29:22.689093 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 31 13:29:22.689140 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 31 13:29:22.689206 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 31 13:29:22.689272 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 31 13:29:22.689331 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 31 13:29:22.689386 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 31 13:29:22.689441 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 31 13:29:22.689511 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 31 13:29:22.689565 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 31 13:29:22.689619 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 31 13:29:22.689667 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 31 13:29:22.689716 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 31 13:29:22.689772 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 31 13:29:22.689781 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 31 13:29:22.689788 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 31 13:29:22.689794 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 31 13:29:22.689800 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 31 13:29:22.689806 kernel: vgaarb: loaded Oct 31 13:29:22.689812 kernel: Registered efivars operations Oct 31 13:29:22.689818 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 31 13:29:22.689825 kernel: VFS: Disk quotas dquot_6.6.0 Oct 31 13:29:22.689832 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 31 13:29:22.689838 kernel: pnp: PnP ACPI init Oct 31 13:29:22.689924 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 31 13:29:22.689975 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 31 13:29:22.689983 kernel: pnp: PnP ACPI: found 1 devices Oct 31 13:29:22.689989 kernel: NET: Registered protocol family 2 Oct 31 13:29:22.689996 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 31 13:29:22.690004 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 31 13:29:22.690010 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 31 13:29:22.690016 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 31 13:29:22.690023 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 31 13:29:22.690029 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 31 13:29:22.690035 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 31 13:29:22.690041 kernel: NET: Registered protocol family 1 Oct 31 13:29:22.690047 kernel: PCI: CLS 0 bytes, default 64 Oct 31 13:29:22.690053 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 31 13:29:22.690060 kernel: kvm [1]: HYP mode not available Oct 31 13:29:22.690066 kernel: Initialise system trusted keyrings Oct 31 13:29:22.690072 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 31 13:29:22.690078 kernel: Key type asymmetric registered Oct 31 13:29:22.690084 kernel: Asymmetric key parser 'x509' registered Oct 31 13:29:22.690090 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 31 13:29:22.690096 kernel: io scheduler mq-deadline registered Oct 31 13:29:22.690102 kernel: io scheduler kyber registered Oct 31 13:29:22.690108 kernel: io scheduler bfq registered Oct 31 13:29:22.690115 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 31 13:29:22.690121 kernel: ACPI: Power Button [PWRB] Oct 31 13:29:22.690127 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 31 13:29:22.690180 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 31 13:29:22.690189 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 31 13:29:22.690195 kernel: msm_serial: driver initialized Oct 31 13:29:22.690200 kernel: random: fast init done Oct 31 13:29:22.690207 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 31 13:29:22.690213 kernel: random: crng init done Oct 31 13:29:22.690219 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 31 13:29:22.690227 kernel: thunder_xcv, ver 1.0 Oct 31 13:29:22.690233 kernel: thunder_bgx, ver 1.0 Oct 31 13:29:22.690239 kernel: nicpf, ver 1.0 Oct 31 13:29:22.690245 kernel: nicvf, ver 1.0 Oct 31 13:29:22.690306 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 31 13:29:22.690358 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-31T13:29:22 UTC (1761917362) Oct 31 13:29:22.690366 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 31 13:29:22.690372 kernel: NET: Registered protocol family 10 Oct 31 13:29:22.690379 kernel: Segment Routing with IPv6 Oct 31 13:29:22.690385 kernel: NET: Registered protocol family 17 Oct 31 13:29:22.690391 kernel: Key type dns_resolver registered Oct 31 13:29:22.690397 kernel: registered taskstats version 1 Oct 31 13:29:22.690403 kernel: Loading compiled-in X.509 certificates Oct 31 13:29:22.690409 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 31 13:29:22.690415 kernel: Key type ._fscrypt registered Oct 31 13:29:22.690421 kernel: Key type .fscrypt registered Oct 31 13:29:22.690427 kernel: Key type fscrypt-provisioning registered Oct 31 13:29:22.690434 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 31 13:29:22.690440 kernel: ima: Allocated hash algorithm: sha1 Oct 31 13:29:22.690446 kernel: ima: No architecture policies found Oct 31 13:29:22.690452 kernel: Freeing unused kernel memory: 34240K Oct 31 13:29:22.690458 kernel: Run /init as init process Oct 31 13:29:22.690464 kernel: with arguments: Oct 31 13:29:22.690469 kernel: /init Oct 31 13:29:22.690475 kernel: with environment: Oct 31 13:29:22.690481 kernel: HOME=/ Oct 31 13:29:22.690487 kernel: TERM=linux Oct 31 13:29:22.690493 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 31 13:29:22.690501 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 31 13:29:22.690509 systemd[1]: Detected virtualization kvm. Oct 31 13:29:22.690516 systemd[1]: Detected architecture arm64. Oct 31 13:29:22.690522 systemd[1]: Running in initial RAM disk. Oct 31 13:29:22.690528 systemd[1]: No hostname configured, using default hostname. Oct 31 13:29:22.690534 systemd[1]: Hostname set to . Oct 31 13:29:22.690543 systemd[1]: Initializing machine ID from VM UUID. Oct 31 13:29:22.690549 systemd[1]: Queued start job for default target Initrd Default Target. Oct 31 13:29:22.690556 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 31 13:29:22.690562 systemd[1]: Reached target Local Encrypted Volumes. Oct 31 13:29:22.690568 systemd[1]: Reached target Path Units. Oct 31 13:29:22.690575 systemd[1]: Reached target Slice Units. Oct 31 13:29:22.690581 systemd[1]: Reached target Swaps. Oct 31 13:29:22.690587 systemd[1]: Reached target Timer Units. Oct 31 13:29:22.690595 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 31 13:29:22.690601 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 31 13:29:22.690608 systemd[1]: Listening on Journal Audit Socket. Oct 31 13:29:22.690614 systemd[1]: Listening on Journal Socket (/dev/log). Oct 31 13:29:22.690620 systemd[1]: Listening on Journal Socket. Oct 31 13:29:22.690627 systemd[1]: Listening on Network Service Netlink Socket. Oct 31 13:29:22.690633 systemd[1]: Listening on udev Control Socket. Oct 31 13:29:22.690639 systemd[1]: Listening on udev Kernel Socket. Oct 31 13:29:22.690646 systemd[1]: Reached target Socket Units. Oct 31 13:29:22.690653 systemd[1]: Starting Create List of Static Device Nodes... Oct 31 13:29:22.690660 systemd[1]: Finished Network Cleanup. Oct 31 13:29:22.690666 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 31 13:29:22.690672 systemd[1]: Starting Journal Service... Oct 31 13:29:22.690679 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 31 13:29:22.690685 systemd[1]: Starting Apply Kernel Variables... Oct 31 13:29:22.690691 systemd[1]: Starting Setup Virtual Console... Oct 31 13:29:22.690698 systemd[1]: Finished Create List of Static Device Nodes. Oct 31 13:29:22.690704 systemd[1]: Finished Apply Kernel Variables. Oct 31 13:29:22.690712 systemd[1]: Finished Setup Virtual Console. Oct 31 13:29:22.690718 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 31 13:29:22.690726 systemd-journald[278]: Journal started Oct 31 13:29:22.690769 systemd-journald[278]: Runtime Journal (/run/log/journal/f90c9168c881436b9b049294c1ba7d19) is 6.0M, max 48.5M, 42.4M free. Oct 31 13:29:22.693274 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 31 13:29:22.694898 systemd[1]: Started Journal Service. Oct 31 13:29:22.695040 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 31 13:29:22.708703 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 31 13:29:22.710468 systemd[1]: Starting dracut cmdline hook... Oct 31 13:29:22.719593 dracut-cmdline[296]: dracut-dracut-053 Oct 31 13:29:22.721935 dracut-cmdline[296]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 31 13:29:22.781892 kernel: SCSI subsystem initialized Oct 31 13:29:22.784879 kernel: Loading iSCSI transport class v2.0-870. Oct 31 13:29:22.790898 kernel: iscsi: registered transport (tcp) Oct 31 13:29:22.802047 kernel: iscsi: registered transport (qla4xxx) Oct 31 13:29:22.802063 kernel: QLogic iSCSI HBA Driver Oct 31 13:29:22.811960 systemd[1]: Finished dracut cmdline hook. Oct 31 13:29:22.813434 systemd[1]: Starting dracut pre-udev hook... Oct 31 13:29:22.826636 kernel: device-mapper: uevent: version 1.0.3 Oct 31 13:29:22.826670 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 31 13:29:22.861888 kernel: raid6: neonx8 gen() 13804 MB/s Oct 31 13:29:22.878877 kernel: raid6: neonx8 xor() 10758 MB/s Oct 31 13:29:22.895928 kernel: raid6: neonx4 gen() 13624 MB/s Oct 31 13:29:22.912885 kernel: raid6: neonx4 xor() 11597 MB/s Oct 31 13:29:22.929895 kernel: raid6: neonx2 gen() 13066 MB/s Oct 31 13:29:22.946882 kernel: raid6: neonx2 xor() 9864 MB/s Oct 31 13:29:22.963996 kernel: raid6: neonx1 gen() 10926 MB/s Oct 31 13:29:22.980892 kernel: raid6: neonx1 xor() 8807 MB/s Oct 31 13:29:22.999931 kernel: raid6: int64x8 gen() 6520 MB/s Oct 31 13:29:23.016888 kernel: raid6: int64x8 xor() 3164 MB/s Oct 31 13:29:23.033886 kernel: raid6: int64x4 gen() 6657 MB/s Oct 31 13:29:23.050889 kernel: raid6: int64x4 xor() 3454 MB/s Oct 31 13:29:23.067889 kernel: raid6: int64x2 gen() 5834 MB/s Oct 31 13:29:23.084885 kernel: raid6: int64x2 xor() 3274 MB/s Oct 31 13:29:23.101887 kernel: raid6: int64x1 gen() 4574 MB/s Oct 31 13:29:23.118898 kernel: raid6: int64x1 xor() 2598 MB/s Oct 31 13:29:23.118910 kernel: raid6: using algorithm neonx8 gen() 13804 MB/s Oct 31 13:29:23.118919 kernel: raid6: .... xor() 10758 MB/s, rmw enabled Oct 31 13:29:23.119902 kernel: raid6: using neon recovery algorithm Oct 31 13:29:23.130332 kernel: xor: measuring software checksum speed Oct 31 13:29:23.130350 kernel: 8regs : 17134 MB/sec Oct 31 13:29:23.131312 kernel: 32regs : 20765 MB/sec Oct 31 13:29:23.132134 kernel: arm64_neon : 29184 MB/sec Oct 31 13:29:23.132146 kernel: xor: using function: arm64_neon (29184 MB/sec) Oct 31 13:29:23.178887 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 31 13:29:23.190566 systemd[1]: Finished dracut pre-udev hook. Oct 31 13:29:23.191000 audit: BPF prog-id=6 op=LOAD Oct 31 13:29:23.192000 audit: BPF prog-id=7 op=LOAD Oct 31 13:29:23.192000 audit: BPF prog-id=8 op=LOAD Oct 31 13:29:23.194116 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 31 13:29:23.197894 kernel: audit: type=1334 audit(1761917363.191:2): prog-id=6 op=LOAD Oct 31 13:29:23.197919 kernel: audit: type=1334 audit(1761917363.192:3): prog-id=7 op=LOAD Oct 31 13:29:23.197927 kernel: audit: type=1334 audit(1761917363.192:4): prog-id=8 op=LOAD Oct 31 13:29:23.208010 systemd-udevd[414]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 31 13:29:23.209859 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 31 13:29:23.211716 systemd[1]: Starting dracut pre-trigger hook... Oct 31 13:29:23.220330 systemd[1]: Starting Network Configuration... Oct 31 13:29:23.219000 audit: BPF prog-id=9 op=LOAD Oct 31 13:29:23.222887 kernel: audit: type=1334 audit(1761917363.219:5): prog-id=9 op=LOAD Oct 31 13:29:23.231486 dracut-pre-trigger[419]: rd.md=0: removing MD RAID activation Oct 31 13:29:23.239270 systemd-networkd[433]: lo: Link UP Oct 31 13:29:23.239276 systemd-networkd[433]: lo: Gained carrier Oct 31 13:29:23.239539 systemd-networkd[433]: Enumeration completed Oct 31 13:29:23.239680 systemd[1]: Started Network Configuration. Oct 31 13:29:23.241000 audit: BPF prog-id=10 op=LOAD Oct 31 13:29:23.241541 systemd[1]: Starting Network Name Resolution... Oct 31 13:29:23.245312 kernel: audit: type=1334 audit(1761917363.241:6): prog-id=10 op=LOAD Oct 31 13:29:23.264770 systemd[1]: Finished dracut pre-trigger hook. Oct 31 13:29:23.266165 systemd[1]: Starting Coldplug All udev Devices... Oct 31 13:29:23.277215 systemd-udevd[414]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 31 13:29:23.277984 systemd-resolved[446]: Positive Trust Anchors: Oct 31 13:29:23.277992 systemd-resolved[446]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 31 13:29:23.278021 systemd-resolved[446]: 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 31 13:29:23.278319 systemd-resolved[446]: Defaulting to hostname 'linux'. Oct 31 13:29:23.279609 systemd[1]: Started Network Name Resolution. Oct 31 13:29:23.282111 systemd[1]: Reached target Network. Oct 31 13:29:23.282739 systemd[1]: Reached target Host and Network Name Lookups. Oct 31 13:29:23.285033 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 31 13:29:23.297528 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 31 13:29:23.299024 systemd[1]: Starting Open-iSCSI... Oct 31 13:29:23.301722 iscsid[487]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 31 13:29:23.301722 iscsid[487]: 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 31 13:29:23.301722 iscsid[487]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 31 13:29:23.301722 iscsid[487]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 31 13:29:23.301722 iscsid[487]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 31 13:29:23.301722 iscsid[487]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 31 13:29:23.305111 systemd[1]: Started Open-iSCSI. Oct 31 13:29:23.325684 systemd[1]: Finished Coldplug All udev Devices. Oct 31 13:29:23.327774 systemd[1]: Starting dracut initqueue hook... Oct 31 13:29:23.343944 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 31 13:29:23.344056 kernel: vda: detected capacity change from 0 to 4756340736 Oct 31 13:29:23.352243 systemd-udevd[469]: Using default interface naming scheme 'v249'. Oct 31 13:29:23.354926 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 31 13:29:23.358232 systemd-networkd[433]: eth0: Link UP Oct 31 13:29:23.371656 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 31 13:29:23.373522 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (479) Oct 31 13:29:23.374147 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 31 13:29:23.374973 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 31 13:29:23.381500 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Oct 31 13:29:23.384465 systemd[1]: Found device /dev/disk/by-label/OEM. Oct 31 13:29:23.387521 systemd[1]: Finished dracut initqueue hook. Oct 31 13:29:23.388360 systemd[1]: Reached target Initrd Root Device. Oct 31 13:29:23.389563 systemd[1]: Reached target Preparation for Remote File Systems. Oct 31 13:29:23.390994 systemd[1]: Reached target Remote Encrypted Volumes. Oct 31 13:29:23.392510 systemd[1]: Reached target Remote File Systems. Oct 31 13:29:23.394473 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 31 13:29:23.396016 systemd[1]: Starting dracut pre-mount hook... Oct 31 13:29:23.404058 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 31 13:29:23.404608 systemd[1]: Finished dracut pre-mount hook. Oct 31 13:29:24.400896 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 31 13:29:24.400740 systemd-networkd[433]: eth0: Gained carrier Oct 31 13:29:24.409943 systemd-networkd[433]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 31 13:29:24.411875 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 31 13:29:24.412029 disk-uuid[508]: The operation has completed successfully. Oct 31 13:29:24.431911 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 31 13:29:24.433006 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 31 13:29:24.435530 systemd[1]: Starting Ignition (setup)... Oct 31 13:29:24.443290 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 31 13:29:24.443320 kernel: BTRFS info (device vda6): has skinny extents Oct 31 13:29:24.448973 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 31 13:29:24.454616 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 31 13:29:24.454727 systemd[1]: Finished Ignition (setup). Oct 31 13:29:24.456115 systemd[1]: Starting Ignition (disks)... Oct 31 13:29:24.465598 ignition[544]: Ignition v0.36.1-15-gde4e6cc9 Oct 31 13:29:24.465616 ignition[544]: Stage: disks Oct 31 13:29:24.465625 ignition[544]: reading system config file "/usr/lib/ignition/base.ign" Oct 31 13:29:24.465635 ignition[544]: no config at "/usr/lib/ignition/base.ign" Oct 31 13:29:24.465676 ignition[544]: parsed url from cmdline: "" Oct 31 13:29:24.465679 ignition[544]: no config URL provided Oct 31 13:29:24.465684 ignition[544]: reading system config file "/usr/lib/ignition/user.ign" Oct 31 13:29:24.465690 ignition[544]: no config at "/usr/lib/ignition/user.ign" Oct 31 13:29:24.465708 ignition[544]: op(1): [started] loading QEMU firmware config module Oct 31 13:29:24.465713 ignition[544]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 31 13:29:24.466718 ignition[544]: op(1): [finished] loading QEMU firmware config module Oct 31 13:29:24.479987 ignition[544]: parsing config with SHA512: eb6ff4d1f988152941704362dffa7fd0c17a26e830e06e9c6a8e89f9adb44eb4bbca96d845434573b5e422617dd01db31dd5a1d7ffd5ea8136196a5ce003a147 Oct 31 13:29:24.481985 ignition[544]: disks: disks passed Oct 31 13:29:24.481995 ignition[544]: Ignition finished successfully Oct 31 13:29:24.482548 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 31 13:29:24.482659 systemd[1]: Finished Ignition (disks). Oct 31 13:29:24.483444 systemd[1]: Reached target Preparation for Local File Systems. Oct 31 13:29:24.485355 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 31 13:29:24.486954 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 31 13:29:24.495064 systemd-fsck[557]: ROOT: clean, 528/553792 files, 37752/553472 blocks Oct 31 13:29:24.498889 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 31 13:29:24.499084 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 31 13:29:24.501146 systemd[1]: Mounting /sysroot... Oct 31 13:29:24.518028 systemd[1]: Found device /dev/mapper/usr. Oct 31 13:29:24.519430 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 31 13:29:24.520475 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 31 13:29:24.529025 systemd-fsck[574]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 31 13:29:24.529025 systemd-fsck[574]: You must have r/w access to the filesystem or be root Oct 31 13:29:24.529588 systemd-fsck[572]: fsck failed with exit status 8. Oct 31 13:29:24.529591 systemd-fsck[572]: Ignoring error. Oct 31 13:29:24.532089 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 31 13:29:24.533829 systemd[1]: Mounting /sysusr/usr... Oct 31 13:29:24.548871 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 31 13:29:24.548907 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 31 13:29:24.549626 systemd[1]: Mounted /sysroot. Oct 31 13:29:24.550342 systemd[1]: Reached target Initrd Root File System. Oct 31 13:29:24.562892 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 31 13:29:24.562960 systemd[1]: Mounted /sysusr/usr. Oct 31 13:29:24.563653 systemd[1]: Reached target Local File Systems. Oct 31 13:29:24.564749 systemd[1]: Reached target System Initialization. Oct 31 13:29:24.566115 systemd[1]: Reached target Basic System. Oct 31 13:29:24.568711 systemd[1]: Mounting /sysroot/usr... Oct 31 13:29:24.570991 systemd[1]: Mounted /sysroot/usr. Oct 31 13:29:24.572301 systemd[1]: Starting Root filesystem setup... Oct 31 13:29:24.596286 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 31 13:29:24.596411 systemd[1]: Finished Root filesystem setup. Oct 31 13:29:24.598555 systemd[1]: Starting Ignition (files)... Oct 31 13:29:24.599790 systemd[1]: Starting /sysroot/boot... Oct 31 13:29:24.601726 ignition[590]: Ignition v0.36.1-15-gde4e6cc9 Oct 31 13:29:24.601750 ignition[590]: Stage: files Oct 31 13:29:24.601760 ignition[590]: reading system config file "/usr/lib/ignition/base.ign" Oct 31 13:29:24.601770 ignition[590]: no config at "/usr/lib/ignition/base.ign" Oct 31 13:29:24.602258 ignition[590]: files: compiled without relabeling support, skipping Oct 31 13:29:24.618913 ignition[590]: files: createUsers: op(1): [started] creating or modifying user "core" Oct 31 13:29:24.618924 ignition[590]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Oct 31 13:29:24.621072 ignition[590]: files: createUsers: op(1): [finished] creating or modifying user "core" Oct 31 13:29:24.621086 ignition[590]: files: createUsers: op(2): [started] adding ssh keys to user "core" Oct 31 13:29:24.621253 systemd[1]: Finished /sysroot/boot. Oct 31 13:29:24.623310 ignition[590]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Oct 31 13:29:24.623330 ignition[590]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Oct 31 13:29:24.624055 ignition[590]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Oct 31 13:29:24.629075 systemd[1]: ignition-files.service: Deactivated successfully. Oct 31 13:29:24.624062 ignition[590]: files: op(4): [started] processing unit "coreos-metadata.service" Oct 31 13:29:24.629181 systemd[1]: Finished Ignition (files). Oct 31 13:29:24.624149 ignition[590]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 31 13:29:24.629944 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Oct 31 13:29:24.625952 ignition[590]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 31 13:29:24.636000 audit: BPF prog-id=9 op=UNLOAD Oct 31 13:29:24.639903 kernel: audit: type=1334 audit(1761917364.636:7): prog-id=9 op=UNLOAD Oct 31 13:29:24.630549 systemd[1]: Starting Ignition (record completion)... Oct 31 13:29:24.639000 audit: BPF prog-id=10 op=UNLOAD Oct 31 13:29:24.639000 audit: BPF prog-id=6 op=UNLOAD Oct 31 13:29:24.625958 ignition[590]: files: op(4): [finished] processing unit "coreos-metadata.service" Oct 31 13:29:24.643846 kernel: audit: type=1334 audit(1761917364.639:8): prog-id=10 op=UNLOAD Oct 31 13:29:24.643879 kernel: audit: type=1334 audit(1761917364.639:9): prog-id=6 op=UNLOAD Oct 31 13:29:24.643890 kernel: audit: type=1334 audit(1761917364.639:10): prog-id=3 op=UNLOAD Oct 31 13:29:24.639000 audit: BPF prog-id=3 op=UNLOAD Oct 31 13:29:24.631893 systemd[1]: Starting Reload Configuration from the Real Root... Oct 31 13:29:24.625963 ignition[590]: files: files passed Oct 31 13:29:24.633529 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 31 13:29:24.625966 ignition[590]: Ignition finished successfully Oct 31 13:29:24.633642 systemd[1]: Finished Ignition (record completion). Oct 31 13:29:24.636090 systemd[1]: Reloading. Oct 31 13:29:24.718000 audit: BPF prog-id=11 op=LOAD Oct 31 13:29:24.719000 audit: BPF prog-id=12 op=LOAD Oct 31 13:29:24.719000 audit: BPF prog-id=13 op=LOAD Oct 31 13:29:24.719000 audit: BPF prog-id=14 op=LOAD Oct 31 13:29:24.719000 audit: BPF prog-id=15 op=LOAD Oct 31 13:29:24.719000 audit: BPF prog-id=7 op=UNLOAD Oct 31 13:29:24.719000 audit: BPF prog-id=8 op=UNLOAD Oct 31 13:29:24.719000 audit: BPF prog-id=16 op=LOAD Oct 31 13:29:24.719000 audit: BPF prog-id=17 op=LOAD Oct 31 13:29:24.719000 audit: BPF prog-id=18 op=LOAD Oct 31 13:29:24.720000 audit: BPF prog-id=4 op=UNLOAD Oct 31 13:29:24.720000 audit: BPF prog-id=5 op=UNLOAD Oct 31 13:29:24.734275 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 31 13:29:24.734398 systemd[1]: Finished Reload Configuration from the Real Root. Oct 31 13:29:24.736096 systemd[1]: Reached target Initrd File Systems. Oct 31 13:29:24.737514 systemd[1]: Reached target Initrd Default Target. Oct 31 13:29:24.738855 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 31 13:29:24.739508 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 31 13:29:24.749331 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 31 13:29:24.750780 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 31 13:29:24.756437 systemd[1]: Stopped target Host and Network Name Lookups. Oct 31 13:29:24.757402 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 31 13:29:24.758844 systemd[1]: Stopped target Timer Units. Oct 31 13:29:24.760119 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 31 13:29:24.760217 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 31 13:29:24.761481 systemd[1]: Stopped target Initrd Default Target. Oct 31 13:29:24.762901 systemd[1]: Stopped target Basic System. Oct 31 13:29:24.764228 systemd[1]: Stopped target Initrd Root Device. Oct 31 13:29:24.765533 systemd[1]: Stopped target Path Units. Oct 31 13:29:24.766689 systemd[1]: Stopped target Remote File Systems. Oct 31 13:29:24.768019 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 31 13:29:24.769376 systemd[1]: Stopped target Slice Units. Oct 31 13:29:24.770546 systemd[1]: Stopped target Socket Units. Oct 31 13:29:24.771935 systemd[1]: Stopped target System Initialization. Oct 31 13:29:24.773284 systemd[1]: Stopped target Local File Systems. Oct 31 13:29:24.774502 systemd[1]: Stopped target Preparation for Local File Systems. Oct 31 13:29:24.775944 systemd[1]: Stopped target Swaps. Oct 31 13:29:24.777105 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 31 13:29:24.777201 systemd[1]: Stopped dracut pre-mount hook. Oct 31 13:29:24.778540 systemd[1]: Stopped target Local Encrypted Volumes. Oct 31 13:29:24.779632 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 31 13:29:24.782912 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 31 13:29:24.783959 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 31 13:29:24.784051 systemd[1]: Stopped dracut initqueue hook. Oct 31 13:29:24.787371 iscsid[487]: iscsid shutting down. Oct 31 13:29:24.785662 systemd[1]: Stopping Open-iSCSI... Oct 31 13:29:24.787369 systemd[1]: Stopping /sysroot/boot... Oct 31 13:29:24.787959 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 31 13:29:24.788070 systemd[1]: Stopped Coldplug All udev Devices. Oct 31 13:29:24.789210 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 31 13:29:24.789286 systemd[1]: Stopped dracut pre-trigger hook. Oct 31 13:29:24.791285 systemd[1]: iscsid.service: Deactivated successfully. Oct 31 13:29:24.791396 systemd[1]: Stopped Open-iSCSI. Oct 31 13:29:24.792794 systemd[1]: iscsid.socket: Deactivated successfully. Oct 31 13:29:24.792854 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 31 13:29:24.793855 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 31 13:29:24.795530 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 31 13:29:24.795646 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 31 13:29:24.797006 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 31 13:29:24.797117 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 31 13:29:24.799017 systemd[1]: Stopped target Network. Oct 31 13:29:24.799688 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 31 13:29:24.799754 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 31 13:29:24.801157 systemd[1]: Stopping Network Name Resolution... Oct 31 13:29:24.809000 audit: BPF prog-id=12 op=UNLOAD Oct 31 13:29:24.802466 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 31 13:29:24.802572 systemd[1]: Stopped /sysroot/boot. Oct 31 13:29:24.805455 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 31 13:29:24.805559 systemd[1]: Stopped Network Name Resolution. Oct 31 13:29:24.806913 systemd[1]: Stopping Network Configuration... Oct 31 13:29:24.810977 systemd-networkd[433]: eth0: DHCP lease lost Oct 31 13:29:24.813921 systemd-networkd[433]: eth0: DHCPv6 lease lost Oct 31 13:29:24.815328 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 31 13:29:24.815436 systemd[1]: Stopped Network Configuration. Oct 31 13:29:24.816637 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 31 13:29:24.819000 audit: BPF prog-id=11 op=UNLOAD Oct 31 13:29:24.816664 systemd[1]: Closed Network Service Netlink Socket. Oct 31 13:29:24.818688 systemd[1]: Stopping Network Cleanup... Oct 31 13:29:24.819329 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 31 13:29:24.819394 systemd[1]: Stopped Apply Kernel Variables. Oct 31 13:29:24.822526 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 31 13:29:24.826892 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 31 13:29:24.827006 systemd[1]: Stopped Network Cleanup. Oct 31 13:29:24.829095 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 31 13:29:24.829212 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 31 13:29:24.830935 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 31 13:29:24.830974 systemd[1]: Closed udev Control Socket. Oct 31 13:29:24.832324 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 31 13:29:24.832355 systemd[1]: Closed udev Kernel Socket. Oct 31 13:29:24.833674 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 31 13:29:24.833713 systemd[1]: Stopped dracut pre-udev hook. Oct 31 13:29:24.834871 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 31 13:29:24.834910 systemd[1]: Stopped dracut cmdline hook. Oct 31 13:29:24.836409 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 31 13:29:24.836449 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 31 13:29:24.838351 systemd[1]: Starting Cleanup udev Database... Oct 31 13:29:24.839351 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 31 13:29:24.840567 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 31 13:29:24.840625 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 31 13:29:24.842245 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 31 13:29:24.842287 systemd[1]: Stopped Create List of Static Device Nodes. Oct 31 13:29:24.843578 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 31 13:29:24.843623 systemd[1]: Stopped Setup Virtual Console. Oct 31 13:29:24.845226 systemd[1]: rngd.service: Deactivated successfully. Oct 31 13:29:24.845337 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 31 13:29:24.846728 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 31 13:29:24.856000 audit: BPF prog-id=13 op=UNLOAD Oct 31 13:29:24.846846 systemd[1]: Finished Cleanup udev Database. Oct 31 13:29:24.857000 audit: BPF prog-id=16 op=UNLOAD Oct 31 13:29:24.847927 systemd[1]: Reached target Switch Root. Oct 31 13:29:24.849925 systemd[1]: Starting Switch Root... Oct 31 13:29:24.854784 systemd[1]: Switching root. Oct 31 13:29:24.871185 systemd-journald[278]: Journal stopped Oct 31 13:29:27.010959 systemd-journald[278]: Received SIGTERM from PID 1 (systemd). Oct 31 13:29:27.011020 kernel: SELinux: policy capability network_peer_controls=1 Oct 31 13:29:27.011032 kernel: SELinux: policy capability open_perms=1 Oct 31 13:29:27.011041 kernel: SELinux: policy capability extended_socket_class=1 Oct 31 13:29:27.011050 kernel: SELinux: policy capability always_check_network=0 Oct 31 13:29:27.011060 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 31 13:29:27.011113 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 31 13:29:27.011126 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 31 13:29:27.011136 systemd[1]: Successfully loaded SELinux policy in 29.301ms. Oct 31 13:29:27.011153 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.616ms. Oct 31 13:29:27.011165 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 31 13:29:27.011175 systemd[1]: Detected virtualization kvm. Oct 31 13:29:27.011185 systemd[1]: Detected architecture arm64. Oct 31 13:29:27.011194 systemd[1]: Detected first boot. Oct 31 13:29:27.011204 systemd[1]: Initializing machine ID from VM UUID. Oct 31 13:29:27.011214 systemd[1]: Populated /etc with preset unit settings. Oct 31 13:29:27.011225 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 31 13:29:27.011236 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 31 13:29:27.011247 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 31 13:29:27.011257 systemd[1]: Stopped Switch Root. Oct 31 13:29:27.011271 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 31 13:29:27.011281 systemd[1]: Created slice Slice /system/addon-config. Oct 31 13:29:27.011291 systemd[1]: Created slice Slice /system/addon-run. Oct 31 13:29:27.011300 systemd[1]: Created slice Slice /system/getty. Oct 31 13:29:27.011309 systemd[1]: Created slice Slice /system/modprobe. Oct 31 13:29:27.011319 kernel: kauditd_printk_skb: 41 callbacks suppressed Oct 31 13:29:27.011330 kernel: audit: type=1334 audit(1761917366.909:52): prog-id=27 op=UNLOAD Oct 31 13:29:27.011339 systemd[1]: Created slice Slice /system/serial-getty. Oct 31 13:29:27.011349 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 31 13:29:27.011359 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 31 13:29:27.011369 systemd[1]: Created slice User and Session Slice. Oct 31 13:29:27.011379 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 31 13:29:27.011388 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 31 13:29:27.011398 systemd[1]: Set up automount Boot partition Automount Point. Oct 31 13:29:27.011408 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 31 13:29:27.011418 systemd[1]: Stopped target Switch Root. Oct 31 13:29:27.011429 systemd[1]: Stopped target Initrd File Systems. Oct 31 13:29:27.011439 systemd[1]: Stopped target Initrd Root File System. Oct 31 13:29:27.011448 systemd[1]: Reached target Remote Encrypted Volumes. Oct 31 13:29:27.011458 systemd[1]: Reached target Remote File Systems. Oct 31 13:29:27.011467 systemd[1]: Reached target Slice Units. Oct 31 13:29:27.011477 systemd[1]: Reached target Swaps. Oct 31 13:29:27.011486 systemd[1]: Reached target Verify torcx succeeded. Oct 31 13:29:27.011496 systemd[1]: Reached target Local Verity Protected Volumes. Oct 31 13:29:27.011505 systemd[1]: Listening on Process Core Dump Socket. Oct 31 13:29:27.011517 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 31 13:29:27.011526 systemd[1]: Listening on Network Service Netlink Socket. Oct 31 13:29:27.011536 systemd[1]: Listening on udev Control Socket. Oct 31 13:29:27.011579 systemd[1]: Listening on udev Kernel Socket. Oct 31 13:29:27.011593 systemd[1]: Mounting Huge Pages File System... Oct 31 13:29:27.011603 systemd[1]: Mounting POSIX Message Queue File System... Oct 31 13:29:27.011612 systemd[1]: Mounting External Media Directory... Oct 31 13:29:27.011622 systemd[1]: Mounting Kernel Debug File System... Oct 31 13:29:27.011646 systemd[1]: Mounting Kernel Trace File System... Oct 31 13:29:27.011662 systemd[1]: Mounting Temporary Directory /tmp... Oct 31 13:29:27.011675 systemd[1]: Starting Create missing system files... Oct 31 13:29:27.011685 systemd[1]: Starting Create List of Static Device Nodes... Oct 31 13:29:27.011694 systemd[1]: Starting Load Kernel Module configfs... Oct 31 13:29:27.011704 systemd[1]: Starting Load Kernel Module drm... Oct 31 13:29:27.011713 systemd[1]: Starting Load Kernel Module fuse... Oct 31 13:29:27.011755 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 31 13:29:27.011767 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 31 13:29:27.011776 systemd[1]: Stopped File System Check on Root Device. Oct 31 13:29:27.011786 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 31 13:29:27.011798 systemd[1]: Stopped systemd-fsck-usr.service. Oct 31 13:29:27.011808 kernel: fuse: init (API version 7.32) Oct 31 13:29:27.011817 systemd[1]: Stopped Journal Service. Oct 31 13:29:27.011827 kernel: audit: type=1334 audit(1761917366.993:53): prog-id=30 op=LOAD Oct 31 13:29:27.011836 kernel: audit: type=1334 audit(1761917366.994:54): prog-id=31 op=LOAD Oct 31 13:29:27.011846 kernel: audit: type=1334 audit(1761917366.995:55): prog-id=32 op=LOAD Oct 31 13:29:27.011855 systemd[1]: Starting Journal Service... Oct 31 13:29:27.011872 kernel: audit: type=1334 audit(1761917366.995:56): prog-id=28 op=UNLOAD Oct 31 13:29:27.011883 kernel: audit: type=1334 audit(1761917366.995:57): prog-id=29 op=UNLOAD Oct 31 13:29:27.011892 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 31 13:29:27.011904 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 31 13:29:27.011914 systemd[1]: Starting Apply Kernel Variables... Oct 31 13:29:27.011924 systemd[1]: Starting Coldplug All udev Devices... Oct 31 13:29:27.011933 systemd[1]: verity-setup.service: Deactivated successfully. Oct 31 13:29:27.011944 kernel: audit: type=1305 audit(1761917367.010:58): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 31 13:29:27.011953 systemd[1]: Stopped verity-setup.service. Oct 31 13:29:27.011963 systemd-journald[807]: Journal started Oct 31 13:29:27.012001 systemd-journald[807]: Runtime Journal (/run/log/journal/f90c9168c881436b9b049294c1ba7d19) is 6.0M, max 48.5M, 42.4M free. Oct 31 13:29:24.930000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 31 13:29:24.982000 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 31 13:29:24.982000 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 31 13:29:24.982000 audit: BPF prog-id=19 op=LOAD Oct 31 13:29:24.982000 audit: BPF prog-id=19 op=UNLOAD Oct 31 13:29:24.982000 audit: BPF prog-id=20 op=LOAD Oct 31 13:29:24.982000 audit: BPF prog-id=20 op=UNLOAD Oct 31 13:29:25.014000 audit[756]: AVC avc: denied { associate } for pid=756 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 31 13:29:26.888000 audit: BPF prog-id=21 op=LOAD Oct 31 13:29:26.888000 audit: BPF prog-id=22 op=LOAD Oct 31 13:29:26.888000 audit: BPF prog-id=23 op=LOAD Oct 31 13:29:26.888000 audit: BPF prog-id=17 op=UNLOAD Oct 31 13:29:26.888000 audit: BPF prog-id=18 op=UNLOAD Oct 31 13:29:26.896000 audit: BPF prog-id=24 op=LOAD Oct 31 13:29:26.896000 audit: BPF prog-id=21 op=UNLOAD Oct 31 13:29:26.897000 audit: BPF prog-id=25 op=LOAD Oct 31 13:29:26.897000 audit: BPF prog-id=26 op=LOAD Oct 31 13:29:26.897000 audit: BPF prog-id=22 op=UNLOAD Oct 31 13:29:26.897000 audit: BPF prog-id=23 op=UNLOAD Oct 31 13:29:26.897000 audit: BPF prog-id=27 op=LOAD Oct 31 13:29:26.897000 audit: BPF prog-id=24 op=UNLOAD Oct 31 13:29:26.898000 audit: BPF prog-id=28 op=LOAD Oct 31 13:29:26.898000 audit: BPF prog-id=29 op=LOAD Oct 31 13:29:26.898000 audit: BPF prog-id=25 op=UNLOAD Oct 31 13:29:26.898000 audit: BPF prog-id=26 op=UNLOAD Oct 31 13:29:26.909000 audit: BPF prog-id=27 op=UNLOAD Oct 31 13:29:26.993000 audit: BPF prog-id=30 op=LOAD Oct 31 13:29:26.994000 audit: BPF prog-id=31 op=LOAD Oct 31 13:29:26.995000 audit: BPF prog-id=32 op=LOAD Oct 31 13:29:26.995000 audit: BPF prog-id=28 op=UNLOAD Oct 31 13:29:26.995000 audit: BPF prog-id=29 op=UNLOAD Oct 31 13:29:27.010000 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 31 13:29:26.888331 systemd[1]: Queued start job for default target Multi-User System. Oct 31 13:29:25.013841 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" 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 31 13:29:26.899342 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 31 13:29:25.014148 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 31 13:29:25.014166 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 31 13:29:25.014283 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 31 13:29:25.014295 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 31 13:29:25.014325 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 31 13:29:25.014338 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 31 13:29:25.014531 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 31 13:29:25.014565 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 31 13:29:25.014580 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 31 13:29:25.015055 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" 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 31 13:29:25.015087 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" 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 31 13:29:25.015107 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" 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 31 13:29:25.015123 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 31 13:29:25.015142 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" 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 31 13:29:25.015156 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:25Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 31 13:29:26.710941 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:26Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 31 13:29:26.711206 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:26Z" 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 31 13:29:26.711309 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:26Z" 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 31 13:29:26.711428 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:26Z" 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 31 13:29:26.711479 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:26Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 31 13:29:26.711533 /usr/lib/systemd/system-generators/torcx-generator[756]: time="2025-10-31T13:29:26Z" 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 31 13:29:27.015968 systemd[1]: Started Journal Service. Oct 31 13:29:27.016463 systemd[1]: Mounted Huge Pages File System. Oct 31 13:29:27.017407 systemd[1]: Mounted POSIX Message Queue File System. Oct 31 13:29:27.018438 systemd[1]: Mounted External Media Directory. Oct 31 13:29:27.019357 systemd[1]: Mounted Kernel Debug File System. Oct 31 13:29:27.020218 systemd[1]: Mounted Kernel Trace File System. Oct 31 13:29:27.021087 systemd[1]: Mounted Temporary Directory /tmp. Oct 31 13:29:27.022213 systemd[1]: Finished Create missing system files. Oct 31 13:29:27.023303 systemd[1]: Finished Create List of Static Device Nodes. Oct 31 13:29:27.024393 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 31 13:29:27.024582 systemd[1]: Finished Load Kernel Module configfs. Oct 31 13:29:27.025605 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 31 13:29:27.025803 systemd[1]: Finished Load Kernel Module drm. Oct 31 13:29:27.026811 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 31 13:29:27.027007 systemd[1]: Finished Load Kernel Module fuse. Oct 31 13:29:27.028112 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 31 13:29:27.029304 systemd[1]: Finished Apply Kernel Variables. Oct 31 13:29:27.042788 systemd[1]: Mounting FUSE Control File System... Oct 31 13:29:27.044567 systemd[1]: Mounting Kernel Configuration File System... Oct 31 13:29:27.045434 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 31 13:29:27.046900 systemd[1]: Starting Rebuild Hardware Database... Oct 31 13:29:27.048619 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 31 13:29:27.049756 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 31 13:29:27.050681 systemd[1]: Starting Load/Save Random Seed... Oct 31 13:29:27.052489 systemd-journald[807]: Time spent on flushing to /var/log/journal/f90c9168c881436b9b049294c1ba7d19 is 8.297ms for 780 entries. Oct 31 13:29:27.052489 systemd-journald[807]: System Journal (/var/log/journal/f90c9168c881436b9b049294c1ba7d19) is 8.0M, max 203.0M, 195.0M free. Oct 31 13:29:27.052503 systemd[1]: Starting Create System Users... Oct 31 13:29:27.056001 systemd[1]: Mounted FUSE Control File System. Oct 31 13:29:27.057175 systemd[1]: Mounted Kernel Configuration File System. Oct 31 13:29:27.058421 systemd[1]: Finished Load/Save Random Seed. Oct 31 13:29:27.059354 systemd[1]: Reached target First Boot Complete. Oct 31 13:29:27.070177 systemd[1]: Finished Coldplug All udev Devices. Oct 31 13:29:27.072126 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 31 13:29:27.073909 systemd-sysusers[818]: Creating group sgx with gid 999. Oct 31 13:29:27.074645 systemd-sysusers[818]: Creating group systemd-oom with gid 998. Oct 31 13:29:27.076050 systemd-sysusers[818]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Oct 31 13:29:27.076795 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 31 13:29:27.078179 systemd-sysusers[818]: Creating group systemd-timesync with gid 997. Oct 31 13:29:27.078707 systemd-sysusers[818]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Oct 31 13:29:27.079366 systemd-sysusers[818]: Creating group systemd-coredump with gid 996. Oct 31 13:29:27.079979 systemd-sysusers[818]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Oct 31 13:29:27.088507 systemd[1]: Finished Create System Users. Oct 31 13:29:27.090389 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 31 13:29:27.102533 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 31 13:29:27.297815 systemd[1]: Finished Rebuild Hardware Database. Oct 31 13:29:27.309000 audit: BPF prog-id=33 op=LOAD Oct 31 13:29:27.310000 audit: BPF prog-id=34 op=LOAD Oct 31 13:29:27.312158 kernel: audit: type=1334 audit(1761917367.309:59): prog-id=33 op=LOAD Oct 31 13:29:27.312195 kernel: audit: type=1334 audit(1761917367.310:60): prog-id=34 op=LOAD Oct 31 13:29:27.312210 kernel: audit: type=1334 audit(1761917367.311:61): prog-id=35 op=LOAD Oct 31 13:29:27.311000 audit: BPF prog-id=35 op=LOAD Oct 31 13:29:27.312775 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 31 13:29:27.311000 audit: BPF prog-id=14 op=UNLOAD Oct 31 13:29:27.311000 audit: BPF prog-id=15 op=UNLOAD Oct 31 13:29:27.336668 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 31 13:29:27.342000 audit: BPF prog-id=36 op=LOAD Oct 31 13:29:27.344091 systemd[1]: Starting Network Configuration... Oct 31 13:29:27.370786 systemd-networkd[841]: lo: Link UP Oct 31 13:29:27.370796 systemd-networkd[841]: lo: Gained carrier Oct 31 13:29:27.371103 systemd-networkd[841]: Enumeration completed Oct 31 13:29:27.371191 systemd[1]: Started Network Configuration. Oct 31 13:29:27.373427 systemd-udevd[826]: Using default interface naming scheme 'v249'. Oct 31 13:29:27.385870 udevadm[821]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 31 13:29:27.400474 systemd-networkd[841]: eth0: Link UP Oct 31 13:29:27.407984 systemd-networkd[841]: eth0: Gained carrier Oct 31 13:29:27.410022 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 31 13:29:27.414980 systemd-networkd[841]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 31 13:29:27.418811 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 31 13:29:27.426985 lvm[851]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 31 13:29:27.450791 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 31 13:29:27.451834 systemd[1]: Reached target Local Encrypted Volumes. Oct 31 13:29:27.463832 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 31 13:29:27.467104 lvm[852]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 31 13:29:27.496905 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 31 13:29:27.497937 systemd[1]: Reached target Preparation for Local File Systems. Oct 31 13:29:27.498933 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 31 13:29:27.498958 systemd[1]: Reached target Containers. Oct 31 13:29:27.511100 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 31 13:29:27.522858 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 31 13:29:27.525051 systemd[1]: Mounting /usr/share/oem... Oct 31 13:29:27.530889 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 31 13:29:27.530965 kernel: BTRFS info (device vda6): has skinny extents Oct 31 13:29:27.533164 systemd[1]: Mounted /usr/share/oem. Oct 31 13:29:27.533951 systemd[1]: Reached target Local File Systems. Oct 31 13:29:27.535756 systemd[1]: Starting Rebuild Dynamic Linker Cache... Oct 31 13:29:27.536933 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 31 13:29:27.536976 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 31 13:29:27.537906 systemd[1]: Starting Commit a transient machine-id on disk... Oct 31 13:29:27.539743 systemd[1]: Starting Create Volatile Files and Directories... Oct 31 13:29:27.546517 systemd-tmpfiles[877]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 31 13:29:27.547959 systemd-tmpfiles[877]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 31 13:29:27.553791 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 31 13:29:27.554380 systemd[1]: Finished Commit a transient machine-id on disk. Oct 31 13:29:27.582191 systemd-tmpfiles[877]: Detected autofs mount point /boot during canonicalization of /boot. Oct 31 13:29:27.582201 systemd-tmpfiles[877]: Skipping /boot Oct 31 13:29:27.589181 systemd-tmpfiles[877]: Detected autofs mount point /boot during canonicalization of /boot. Oct 31 13:29:27.589191 systemd-tmpfiles[877]: Skipping /boot Oct 31 13:29:27.607700 systemd[1]: Finished Rebuild Dynamic Linker Cache. Oct 31 13:29:27.628878 systemd[1]: Finished Create Volatile Files and Directories. Oct 31 13:29:27.638788 systemd[1]: Starting Load Security Auditing Rules... Oct 31 13:29:27.640585 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 31 13:29:27.642578 systemd[1]: Starting Rebuild Journal Catalog... Oct 31 13:29:27.643000 audit: BPF prog-id=37 op=LOAD Oct 31 13:29:27.644684 systemd[1]: Starting Network Name Resolution... Oct 31 13:29:27.646000 audit: BPF prog-id=38 op=LOAD Oct 31 13:29:27.648082 systemd[1]: Starting Network Time Synchronization... Oct 31 13:29:27.649857 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 31 13:29:27.651374 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 31 13:29:27.652656 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 31 13:29:27.655226 systemd[1]: Finished Rebuild Journal Catalog. Oct 31 13:29:27.659542 systemd[1]: Starting Update is Completed... Oct 31 13:29:27.661982 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 31 13:29:27.664000 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 31 13:29:27.665102 augenrules[899]: No rules Oct 31 13:29:27.665760 systemd[1]: Finished Update is Completed. Oct 31 13:29:27.667000 systemd[1]: Finished Load Security Auditing Rules. Oct 31 13:29:27.693855 systemd[1]: Started Network Time Synchronization. Oct 31 13:29:27.267311 systemd-resolved[887]: Positive Trust Anchors: Oct 31 13:29:27.267321 systemd-resolved[887]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 31 13:29:27.267349 systemd-resolved[887]: 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 31 13:29:27.267716 systemd-timesyncd[888]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 31 13:29:27.267921 systemd[1]: Reached target System Initialization. Oct 31 13:29:27.268235 systemd-resolved[887]: Defaulting to hostname 'linux'. Oct 31 13:29:27.268904 systemd[1]: Started Watch for update engine configuration changes. Oct 31 13:29:27.270141 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 31 13:29:27.271403 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 31 13:29:27.273102 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 31 13:29:27.273134 systemd[1]: Reached target Path Units. Oct 31 13:29:27.273893 systemd[1]: Reached target System Time Set. Oct 31 13:29:27.274948 systemd[1]: Started Daily Log Rotation. Oct 31 13:29:27.275796 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 31 13:29:27.276862 systemd[1]: Reached target Timer Units. Oct 31 13:29:27.277978 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 31 13:29:27.293340 systemd[1]: Starting Docker Socket for the API... Oct 31 13:29:27.296428 systemd[1]: Listening on OpenSSH Server Socket. Oct 31 13:29:27.297723 systemd[1]: Started Network Name Resolution. Oct 31 13:29:27.298621 systemd[1]: Listening on Docker Socket for the API. Oct 31 13:29:27.299514 systemd[1]: Reached target Network. Oct 31 13:29:27.300265 systemd[1]: Reached target Host and Network Name Lookups. Oct 31 13:29:27.301208 systemd[1]: Reached target Socket Units. Oct 31 13:29:27.301988 systemd[1]: Reached target Basic System. Oct 31 13:29:27.302782 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 31 13:29:27.302815 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 31 13:29:27.303884 systemd[1]: Started D-Bus System Message Bus. Oct 31 13:29:27.307012 systemd[1]: Starting Extend Filesystems... Oct 31 13:29:27.307845 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 31 13:29:27.308805 systemd[1]: Starting Generate /run/flatcar/motd... Oct 31 13:29:27.310574 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 31 13:29:27.312580 systemd[1]: Starting Generate sshd host keys... Oct 31 13:29:27.314029 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 31 13:29:27.314070 systemd[1]: Reached target Load system-provided cloud configs. Oct 31 13:29:27.317225 extend-filesystems[909]: Found vda Oct 31 13:29:27.317225 extend-filesystems[909]: Found vda1 Oct 31 13:29:27.317225 extend-filesystems[909]: Found vda2 Oct 31 13:29:27.317225 extend-filesystems[909]: Found vda3 Oct 31 13:29:27.317225 extend-filesystems[909]: Found usr Oct 31 13:29:27.317225 extend-filesystems[909]: Found vda4 Oct 31 13:29:27.317225 extend-filesystems[909]: Found vda6 Oct 31 13:29:27.317225 extend-filesystems[909]: Found vda7 Oct 31 13:29:27.317225 extend-filesystems[909]: Found vda9 Oct 31 13:29:27.317225 extend-filesystems[909]: Checking size of /dev/vda9 Oct 31 13:29:27.320209 systemd[1]: Starting User Login Management... Oct 31 13:29:27.321785 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 31 13:29:27.322403 systemd[1]: Starting Update Engine... Oct 31 13:29:27.325065 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 31 13:29:27.325095 systemd[1]: Reached target Load user-provided cloud configs. Oct 31 13:29:27.327037 systemd[1]: motdgen.service: Deactivated successfully. Oct 31 13:29:27.327267 systemd[1]: Finished Generate /run/flatcar/motd. Oct 31 13:29:27.328686 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 31 13:29:27.328925 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 31 13:29:27.345868 extend-filesystems[909]: Old size kept for /dev/vda9 Oct 31 13:29:27.351938 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 31 13:29:27.353318 update_engine[925]: I1031 13:29:27.352866 925 main.cc:89] Flatcar Update Engine starting Oct 31 13:29:27.352175 systemd[1]: Finished Extend Filesystems. Oct 31 13:29:27.356352 systemd[1]: Started Update Engine. Oct 31 13:29:27.357613 update_engine[925]: I1031 13:29:27.356679 925 update_check_scheduler.cc:74] Next update check in 4m33s Oct 31 13:29:27.363840 systemd[1]: Started Cluster reboot manager. Oct 31 13:29:27.368065 systemd-logind[923]: Watching system buttons on /dev/input/event0 (Power Button) Oct 31 13:29:27.368269 systemd-logind[923]: New seat seat0. Oct 31 13:29:27.375563 systemd[1]: Started User Login Management. Oct 31 13:29:27.392451 locksmithd[932]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 31 13:29:28.633804 sshd_keygen[926]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Oct 31 13:29:28.652423 systemd[1]: Finished Generate sshd host keys. Oct 31 13:29:28.668815 systemd[1]: Starting Generate /run/issue... Oct 31 13:29:28.673230 systemd[1]: issuegen.service: Deactivated successfully. Oct 31 13:29:28.673464 systemd[1]: Finished Generate /run/issue. Oct 31 13:29:28.675672 systemd[1]: Starting Permit User Sessions... Oct 31 13:29:28.680298 systemd[1]: Finished Permit User Sessions. Oct 31 13:29:28.682434 systemd[1]: Started Getty on tty1. Oct 31 13:29:28.684328 systemd[1]: Started Serial Getty on ttyAMA0. Oct 31 13:29:28.685296 systemd[1]: Reached target Login Prompts. Oct 31 13:29:28.686178 systemd[1]: Reached target Multi-User System. Oct 31 13:29:28.688112 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 31 13:29:28.693314 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 31 13:29:28.693563 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 31 13:29:28.694596 systemd[1]: Startup finished in 694ms (kernel) + 2.332s (initrd) + 4.221s (userspace) = 7.248s. Oct 31 13:29:28.900900 systemd-networkd[841]: eth0: Gained IPv6LL Oct 31 13:29:34.028773 systemd[1]: Created slice Slice /system/sshd. Oct 31 13:29:34.029839 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:41682). Oct 31 13:29:34.076270 sshd[954]: Accepted publickey for core from 10.0.0.1 port 41682 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:34.078712 sshd[954]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:34.095188 systemd[1]: Created slice User Slice of UID 500. Oct 31 13:29:34.096270 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 31 13:29:34.097826 systemd-logind[923]: New session 1 of user core. Oct 31 13:29:34.104909 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 31 13:29:34.106201 systemd[1]: Starting User Manager for UID 500... Oct 31 13:29:34.108579 systemd[957]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:34.158274 systemd[957]: Queued start job for default target Main User Target. Oct 31 13:29:34.158446 systemd[957]: Reached target Paths. Oct 31 13:29:34.158460 systemd[957]: Reached target Sockets. Oct 31 13:29:34.158924 systemd[957]: Reached target Timers. Oct 31 13:29:34.158960 systemd[957]: Reached target Basic System. Oct 31 13:29:34.159063 systemd[1]: Started User Manager for UID 500. Oct 31 13:29:34.159568 systemd[957]: Reached target Main User Target. Oct 31 13:29:34.159586 systemd[957]: Startup finished in 47ms. Oct 31 13:29:34.169899 systemd[1]: Started Session 1 of User core. Oct 31 13:29:34.261239 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:41686). Oct 31 13:29:34.302090 sshd[966]: Accepted publickey for core from 10.0.0.1 port 41686 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:34.303174 sshd[966]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:34.306216 systemd-logind[923]: New session 2 of user core. Oct 31 13:29:34.313815 systemd[1]: Started Session 2 of User core. Oct 31 13:29:34.368187 sshd[966]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:34.380368 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:41686.service: Deactivated successfully. Oct 31 13:29:34.380997 systemd[1]: session-2.scope: Deactivated successfully. Oct 31 13:29:34.381758 systemd-logind[923]: Session 2 logged out. Waiting for processes to exit. Oct 31 13:29:34.416045 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:41698). Oct 31 13:29:34.417034 systemd-logind[923]: Removed session 2. Oct 31 13:29:34.456367 sshd[972]: Accepted publickey for core from 10.0.0.1 port 41698 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:34.457332 sshd[972]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:34.460120 systemd-logind[923]: New session 3 of user core. Oct 31 13:29:34.474844 systemd[1]: Started Session 3 of User core. Oct 31 13:29:34.524847 sshd[972]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:34.539089 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:41698.service: Deactivated successfully. Oct 31 13:29:34.541112 systemd[1]: session-3.scope: Deactivated successfully. Oct 31 13:29:34.543177 systemd-logind[923]: Session 3 logged out. Waiting for processes to exit. Oct 31 13:29:34.544842 systemd-logind[923]: Removed session 3. Oct 31 13:29:34.547776 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:41700). Oct 31 13:29:34.587713 sshd[979]: Accepted publickey for core from 10.0.0.1 port 41700 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:34.589356 sshd[979]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:34.593492 systemd-logind[923]: New session 4 of user core. Oct 31 13:29:34.602221 systemd[1]: Started Session 4 of User core. Oct 31 13:29:34.659940 sshd[979]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:34.674361 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:41700.service: Deactivated successfully. Oct 31 13:29:34.675050 systemd[1]: session-4.scope: Deactivated successfully. Oct 31 13:29:34.675894 systemd-logind[923]: Session 4 logged out. Waiting for processes to exit. Oct 31 13:29:34.676818 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:41714). Oct 31 13:29:34.677810 systemd-logind[923]: Removed session 4. Oct 31 13:29:34.724347 sshd[985]: Accepted publickey for core from 10.0.0.1 port 41714 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:34.724309 sshd[985]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:34.728485 systemd-logind[923]: New session 5 of user core. Oct 31 13:29:34.738832 systemd[1]: Started Session 5 of User core. Oct 31 13:29:34.796009 sudo[988]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 31 13:29:34.796224 sudo[988]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 31 13:29:34.805176 sudo[988]: pam_unix(sudo:session): session closed for user root Oct 31 13:29:34.807393 sshd[985]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:34.821526 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:41716). Oct 31 13:29:34.824451 dbus-daemon[908]: [system] Reloaded configuration Oct 31 13:29:34.829066 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:41714.service: Deactivated successfully. Oct 31 13:29:34.829846 systemd[1]: session-5.scope: Deactivated successfully. Oct 31 13:29:34.833897 systemd-logind[923]: Session 5 logged out. Waiting for processes to exit. Oct 31 13:29:34.834764 systemd-logind[923]: Removed session 5. Oct 31 13:29:34.867845 sshd[991]: Accepted publickey for core from 10.0.0.1 port 41716 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:34.868952 sshd[991]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:34.871594 systemd-logind[923]: New session 6 of user core. Oct 31 13:29:34.880835 systemd[1]: Started Session 6 of User core. Oct 31 13:29:34.931938 sudo[996]: 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 31 13:29:34.932152 sudo[996]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 31 13:29:34.934445 sudo[996]: pam_unix(sudo:session): session closed for user root Oct 31 13:29:34.938344 sudo[995]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 31 13:29:34.938688 sudo[995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 31 13:29:34.952680 systemd[1]: Stopping Load Security Auditing Rules... Oct 31 13:29:34.956199 kernel: kauditd_printk_skb: 6 callbacks suppressed Oct 31 13:29:34.956259 kernel: audit: type=1305 audit(1761917374.953:68): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 31 13:29:34.953000 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 31 13:29:34.956435 auditctl[999]: No rules Oct 31 13:29:34.956718 systemd[1]: audit-rules.service: Deactivated successfully. Oct 31 13:29:34.958873 systemd[1]: Stopped Load Security Auditing Rules. Oct 31 13:29:34.960278 systemd[1]: Starting Load Security Auditing Rules... Oct 31 13:29:34.976726 augenrules[1016]: No rules Oct 31 13:29:34.977429 systemd[1]: Finished Load Security Auditing Rules. Oct 31 13:29:34.978327 sudo[995]: pam_unix(sudo:session): session closed for user root Oct 31 13:29:34.980171 sshd[991]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:34.997571 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:41716.service: Deactivated successfully. Oct 31 13:29:34.998129 systemd[1]: session-6.scope: Deactivated successfully. Oct 31 13:29:34.998797 systemd-logind[923]: Session 6 logged out. Waiting for processes to exit. Oct 31 13:29:34.999858 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:41722). Oct 31 13:29:35.003380 systemd-logind[923]: Removed session 6. Oct 31 13:29:35.041817 sshd[1022]: Accepted publickey for core from 10.0.0.1 port 41722 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:35.043382 sshd[1022]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:35.045854 kernel: audit: type=1006 audit(1761917375.042:69): pid=1022 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 31 13:29:35.050837 systemd-logind[923]: New session 7 of user core. Oct 31 13:29:35.060870 systemd[1]: Started Session 7 of User core. Oct 31 13:29:35.113209 sudo[1025]: 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 31 13:29:38.154375 update_engine[1272]: Oct 31 13:29:38.154375 update_engine[1272]: Oct 31 13:29:38.154375 update_engine[1272]: Oct 31 13:29:38.154375 update_engine[1272]: Oct 31 13:29:38.154375 update_engine[1272]: Oct 31 13:29:38.154375 update_engine[1272]: Oct 31 13:29:38.154375 update_engine[1272]: Oct 31 13:29:38.154375 update_engine[1272]: Oct 31 13:29:38.154375 update_engine[1272]: I1031 13:29:38.154367 1272 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 31 13:29:38.158013 update_engine[1272]: I1031 13:29:38.157974 1272 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 31 13:29:38.158229 update_engine[1272]: I1031 13:29:38.158210 1272 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 31 13:29:38.159311 update_engine[1272]: I1031 13:29:38.159276 1272 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 31 13:29:38.159381 update_engine[1272]: I1031 13:29:38.159368 1272 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Oct 31 13:29:38.159381 update_engine[1272]: I1031 13:29:38.159379 1272 omaha_request_action.cc:619] Omaha request response: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.159381 update_engine[1272]: Oct 31 13:29:38.161514 update_engine[1272]: I1031 13:29:38.161482 1272 omaha_request_action.cc:447] Omaha Response manifest version = Oct 31 13:29:38.161514 update_engine[1272]: I1031 13:29:38.161514 1272 omaha_request_action.cc:470] Found 1 url(s) Oct 31 13:29:38.161565 update_engine[1272]: I1031 13:29:38.161528 1272 omaha_request_action.cc:506] Processing first of 1 package(s) Oct 31 13:29:38.161565 update_engine[1272]: I1031 13:29:38.161532 1272 omaha_request_action.cc:513] Omaha Response package name = update.gz Oct 31 13:29:38.161565 update_engine[1272]: I1031 13:29:38.161535 1272 omaha_request_action.cc:529] Url0: http://10.0.0.5:34567/packages/update.gz Oct 31 13:29:38.161565 update_engine[1272]: I1031 13:29:38.161545 1272 omaha_request_action.cc:541] Payload size = 426251591 bytes Oct 31 13:29:38.161565 update_engine[1272]: I1031 13:29:38.161554 1272 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Oct 31 13:29:38.161565 update_engine[1272]: I1031 13:29:38.161564 1272 payload_state.cc:51] Resetting all persisted state as this is a new response Oct 31 13:29:38.161565 update_engine[1272]: I1031 13:29:38.161568 1272 payload_state.cc:360] Current Response Signature = Oct 31 13:29:38.161565 update_engine[1272]: NumURLs = 1 Oct 31 13:29:38.161565 update_engine[1272]: Url0 = http://10.0.0.5:34567/packages/update.gz Oct 31 13:29:38.161565 update_engine[1272]: Payload Size = 426251591 Oct 31 13:29:38.161565 update_engine[1272]: Payload Sha256 Hash = qwysf93IzFKZIIEIOAr8FB/Ur4+2vzR6efmfEvB0U+Q= Oct 31 13:29:38.161565 update_engine[1272]: Is Delta Payload = 0 Oct 31 13:29:38.161565 update_engine[1272]: Max Failure Count Per Url = 10 Oct 31 13:29:38.161565 update_engine[1272]: Disable Payload Backoff = 1 Oct 31 13:29:38.161792 update_engine[1272]: I1031 13:29:38.161665 1272 payload_state.cc:381] Payload Attempt Number = 0 Oct 31 13:29:38.161792 update_engine[1272]: I1031 13:29:38.161702 1272 payload_state.cc:404] Current URL Index = 0 Oct 31 13:29:38.161792 update_engine[1272]: I1031 13:29:38.161729 1272 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Oct 31 13:29:38.161792 update_engine[1272]: I1031 13:29:38.161756 1272 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Oct 31 13:29:38.161792 update_engine[1272]: I1031 13:29:38.161760 1272 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 31 13:29:38.161792 update_engine[1272]: I1031 13:29:38.161792 1272 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Oct 31 13:29:38.161889 update_engine[1272]: I1031 13:29:38.161809 1272 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Oct 31 13:29:38.161889 update_engine[1272]: I1031 13:29:38.161813 1272 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Oct 31 13:29:38.161889 update_engine[1272]: I1031 13:29:38.161827 1272 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Oct 31 13:29:38.161889 update_engine[1272]: E1031 13:29:38.161831 1272 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Oct 31 13:29:38.162369 update_engine[1272]: I1031 13:29:38.162339 1272 omaha_response_handler_action.cc:85] Using this install plan: Oct 31 13:29:38.162369 update_engine[1272]: I1031 13:29:38.162356 1272 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.5:34567/packages/update.gz, payload size: 426251591, payload hash: qwysf93IzFKZIIEIOAr8FB/Ur4+2vzR6efmfEvB0U+Q=, 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 31 13:29:38.162464 update_engine[1272]: I1031 13:29:38.162433 1272 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Oct 31 13:29:38.163501 update_engine[1272]: I1031 13:29:38.163468 1272 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Oct 31 13:29:38.182171 sshd[1293]: Accepted publickey for core from 10.0.0.1 port 41904 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:38.182977 sshd[1293]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:38.186063 systemd-logind[923]: New session 25 of user core. Oct 31 13:29:38.194831 systemd[1]: Started Session 25 of User core. Oct 31 13:29:38.250525 sshd[1293]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:38.254937 systemd[1]: sshd@24-10.0.0.6:22-10.0.0.1:41904.service: Deactivated successfully. Oct 31 13:29:38.255594 systemd[1]: session-25.scope: Deactivated successfully. Oct 31 13:29:38.256194 systemd-logind[923]: Session 25 logged out. Waiting for processes to exit. Oct 31 13:29:38.257125 systemd-logind[923]: Removed session 25. Oct 31 13:29:40.105590 update_engine[1272]: I1031 13:29:40.105553 1272 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Oct 31 13:29:40.106000 update_engine[1272]: I1031 13:29:40.105983 1272 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Oct 31 13:29:40.162072 update_engine[1272]: E1031 13:29:40.162029 1272 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Oct 31 13:29:40.162221 update_engine[1272]: I1031 13:29:40.162211 1272 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Oct 31 13:29:40.162267 update_engine[1272]: I1031 13:29:40.162257 1272 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Oct 31 13:29:40.162314 update_engine[1272]: I1031 13:29:40.162304 1272 update_attempter.cc:302] Processing Done. Oct 31 13:29:40.162414 update_engine[1272]: E1031 13:29:40.162403 1272 update_attempter.cc:615] Update failed. Oct 31 13:29:40.162478 update_engine[1272]: I1031 13:29:40.162467 1272 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Oct 31 13:29:40.162527 update_engine[1272]: I1031 13:29:40.162516 1272 payload_state.cc:276] Incrementing the URL failure count Oct 31 13:29:40.162575 update_engine[1272]: I1031 13:29:40.162564 1272 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 31 13:29:40.162898 update_engine[1272]: I1031 13:29:40.162882 1272 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 31 13:29:40.162983 update_engine[1272]: I1031 13:29:40.162971 1272 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.5:34567/v1/update Oct 31 13:29:40.163028 update_engine[1272]: I1031 13:29:40.163018 1272 omaha_request_action.cc:269] Request: Oct 31 13:29:40.163028 update_engine[1272]: Oct 31 13:29:40.163028 update_engine[1272]: Oct 31 13:29:40.163028 update_engine[1272]: Oct 31 13:29:40.163028 update_engine[1272]: Oct 31 13:29:40.163028 update_engine[1272]: Oct 31 13:29:40.163028 update_engine[1272]: Oct 31 13:29:40.163172 update_engine[1272]: I1031 13:29:40.163161 1272 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 31 13:29:40.163273 update_engine[1272]: I1031 13:29:40.163262 1272 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 31 13:29:40.163436 update_engine[1272]: I1031 13:29:40.163422 1272 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 31 13:29:40.357890 update_engine[1272]: I1031 13:29:40.357376 1272 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 31 13:29:40.357890 update_engine[1272]: I1031 13:29:40.357470 1272 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Oct 31 13:29:40.357890 update_engine[1272]: I1031 13:29:40.357476 1272 omaha_request_action.cc:619] Omaha request response: Oct 31 13:29:40.357890 update_engine[1272]: Oct 31 13:29:40.357890 update_engine[1272]: Oct 31 13:29:40.357890 update_engine[1272]: Oct 31 13:29:40.357890 update_engine[1272]: Oct 31 13:29:40.357890 update_engine[1272]: Oct 31 13:29:40.357890 update_engine[1272]: Oct 31 13:29:40.357890 update_engine[1272]: E1031 13:29:40.357491 1272 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Oct 31 13:29:40.357890 update_engine[1272]: I1031 13:29:40.357496 1272 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 31 13:29:40.357890 update_engine[1272]: I1031 13:29:40.357498 1272 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 31 13:29:40.357890 update_engine[1272]: I1031 13:29:40.357501 1272 update_attempter.cc:302] Processing Done. Oct 31 13:29:40.357890 update_engine[1272]: I1031 13:29:40.357506 1272 update_attempter.cc:306] Error event sent. Oct 31 13:29:48.259327 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:49074). Oct 31 13:29:48.303027 sshd[1309]: Accepted publickey for core from 10.0.0.1 port 49074 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:48.304259 sshd[1309]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:48.306143 kernel: kauditd_printk_skb: 287 callbacks suppressed Oct 31 13:29:48.306182 kernel: audit: type=1006 audit(1761917388.303:365): pid=1309 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 31 13:29:48.307185 systemd-logind[923]: New session 26 of user core. Oct 31 13:29:48.316807 systemd[1]: Started Session 26 of User core. Oct 31 13:29:48.374553 sshd[1309]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:48.391508 systemd[1]: sshd@25-10.0.0.6:22-10.0.0.1:49074.service: Deactivated successfully. Oct 31 13:29:48.392168 systemd[1]: session-26.scope: Deactivated successfully. Oct 31 13:29:48.392740 systemd-logind[923]: Session 26 logged out. Waiting for processes to exit. Oct 31 13:29:48.393799 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:49082). Oct 31 13:29:48.394427 systemd-logind[923]: Removed session 26. Oct 31 13:29:48.433993 sshd[1316]: Accepted publickey for core from 10.0.0.1 port 49082 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:48.435973 sshd[1316]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:48.437663 kernel: audit: type=1006 audit(1761917388.434:366): pid=1316 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 31 13:29:48.438754 systemd-logind[923]: New session 27 of user core. Oct 31 13:29:48.446803 systemd[1]: Started Session 27 of User core. Oct 31 13:29:48.501840 sshd[1316]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:48.511064 systemd[1]: sshd@26-10.0.0.6:22-10.0.0.1:49082.service: Deactivated successfully. Oct 31 13:29:48.511724 systemd[1]: session-27.scope: Deactivated successfully. Oct 31 13:29:48.512278 systemd-logind[923]: Session 27 logged out. Waiting for processes to exit. Oct 31 13:29:48.513311 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:49092). Oct 31 13:29:48.513970 systemd-logind[923]: Removed session 27. Oct 31 13:29:48.554000 sshd[1324]: Accepted publickey for core from 10.0.0.1 port 49092 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:48.555956 sshd[1324]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:48.557655 kernel: audit: type=1006 audit(1761917388.554:367): pid=1324 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 31 13:29:48.558801 systemd-logind[923]: New session 28 of user core. Oct 31 13:29:48.568804 systemd[1]: Started Session 28 of User core. Oct 31 13:29:48.616950 sshd[1324]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:48.625664 systemd[1]: sshd@27-10.0.0.6:22-10.0.0.1:49092.service: Deactivated successfully. Oct 31 13:29:48.626294 systemd[1]: session-28.scope: Deactivated successfully. Oct 31 13:29:48.626840 systemd-logind[923]: Session 28 logged out. Waiting for processes to exit. Oct 31 13:29:48.627868 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:49094). Oct 31 13:29:48.628419 systemd-logind[923]: Removed session 28. Oct 31 13:29:48.668709 sshd[1330]: Accepted publickey for core from 10.0.0.1 port 49094 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:48.669845 sshd[1330]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:48.671651 kernel: audit: type=1006 audit(1761917388.668:368): pid=1330 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 31 13:29:48.673122 systemd-logind[923]: New session 29 of user core. Oct 31 13:29:48.687796 systemd[1]: Started Session 29 of User core. Oct 31 13:29:48.735671 sshd[1330]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:48.747256 systemd[1]: sshd@28-10.0.0.6:22-10.0.0.1:49094.service: Deactivated successfully. Oct 31 13:29:48.747819 systemd[1]: session-29.scope: Deactivated successfully. Oct 31 13:29:48.748356 systemd-logind[923]: Session 29 logged out. Waiting for processes to exit. Oct 31 13:29:48.749343 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:49102). Oct 31 13:29:48.749969 systemd-logind[923]: Removed session 29. Oct 31 13:29:48.789674 sshd[1336]: Accepted publickey for core from 10.0.0.1 port 49102 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:29:48.790745 sshd[1336]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:29:48.792666 kernel: audit: type=1006 audit(1761917388.789:369): pid=1336 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 31 13:29:48.793991 systemd-logind[923]: New session 30 of user core. Oct 31 13:29:48.802784 systemd[1]: Started Session 30 of User core. Oct 31 13:29:48.853601 sudo[1340]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Oct 31 13:29:48.853823 sudo[1340]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 31 13:29:48.859563 systemd[1]: sshd.socket: Deactivated successfully. Oct 31 13:29:48.859920 systemd[1]: Closed OpenSSH Server Socket. Oct 31 13:29:48.861012 sudo[1340]: pam_unix(sudo:session): session closed for user root Oct 31 13:29:48.864629 sudo[1339]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Oct 31 13:29:48.864841 sudo[1339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 31 13:29:48.879807 sshd[954]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:48.879907 systemd[1]: Stopping Session 1 of User core... Oct 31 13:29:48.881053 systemd[1]: Stopping Session 30 of User core... Oct 31 13:29:48.881316 sshd[1336]: pam_unix(sshd:session): session closed for user core Oct 31 13:29:48.881804 sudo[1339]: pam_unix(sudo:session): session closed for user root Oct 31 13:29:48.882018 systemd[1]: Removed slice Slice /system/addon-config. Oct 31 13:29:48.883118 systemd[1]: Removed slice Slice /system/addon-run. Oct 31 13:29:48.884225 systemd[1]: Removed slice Slice /system/modprobe. Oct 31 13:29:48.885357 systemd[1]: Removed slice Slice /system/system-cloudinit. Oct 31 13:29:48.886370 systemd[1]: Stopped target Multi-User System. Oct 31 13:29:48.887207 systemd[1]: Stopped target Login Prompts. Oct 31 13:29:48.887933 systemd[1]: Stopped target Containers. Oct 31 13:29:48.888600 systemd[1]: Stopped target Host and Network Name Lookups. Oct 31 13:29:48.889523 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 31 13:29:48.890404 systemd[1]: Stopped target Timer Units. Oct 31 13:29:48.891371 systemd[1]: logrotate.timer: Deactivated successfully. Oct 31 13:29:48.891424 systemd[1]: Stopped Daily Log Rotation. Oct 31 13:29:48.892131 systemd[1]: mdadm.timer: Deactivated successfully. Oct 31 13:29:48.892169 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Oct 31 13:29:48.893148 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Oct 31 13:29:48.893189 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Oct 31 13:29:48.894084 systemd[1]: Stopped target System Time Set. Oct 31 13:29:48.894820 systemd[1]: Stopped target Load user-provided cloud configs. Oct 31 13:29:48.895712 systemd[1]: Stopped target Load system-provided cloud configs. Oct 31 13:29:48.896606 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 31 13:29:48.896871 systemd[1]: Closed Process Core Dump Socket. Oct 31 13:29:48.898280 systemd[1]: Unmounting Boot partition... Oct 31 13:29:48.899238 systemd[1]: Stopping Getty on tty1... Oct 31 13:29:48.900031 systemd[1]: Stopping Serial Getty on ttyAMA0... Oct 31 13:29:48.900899 systemd[1]: Stopping OpenSSH per-connection server daemon... Oct 31 13:29:48.901752 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:49102)... Oct 31 13:29:48.902596 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Oct 31 13:29:48.902753 systemd[1]: Stopped Commit a transient machine-id on disk. Oct 31 13:29:48.903784 systemd[1]: Stopped target First Boot Complete. Oct 31 13:29:48.905486 systemd[1]: Stopping Load/Save Random Seed... Oct 31 13:29:48.906415 systemd[1]: Stopping Update Engine... Oct 31 13:29:48.909526 systemd[1]: getty@tty1.service: Deactivated successfully. Oct 31 13:29:48.909764 systemd[1]: Stopped Getty on tty1. Oct 31 13:29:48.910804 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Oct 31 13:29:48.910992 systemd[1]: Stopped Serial Getty on ttyAMA0. Oct 31 13:29:48.912318 systemd[1]: sshd@0-10.0.0.6:22-10.0.0.1:41682.service: Deactivated successfully. Oct 31 13:29:48.912506 systemd[1]: Stopped OpenSSH per-connection server daemon. Oct 31 13:29:48.913952 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 31 13:29:48.914019 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 31 13:29:48.914242 systemd[1]: Stopped Update Engine. Oct 31 13:29:48.915000 systemd[1]: update-engine.service: Consumed 2.360s CPU time. Oct 31 13:29:48.915213 systemd[1]: sshd@29-10.0.0.6:22-10.0.0.1:49102.service: Deactivated successfully. Oct 31 13:29:48.915382 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:49102). Oct 31 13:29:48.930357 systemd[1]: systemd-random-seed.service: Deactivated successfully. Oct 31 13:29:48.930594 systemd[1]: Stopped Load/Save Random Seed. Oct 31 13:29:48.931627 systemd[1]: boot.mount: Deactivated successfully. Oct 31 13:29:48.931873 systemd[1]: Unmounted Boot partition. Oct 31 13:29:48.932850 systemd[1]: session-30.scope: Deactivated successfully. Oct 31 13:29:48.933064 systemd[1]: Stopped Session 30 of User core. Oct 31 13:29:48.933971 systemd[1]: session-1.scope: Deactivated successfully. Oct 31 13:29:48.934193 systemd[1]: Stopped Session 1 of User core. Oct 31 13:29:48.935330 systemd-logind[923]: Session 1 logged out. Waiting for processes to exit. Oct 31 13:29:48.936281 systemd-logind[923]: Session 30 logged out. Waiting for processes to exit. Oct 31 13:29:48.936534 systemd[1]: Removed slice Slice /system/getty. Oct 31 13:29:48.937662 systemd[1]: Removed slice Slice /system/serial-getty. Oct 31 13:29:48.938764 systemd[1]: Removed slice Slice /system/sshd. Oct 31 13:29:48.939526 systemd[1]: sshd-keygen.service: Deactivated successfully. Oct 31 13:29:48.939627 systemd[1]: Stopped Generate sshd host keys. Oct 31 13:29:48.940377 systemd[1]: sshd-keygen.service: Consumed 1.310s CPU time. Oct 31 13:29:48.940428 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Oct 31 13:29:48.940543 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Oct 31 13:29:48.941837 systemd[1]: Stopping User Login Management... Oct 31 13:29:48.942534 systemd[1]: Stopping User Manager for UID 500... Oct 31 13:29:48.944574 systemd[957]: Stopped target Main User Target. Oct 31 13:29:48.944592 systemd[957]: Stopped target Basic System. Oct 31 13:29:48.944602 systemd[957]: Stopped target Paths. Oct 31 13:29:48.944610 systemd[957]: Stopped target Sockets. Oct 31 13:29:48.944625 systemd[957]: Reached target Shutdown. Oct 31 13:29:48.944632 systemd[957]: Stopped target Timers. Oct 31 13:29:48.944762 systemd[957]: Finished Exit the Session. Oct 31 13:29:48.944787 systemd[957]: Reached target Exit the Session. Oct 31 13:29:48.945190 systemd-logind[923]: Removed session 1. Oct 31 13:29:48.951096 systemd[1]: user@500.service: Deactivated successfully. Oct 31 13:29:48.951360 systemd[1]: Stopped User Manager for UID 500. Oct 31 13:29:48.953256 systemd[1]: Stopping User Runtime Directory /run/user/500... Oct 31 13:29:48.958477 systemd[1]: run-user-500.mount: Deactivated successfully. Oct 31 13:29:48.958623 systemd[1]: Unmounted /run/user/500. Oct 31 13:29:48.959700 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Oct 31 13:29:48.959986 systemd[1]: Stopped User Runtime Directory /run/user/500. Oct 31 13:29:48.961775 systemd[1]: Removed slice User Slice of UID 500. Oct 31 13:29:48.963388 systemd[1]: Stopping D-Bus System Message Bus... Oct 31 13:29:48.974414 systemd[1]: Stopping Permit User Sessions... Oct 31 13:29:48.975867 systemd[1]: dbus.service: Deactivated successfully. Oct 31 13:29:48.976209 systemd[1]: Stopped D-Bus System Message Bus. Oct 31 13:29:48.977252 systemd[1]: systemd-logind.service: Deactivated successfully. Oct 31 13:29:48.977593 systemd[1]: Stopped User Login Management. Oct 31 13:29:48.978784 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Oct 31 13:29:48.979079 systemd[1]: Stopped Permit User Sessions. Oct 31 13:29:48.980013 systemd[1]: Stopped target Basic System. Oct 31 13:29:48.980795 systemd[1]: Stopped target Network. Oct 31 13:29:48.981487 systemd[1]: Stopped target Path Units. Oct 31 13:29:48.982257 systemd[1]: motdgen.path: Deactivated successfully. Oct 31 13:29:48.984000 audit: BPF prog-id=57 op=UNLOAD Oct 31 13:29:48.985674 kernel: audit: type=1334 audit(1761917388.984:370): prog-id=57 op=UNLOAD Oct 31 13:29:48.986675 systemd[1]: Stopped Watch for update engine configuration changes. Oct 31 13:29:48.987647 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Oct 31 13:29:48.991686 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 31 13:29:48.992704 systemd[1]: Stopped target Remote File Systems. Oct 31 13:29:48.993515 systemd[1]: Stopped target Slice Units. Oct 31 13:29:48.994725 systemd[1]: Removed slice User and Session Slice. Oct 31 13:29:48.995544 systemd[1]: Stopped target Socket Units. Oct 31 13:29:48.996316 systemd[1]: dbus.socket: Deactivated successfully. Oct 31 13:29:48.996445 systemd[1]: Closed D-Bus System Message Bus Socket. Oct 31 13:29:48.997461 systemd[1]: docker.socket: Deactivated successfully. Oct 31 13:29:48.997792 systemd[1]: Closed Docker Socket for the API. Oct 31 13:29:48.998583 systemd[1]: Stopped target System Initialization. Oct 31 13:29:48.999478 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Oct 31 13:29:48.999710 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Oct 31 13:29:49.000739 systemd[1]: Stopped target Local Verity Protected Volumes. Oct 31 13:29:49.002444 systemd[1]: Stopping Load Security Auditing Rules... Oct 31 13:29:49.003762 systemd[1]: Stopping Network Name Resolution... Oct 31 13:29:49.004367 auditctl[1354]: No rules Oct 31 13:29:49.004581 systemd[1]: Stopping Network Time Synchronization... Oct 31 13:29:49.005317 systemd[1]: systemd-update-done.service: Deactivated successfully. Oct 31 13:29:49.005395 systemd[1]: Stopped Update is Completed. Oct 31 13:29:49.006138 systemd[1]: ldconfig.service: Deactivated successfully. Oct 31 13:29:49.006196 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Oct 31 13:29:49.006976 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Oct 31 13:29:49.007032 systemd[1]: Stopped Rebuild Hardware Database. Oct 31 13:29:49.007752 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Oct 31 13:29:49.007813 systemd[1]: Stopped Rebuild Journal Catalog. Oct 31 13:29:49.009282 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Oct 31 13:29:49.011779 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 31 13:29:49.012024 systemd[1]: Stopped Network Name Resolution. Oct 31 13:29:49.012955 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Oct 31 13:29:49.013191 systemd[1]: Stopped Network Time Synchronization. Oct 31 13:29:49.014307 systemd[1]: audit-rules.service: Deactivated successfully. Oct 31 13:29:49.014537 systemd[1]: Stopped Load Security Auditing Rules. Oct 31 13:29:49.016792 systemd[1]: Stopping Network Configuration... Oct 31 13:29:49.017699 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Oct 31 13:29:49.017914 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Oct 31 13:29:49.018000 audit: BPF prog-id=56 op=UNLOAD Oct 31 13:29:49.019658 kernel: audit: type=1334 audit(1761917389.018:371): prog-id=56 op=UNLOAD Oct 31 13:29:49.019689 kernel: audit: type=1334 audit(1761917389.018:372): prog-id=60 op=UNLOAD Oct 31 13:29:49.018000 audit: BPF prog-id=60 op=UNLOAD Oct 31 13:29:49.021064 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 31 13:29:49.021156 systemd[1]: Stopped Create Volatile Files and Directories. Oct 31 13:29:49.022041 systemd[1]: Stopped target Local File Systems. Oct 31 13:29:49.023629 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Oct 31 13:29:49.024984 systemd[1]: Unmounting External Media Directory... Oct 31 13:29:49.025706 systemd-networkd[841]: eth0: DHCPv6 lease lost Oct 31 13:29:49.026588 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Oct 31 13:29:49.028377 systemd[1]: Unmounting /run/torcx/unpack... Oct 31 13:29:49.029625 systemd[1]: Unmounting Temporary Directory /tmp... Oct 31 13:29:49.030857 systemd[1]: Unmounting /usr/share/oem... Oct 31 13:29:49.032840 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Oct 31 13:29:49.035311 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 31 13:29:49.035562 systemd[1]: Stopped Network Configuration. Oct 31 13:29:49.036500 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 31 13:29:49.036745 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Oct 31 13:29:49.037873 systemd[1]: media.mount: Deactivated successfully. Oct 31 13:29:49.038125 systemd[1]: Unmounted External Media Directory. Oct 31 13:29:49.038977 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Oct 31 13:29:49.039194 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Oct 31 13:29:49.040359 systemd[1]: tmp.mount: Deactivated successfully. Oct 31 13:29:49.040617 systemd[1]: Unmounted Temporary Directory /tmp. Oct 31 13:29:49.041479 systemd[1]: usr-share-oem.mount: Deactivated successfully. Oct 31 13:29:49.053889 systemd[1]: Unmounted /usr/share/oem. Oct 31 13:29:49.054763 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Oct 31 13:29:49.054986 systemd[1]: Unmounted /run/torcx/unpack. Oct 31 13:29:49.055901 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 31 13:29:49.056139 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Oct 31 13:29:49.056000 audit: BPF prog-id=67 op=UNLOAD Oct 31 13:29:49.058317 systemd[1]: Stopped target Swaps. Oct 31 13:29:49.058893 kernel: audit: type=1334 audit(1761917389.056:373): prog-id=67 op=UNLOAD Oct 31 13:29:49.058971 systemd[1]: Reached target Unmount All Filesystems. Oct 31 13:29:49.059773 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 31 13:29:49.059830 systemd[1]: Closed Network Service Netlink Socket. Oct 31 13:29:49.060602 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Oct 31 13:29:49.060680 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Oct 31 13:29:49.061827 systemd[1]: Removed slice Slice /system/systemd-fsck. Oct 31 13:29:49.062617 systemd[1]: Stopped target Preparation for Local File Systems. Oct 31 13:29:49.063668 systemd[1]: lvm2-activation.service: Deactivated successfully. Oct 31 13:29:49.063731 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 31 13:29:49.064541 systemd[1]: Stopped target Local Encrypted Volumes. Oct 31 13:29:49.065366 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 31 13:29:49.065459 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 31 13:29:49.066485 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Oct 31 13:29:49.069678 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Oct 31 13:29:49.070646 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Oct 31 13:29:49.070716 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 31 13:29:49.071549 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 31 13:29:49.071607 systemd[1]: Stopped Apply Kernel Variables. Oct 31 13:29:49.072620 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 31 13:29:49.072693 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 31 13:29:49.073519 systemd[1]: systemd-sysusers.service: Deactivated successfully. Oct 31 13:29:49.073574 systemd[1]: Stopped Create System Users. Oct 31 13:29:49.074332 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Oct 31 13:29:49.074387 systemd[1]: Stopped Remount Root and Kernel File Systems. Oct 31 13:29:49.075432 systemd[1]: Reached target System Shutdown. Oct 31 13:29:49.076170 systemd[1]: Reached target Late Shutdown Services. Oct 31 13:29:49.077015 systemd[1]: systemd-reboot.service: Deactivated successfully. Oct 31 13:29:49.077054 systemd[1]: Finished System Reboot. Oct 31 13:29:49.077713 systemd[1]: Reached target System Reboot. Oct 31 13:29:49.078366 systemd[1]: Shutting down. Oct 31 13:29:49.078000 audit: BPF prog-id=59 op=UNLOAD Oct 31 13:29:49.079000 audit: BPF prog-id=58 op=UNLOAD Oct 31 13:29:49.080654 kernel: audit: type=1334 audit(1761917389.078:374): prog-id=59 op=UNLOAD Oct 31 13:29:49.084000 audit: BPF prog-id=63 op=UNLOAD Oct 31 13:29:49.084000 audit: BPF prog-id=62 op=UNLOAD Oct 31 13:29:49.084000 audit: BPF prog-id=61 op=UNLOAD Oct 31 13:29:49.084000 audit: BPF prog-id=66 op=UNLOAD Oct 31 13:29:49.084000 audit: BPF prog-id=65 op=UNLOAD Oct 31 13:29:49.084000 audit: BPF prog-id=64 op=UNLOAD Oct 31 13:29:49.119680 systemd-shutdown[1]: Syncing filesystems and block devices. Oct 31 13:29:49.126093 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Oct 31 13:29:49.126170 systemd-journald[807]: Journal stopped -- Reboot -- Oct 31 13:29:56.672159 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 31 13:29:56.672176 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 31 13:29:56.672185 kernel: efi: EFI v2.70 by EDK II Oct 31 13:29:56.672191 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 31 13:29:56.672195 kernel: efi: seeding entropy pool Oct 31 13:29:56.672200 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 31 13:29:56.672206 kernel: ACPI: Early table checksum verification disabled Oct 31 13:29:56.672211 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 31 13:29:56.672216 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 31 13:29:56.672221 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:56.672228 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:56.672232 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:56.672237 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:56.672242 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:56.672248 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:56.672253 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:56.672260 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:56.672265 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 31 13:29:56.672270 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 31 13:29:56.672275 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 31 13:29:56.672281 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 31 13:29:56.672286 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 31 13:29:56.672291 kernel: Zone ranges: Oct 31 13:29:56.672296 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 31 13:29:56.672302 kernel: DMA32 empty Oct 31 13:29:56.672307 kernel: Normal empty Oct 31 13:29:56.672333 kernel: Movable zone start for each node Oct 31 13:29:56.672340 kernel: Early memory node ranges Oct 31 13:29:56.672345 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 31 13:29:56.672351 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 31 13:29:56.672356 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 31 13:29:56.672361 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 31 13:29:56.672366 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 31 13:29:56.672371 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 31 13:29:56.672376 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 31 13:29:56.672382 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 31 13:29:56.672387 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 31 13:29:56.672392 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 31 13:29:56.672397 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 31 13:29:56.672403 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 31 13:29:56.672411 kernel: On node 0 totalpages: 643072 Oct 31 13:29:56.672417 kernel: DMA zone: 10048 pages used for memmap Oct 31 13:29:56.672422 kernel: DMA zone: 0 pages reserved Oct 31 13:29:56.672427 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 31 13:29:56.672433 kernel: psci: probing for conduit method from ACPI. Oct 31 13:29:56.672438 kernel: psci: PSCIv1.1 detected in firmware. Oct 31 13:29:56.672443 kernel: psci: Using standard PSCI v0.2 function IDs Oct 31 13:29:56.672449 kernel: psci: Trusted OS migration not required Oct 31 13:29:56.672455 kernel: psci: SMC Calling Convention v1.1 Oct 31 13:29:56.672461 kernel: ACPI: SRAT not present Oct 31 13:29:56.672466 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 31 13:29:56.672472 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 31 13:29:56.672477 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 31 13:29:56.672482 kernel: Detected PIPT I-cache on CPU0 Oct 31 13:29:56.672488 kernel: CPU features: detected: GIC system register CPU interface Oct 31 13:29:56.672493 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 31 13:29:56.672499 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 31 13:29:56.672504 kernel: CPU features: detected: Hardware dirty bit management Oct 31 13:29:56.672510 kernel: CPU features: detected: Spectre-v4 Oct 31 13:29:56.672517 kernel: CPU features: detected: ARM erratum 1418040 Oct 31 13:29:56.672522 kernel: CPU features: detected: Spectre-BHB Oct 31 13:29:56.672528 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 31 13:29:56.672533 kernel: Policy zone: DMA Oct 31 13:29:56.672539 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 31 13:29:56.672545 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 31 13:29:56.672551 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 31 13:29:56.672556 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 31 13:29:56.672562 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 31 13:29:56.672568 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 31 13:29:56.672573 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 31 13:29:56.672580 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 31 13:29:56.672586 kernel: rcu: RCU event tracing is enabled. Oct 31 13:29:56.672592 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 31 13:29:56.672598 kernel: Trampoline variant of Tasks RCU enabled. Oct 31 13:29:56.672610 kernel: Tracing variant of Tasks RCU enabled. Oct 31 13:29:56.672616 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 31 13:29:56.672622 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 31 13:29:56.672628 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 31 13:29:56.672633 kernel: GICv3: 256 SPIs implemented Oct 31 13:29:56.672638 kernel: GICv3: 0 Extended SPIs implemented Oct 31 13:29:56.672644 kernel: GICv3: Distributor has no Range Selector support Oct 31 13:29:56.672649 kernel: GICv3: 16 PPIs implemented Oct 31 13:29:56.672656 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 31 13:29:56.672661 kernel: ACPI: SRAT not present Oct 31 13:29:56.672667 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 31 13:29:56.672672 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 31 13:29:56.672678 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 31 13:29:56.672684 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 31 13:29:56.672689 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 31 13:29:56.672695 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 31 13:29:56.672700 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 31 13:29:56.672706 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 31 13:29:56.672712 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 31 13:29:56.672718 kernel: arm-pv: using stolen time PV Oct 31 13:29:56.672724 kernel: Console: colour dummy device 80x25 Oct 31 13:29:56.672730 kernel: ACPI: Core revision 20200925 Oct 31 13:29:56.672736 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 31 13:29:56.672741 kernel: pid_max: default: 32768 minimum: 301 Oct 31 13:29:56.672747 kernel: LSM: Security Framework initializing Oct 31 13:29:56.672753 kernel: SELinux: Initializing. Oct 31 13:29:56.672759 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 31 13:29:56.672769 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 31 13:29:56.672777 kernel: rcu: Hierarchical SRCU implementation. Oct 31 13:29:56.672784 kernel: Platform MSI: ITS@0x8080000 domain created Oct 31 13:29:56.672790 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 31 13:29:56.672796 kernel: Remapping and enabling EFI services. Oct 31 13:29:56.672801 kernel: smp: Bringing up secondary CPUs ... Oct 31 13:29:56.672807 kernel: Detected PIPT I-cache on CPU1 Oct 31 13:29:56.672813 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 31 13:29:56.672819 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 31 13:29:56.672824 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 31 13:29:56.672830 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 31 13:29:56.672836 kernel: Detected PIPT I-cache on CPU2 Oct 31 13:29:56.672843 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 31 13:29:56.672849 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 31 13:29:56.672855 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 31 13:29:56.672860 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 31 13:29:56.672866 kernel: Detected PIPT I-cache on CPU3 Oct 31 13:29:56.672875 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 31 13:29:56.672881 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 31 13:29:56.672888 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 31 13:29:56.672894 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 31 13:29:56.672900 kernel: smp: Brought up 1 node, 4 CPUs Oct 31 13:29:56.672906 kernel: SMP: Total of 4 processors activated. Oct 31 13:29:56.672912 kernel: CPU features: detected: Privileged Access Never Oct 31 13:29:56.672918 kernel: CPU features: detected: LSE atomic instructions Oct 31 13:29:56.672924 kernel: CPU features: detected: User Access Override Oct 31 13:29:56.672930 kernel: CPU features: detected: 32-bit EL0 Support Oct 31 13:29:56.672936 kernel: CPU features: detected: Common not Private translations Oct 31 13:29:56.672942 kernel: CPU features: detected: RAS Extension Support Oct 31 13:29:56.672949 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 31 13:29:56.672955 kernel: CPU features: detected: CRC32 instructions Oct 31 13:29:56.672961 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 31 13:29:56.672967 kernel: CPU: All CPU(s) started at EL1 Oct 31 13:29:56.672973 kernel: alternatives: patching kernel code Oct 31 13:29:56.672980 kernel: devtmpfs: initialized Oct 31 13:29:56.672986 kernel: KASLR enabled Oct 31 13:29:56.672992 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 31 13:29:56.672998 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 31 13:29:56.673004 kernel: pinctrl core: initialized pinctrl subsystem Oct 31 13:29:56.673010 kernel: SMBIOS 3.0.0 present. Oct 31 13:29:56.673016 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 31 13:29:56.673022 kernel: NET: Registered protocol family 16 Oct 31 13:29:56.673031 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 31 13:29:56.673037 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 31 13:29:56.673045 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 31 13:29:56.673052 kernel: audit: initializing netlink subsys (disabled) Oct 31 13:29:56.673058 kernel: audit: type=2000 audit(0.031:1): state=initialized audit_enabled=0 res=1 Oct 31 13:29:56.673064 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 31 13:29:56.673070 kernel: cpuidle: using governor menu Oct 31 13:29:56.673076 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 31 13:29:56.673082 kernel: ASID allocator initialised with 32768 entries Oct 31 13:29:56.673087 kernel: ACPI: bus type PCI registered Oct 31 13:29:56.673093 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 31 13:29:56.673100 kernel: Serial: AMBA PL011 UART driver Oct 31 13:29:56.673106 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 31 13:29:56.673116 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 31 13:29:56.673123 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 31 13:29:56.673131 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 31 13:29:56.673138 kernel: cryptd: max_cpu_qlen set to 1000 Oct 31 13:29:56.673144 kernel: ACPI: Added _OSI(Module Device) Oct 31 13:29:56.673149 kernel: ACPI: Added _OSI(Processor Device) Oct 31 13:29:56.673157 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 31 13:29:56.673164 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 31 13:29:56.673175 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 31 13:29:56.673181 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 31 13:29:56.673189 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 31 13:29:56.673195 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 31 13:29:56.673201 kernel: ACPI: Interpreter enabled Oct 31 13:29:56.673207 kernel: ACPI: Using GIC for interrupt routing Oct 31 13:29:56.673213 kernel: ACPI: MCFG table detected, 1 entries Oct 31 13:29:56.673219 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 31 13:29:56.673225 kernel: printk: console [ttyAMA0] enabled Oct 31 13:29:56.673232 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 31 13:29:56.673332 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 31 13:29:56.673388 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 31 13:29:56.673440 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 31 13:29:56.673491 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 31 13:29:56.673541 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 31 13:29:56.673549 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 31 13:29:56.673557 kernel: PCI host bridge to bus 0000:00 Oct 31 13:29:56.673632 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 31 13:29:56.673682 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 31 13:29:56.673730 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 31 13:29:56.673786 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 31 13:29:56.673853 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 31 13:29:56.673914 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 31 13:29:56.673972 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 31 13:29:56.674025 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 31 13:29:56.674078 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 31 13:29:56.674131 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 31 13:29:56.674184 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 31 13:29:56.674237 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 31 13:29:56.674285 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 31 13:29:56.674333 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 31 13:29:56.674381 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 31 13:29:56.674389 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 31 13:29:56.674395 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 31 13:29:56.674401 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 31 13:29:56.674407 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 31 13:29:56.674413 kernel: vgaarb: loaded Oct 31 13:29:56.674418 kernel: Registered efivars operations Oct 31 13:29:56.674424 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 31 13:29:56.674432 kernel: VFS: Disk quotas dquot_6.6.0 Oct 31 13:29:56.674438 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 31 13:29:56.674444 kernel: pnp: PnP ACPI init Oct 31 13:29:56.674507 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 31 13:29:56.674563 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 31 13:29:56.674570 kernel: pnp: PnP ACPI: found 1 devices Oct 31 13:29:56.674576 kernel: NET: Registered protocol family 2 Oct 31 13:29:56.674582 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 31 13:29:56.674590 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 31 13:29:56.674596 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 31 13:29:56.674602 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 31 13:29:56.674620 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 31 13:29:56.674626 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 31 13:29:56.674632 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 31 13:29:56.674638 kernel: NET: Registered protocol family 1 Oct 31 13:29:56.674645 kernel: PCI: CLS 0 bytes, default 64 Oct 31 13:29:56.674651 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 31 13:29:56.674658 kernel: kvm [1]: HYP mode not available Oct 31 13:29:56.674664 kernel: Initialise system trusted keyrings Oct 31 13:29:56.674670 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 31 13:29:56.674676 kernel: Key type asymmetric registered Oct 31 13:29:56.674681 kernel: Asymmetric key parser 'x509' registered Oct 31 13:29:56.674688 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 31 13:29:56.674694 kernel: io scheduler mq-deadline registered Oct 31 13:29:56.674700 kernel: io scheduler kyber registered Oct 31 13:29:56.674705 kernel: io scheduler bfq registered Oct 31 13:29:56.674713 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 31 13:29:56.674718 kernel: ACPI: Power Button [PWRB] Oct 31 13:29:56.674724 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 31 13:29:56.674805 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 31 13:29:56.674814 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 31 13:29:56.674820 kernel: msm_serial: driver initialized Oct 31 13:29:56.674826 kernel: random: fast init done Oct 31 13:29:56.674832 kernel: random: crng init done Oct 31 13:29:56.674838 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 31 13:29:56.674844 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 31 13:29:56.674852 kernel: thunder_xcv, ver 1.0 Oct 31 13:29:56.674857 kernel: thunder_bgx, ver 1.0 Oct 31 13:29:56.674863 kernel: nicpf, ver 1.0 Oct 31 13:29:56.674869 kernel: nicvf, ver 1.0 Oct 31 13:29:56.674932 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 31 13:29:56.674983 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-31T13:29:56 UTC (1761917396) Oct 31 13:29:56.674991 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 31 13:29:56.674997 kernel: NET: Registered protocol family 10 Oct 31 13:29:56.675004 kernel: Segment Routing with IPv6 Oct 31 13:29:56.675010 kernel: NET: Registered protocol family 17 Oct 31 13:29:56.675016 kernel: Key type dns_resolver registered Oct 31 13:29:56.675021 kernel: registered taskstats version 1 Oct 31 13:29:56.675027 kernel: Loading compiled-in X.509 certificates Oct 31 13:29:56.675034 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 31 13:29:56.675040 kernel: Key type ._fscrypt registered Oct 31 13:29:56.675046 kernel: Key type .fscrypt registered Oct 31 13:29:56.675052 kernel: Key type fscrypt-provisioning registered Oct 31 13:29:56.675059 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 31 13:29:56.675065 kernel: ima: Allocated hash algorithm: sha1 Oct 31 13:29:56.675071 kernel: ima: No architecture policies found Oct 31 13:29:56.675077 kernel: Freeing unused kernel memory: 34240K Oct 31 13:29:56.675083 kernel: Run /init as init process Oct 31 13:29:56.675088 kernel: with arguments: Oct 31 13:29:56.675094 kernel: /init Oct 31 13:29:56.675100 kernel: with environment: Oct 31 13:29:56.675106 kernel: HOME=/ Oct 31 13:29:56.675112 kernel: TERM=linux Oct 31 13:29:56.675118 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 31 13:29:56.675126 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 31 13:29:56.675135 systemd[1]: Detected virtualization kvm. Oct 31 13:29:56.675141 systemd[1]: Detected architecture arm64. Oct 31 13:29:56.675147 systemd[1]: Running in initial RAM disk. Oct 31 13:29:56.675154 systemd[1]: No hostname configured, using default hostname. Oct 31 13:29:56.675160 systemd[1]: Hostname set to . Oct 31 13:29:56.675168 systemd[1]: Initializing machine ID from VM UUID. Oct 31 13:29:56.675174 systemd[1]: Queued start job for default target Initrd Default Target. Oct 31 13:29:56.675181 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 31 13:29:56.675187 systemd[1]: Reached target Local Encrypted Volumes. Oct 31 13:29:56.675194 systemd[1]: Reached target Path Units. Oct 31 13:29:56.675200 systemd[1]: Reached target Slice Units. Oct 31 13:29:56.675206 systemd[1]: Reached target Swaps. Oct 31 13:29:56.675212 systemd[1]: Reached target Timer Units. Oct 31 13:29:56.675220 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 31 13:29:56.675227 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 31 13:29:56.675233 systemd[1]: Listening on Journal Audit Socket. Oct 31 13:29:56.675240 systemd[1]: Listening on Journal Socket (/dev/log). Oct 31 13:29:56.675246 systemd[1]: Listening on Journal Socket. Oct 31 13:29:56.675253 systemd[1]: Listening on udev Control Socket. Oct 31 13:29:56.675259 systemd[1]: Listening on udev Kernel Socket. Oct 31 13:29:56.675265 systemd[1]: Reached target Socket Units. Oct 31 13:29:56.675272 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 31 13:29:56.675279 systemd[1]: Starting Create List of Static Device Nodes... Oct 31 13:29:56.675286 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 31 13:29:56.675292 systemd[1]: Starting Journal Service... Oct 31 13:29:56.675298 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 31 13:29:56.675305 systemd[1]: Starting Apply Kernel Variables... Oct 31 13:29:56.675311 systemd[1]: Starting Setup Virtual Console... Oct 31 13:29:56.675318 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 31 13:29:56.675324 kernel: SCSI subsystem initialized Oct 31 13:29:56.675330 kernel: Loading iSCSI transport class v2.0-870. Oct 31 13:29:56.675337 systemd[1]: Finished Create List of Static Device Nodes. Oct 31 13:29:56.675343 systemd[1]: Finished Apply Kernel Variables. Oct 31 13:29:56.675352 systemd-journald[270]: Journal started Oct 31 13:29:56.675386 systemd-journald[270]: Runtime Journal (/run/log/journal/f90c9168c881436b9b049294c1ba7d19) is 6.0M, max 48.5M, 42.4M free. Oct 31 13:29:56.677128 systemd[1]: Started Journal Service. Oct 31 13:29:56.677496 systemd[1]: Finished Setup Virtual Console. Oct 31 13:29:56.678911 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 31 13:29:56.680240 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 31 13:29:56.683434 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 31 13:29:56.694642 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 31 13:29:56.696179 systemd[1]: Starting dracut cmdline hook... Oct 31 13:29:56.704850 dracut-cmdline[290]: dracut-dracut-053 Oct 31 13:29:56.707112 dracut-cmdline[290]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 31 13:29:56.762638 kernel: iscsi: registered transport (tcp) Oct 31 13:29:56.773860 kernel: iscsi: registered transport (qla4xxx) Oct 31 13:29:56.773874 kernel: QLogic iSCSI HBA Driver Oct 31 13:29:56.783575 systemd[1]: Finished dracut cmdline hook. Oct 31 13:29:56.785018 systemd[1]: Starting dracut pre-udev hook... Oct 31 13:29:56.786168 systemd[1]: Starting Open-iSCSI... Oct 31 13:29:56.788573 iscsid[375]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 31 13:29:56.788573 iscsid[375]: 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 31 13:29:56.788573 iscsid[375]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 31 13:29:56.788573 iscsid[375]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 31 13:29:56.788573 iscsid[375]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 31 13:29:56.788573 iscsid[375]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 31 13:29:56.799658 kernel: device-mapper: uevent: version 1.0.3 Oct 31 13:29:56.792128 systemd[1]: Started Open-iSCSI. Oct 31 13:29:56.801165 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 31 13:29:56.835639 kernel: raid6: neonx8 gen() 13782 MB/s Oct 31 13:29:56.852631 kernel: raid6: neonx8 xor() 10758 MB/s Oct 31 13:29:56.869630 kernel: raid6: neonx4 gen() 13662 MB/s Oct 31 13:29:56.886632 kernel: raid6: neonx4 xor() 11566 MB/s Oct 31 13:29:56.903626 kernel: raid6: neonx2 gen() 13003 MB/s Oct 31 13:29:56.920640 kernel: raid6: neonx2 xor() 9894 MB/s Oct 31 13:29:56.937639 kernel: raid6: neonx1 gen() 10995 MB/s Oct 31 13:29:56.954631 kernel: raid6: neonx1 xor() 8854 MB/s Oct 31 13:29:56.971632 kernel: raid6: int64x8 gen() 6834 MB/s Oct 31 13:29:56.988630 kernel: raid6: int64x8 xor() 3796 MB/s Oct 31 13:29:57.005630 kernel: raid6: int64x4 gen() 6916 MB/s Oct 31 13:29:57.022639 kernel: raid6: int64x4 xor() 3838 MB/s Oct 31 13:29:57.039628 kernel: raid6: int64x2 gen() 6191 MB/s Oct 31 13:29:57.056631 kernel: raid6: int64x2 xor() 3316 MB/s Oct 31 13:29:57.073639 kernel: raid6: int64x1 gen() 5014 MB/s Oct 31 13:29:57.090674 kernel: raid6: int64x1 xor() 2594 MB/s Oct 31 13:29:57.090686 kernel: raid6: using algorithm neonx8 gen() 13782 MB/s Oct 31 13:29:57.090694 kernel: raid6: .... xor() 10758 MB/s, rmw enabled Oct 31 13:29:57.091753 kernel: raid6: using neon recovery algorithm Oct 31 13:29:57.101624 kernel: xor: measuring software checksum speed Oct 31 13:29:57.101640 kernel: 8regs : 17156 MB/sec Oct 31 13:29:57.103107 kernel: 32regs : 20749 MB/sec Oct 31 13:29:57.103962 kernel: arm64_neon : 29121 MB/sec Oct 31 13:29:57.103979 kernel: xor: using function: arm64_neon (29121 MB/sec) Oct 31 13:29:57.149637 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 31 13:29:57.159439 systemd[1]: Finished dracut pre-udev hook. Oct 31 13:29:57.162684 kernel: audit: type=1334 audit(1761917397.160:2): prog-id=6 op=LOAD Oct 31 13:29:57.162702 kernel: audit: type=1334 audit(1761917397.160:3): prog-id=7 op=LOAD Oct 31 13:29:57.162711 kernel: audit: type=1334 audit(1761917397.161:4): prog-id=8 op=LOAD Oct 31 13:29:57.160000 audit: BPF prog-id=6 op=LOAD Oct 31 13:29:57.160000 audit: BPF prog-id=7 op=LOAD Oct 31 13:29:57.161000 audit: BPF prog-id=8 op=LOAD Oct 31 13:29:57.162726 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 31 13:29:57.174343 systemd-udevd[406]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 31 13:29:57.176024 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 31 13:29:57.177726 systemd[1]: Starting dracut pre-trigger hook... Oct 31 13:29:57.189948 dracut-pre-trigger[413]: rd.md=0: removing MD RAID activation Oct 31 13:29:57.213200 systemd[1]: Finished dracut pre-trigger hook. Oct 31 13:29:57.214724 systemd[1]: Starting Coldplug All udev Devices... Oct 31 13:29:57.224114 systemd-udevd[406]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 31 13:29:57.243295 systemd[1]: Finished Coldplug All udev Devices. Oct 31 13:29:57.245453 systemd[1]: Starting dracut initqueue hook... Oct 31 13:29:57.266100 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 31 13:29:57.266239 kernel: vda: detected capacity change from 0 to 4756340736 Oct 31 13:29:57.273642 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 31 13:29:57.274477 systemd-udevd[455]: Using default interface naming scheme 'v249'. Oct 31 13:29:57.289630 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (456) Oct 31 13:29:57.291526 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 31 13:29:57.293809 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 31 13:29:57.294804 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 31 13:29:57.304684 systemd[1]: Finished dracut initqueue hook. Oct 31 13:29:57.305483 systemd[1]: Reached target Initrd Root Device. Oct 31 13:29:57.306692 systemd[1]: Reached target Preparation for Remote File Systems. Oct 31 13:29:57.308138 systemd[1]: Reached target Remote Encrypted Volumes. Oct 31 13:29:57.309682 systemd[1]: Reached target Remote File Systems. Oct 31 13:29:57.311706 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 31 13:29:57.313190 systemd[1]: Starting dracut pre-mount hook... Oct 31 13:29:57.314397 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 31 13:29:57.314495 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 31 13:29:57.315649 systemd[1]: Reached target Preparation for Local File Systems. Oct 31 13:29:57.317779 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 31 13:29:57.322153 systemd[1]: Finished dracut pre-mount hook. Oct 31 13:29:57.323531 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 31 13:29:57.329622 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 31 13:29:57.332036 systemd-fsck[504]: ROOT: clean, 641/553792 files, 42010/553472 blocks Oct 31 13:29:57.334843 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 31 13:29:57.336812 systemd[1]: Mounting /sysroot... Oct 31 13:29:57.349469 systemd[1]: Found device /dev/mapper/usr. Oct 31 13:29:57.351398 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 31 13:29:57.353519 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 31 13:29:57.360959 systemd-fsck[517]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 31 13:29:57.360959 systemd-fsck[517]: You must have r/w access to the filesystem or be root Oct 31 13:29:57.363252 systemd-fsck[513]: fsck failed with exit status 8. Oct 31 13:29:57.363258 systemd-fsck[513]: Ignoring error. Oct 31 13:29:57.366818 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 31 13:29:57.368227 systemd[1]: Mounting /sysusr/usr... Oct 31 13:29:57.377697 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 31 13:29:57.377733 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 31 13:29:57.378149 systemd[1]: Mounted /sysroot. Oct 31 13:29:57.378803 systemd[1]: Reached target Initrd Root File System. Oct 31 13:29:57.380427 systemd[1]: Starting Reload Configuration from the Real Root... Oct 31 13:29:57.384503 systemd[1]: Reloading. Oct 31 13:29:57.387000 audit: BPF prog-id=6 op=UNLOAD Oct 31 13:29:57.388000 audit: BPF prog-id=3 op=UNLOAD Oct 31 13:29:57.389677 kernel: audit: type=1334 audit(1761917397.387:5): prog-id=6 op=UNLOAD Oct 31 13:29:57.389705 kernel: audit: type=1334 audit(1761917397.388:6): prog-id=3 op=UNLOAD Oct 31 13:29:57.398634 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 31 13:29:57.474000 audit: BPF prog-id=9 op=LOAD Oct 31 13:29:57.476000 audit: BPF prog-id=10 op=LOAD Oct 31 13:29:57.477060 kernel: audit: type=1334 audit(1761917397.474:7): prog-id=9 op=LOAD Oct 31 13:29:57.477082 kernel: audit: type=1334 audit(1761917397.476:8): prog-id=10 op=LOAD Oct 31 13:29:57.477000 audit: BPF prog-id=11 op=LOAD Oct 31 13:29:57.477895 kernel: audit: type=1334 audit(1761917397.477:9): prog-id=11 op=LOAD Oct 31 13:29:57.477000 audit: BPF prog-id=7 op=UNLOAD Oct 31 13:29:57.478680 kernel: audit: type=1334 audit(1761917397.477:10): prog-id=7 op=UNLOAD Oct 31 13:29:57.478000 audit: BPF prog-id=8 op=UNLOAD Oct 31 13:29:57.478000 audit: BPF prog-id=12 op=LOAD Oct 31 13:29:57.478000 audit: BPF prog-id=13 op=LOAD Oct 31 13:29:57.478000 audit: BPF prog-id=14 op=LOAD Oct 31 13:29:57.478000 audit: BPF prog-id=4 op=UNLOAD Oct 31 13:29:57.478000 audit: BPF prog-id=5 op=UNLOAD Oct 31 13:29:57.480445 systemd[1]: Mounted /sysusr/usr. Oct 31 13:29:57.482422 systemd[1]: Reached target Local File Systems. Oct 31 13:29:57.483232 systemd[1]: Reached target System Initialization. Oct 31 13:29:57.484515 systemd[1]: Reached target Basic System. Oct 31 13:29:57.486797 systemd[1]: Mounting /sysroot/usr... Oct 31 13:29:57.489176 systemd[1]: Mounted /sysroot/usr. Oct 31 13:29:57.497572 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 31 13:29:57.497715 systemd[1]: Finished Reload Configuration from the Real Root. Oct 31 13:29:57.499492 systemd[1]: Reached target Initrd File Systems. Oct 31 13:29:57.500868 systemd[1]: Reached target Initrd Default Target. Oct 31 13:29:57.502215 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 31 13:29:57.502862 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 31 13:29:57.512957 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 31 13:29:57.514368 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 31 13:29:57.520057 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 31 13:29:57.520948 systemd[1]: Stopped target Timer Units. Oct 31 13:29:57.522220 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 31 13:29:57.522329 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 31 13:29:57.523550 systemd[1]: Stopped target Initrd Default Target. Oct 31 13:29:57.524976 systemd[1]: Stopped target Basic System. Oct 31 13:29:57.526274 systemd[1]: Stopped target Initrd Root Device. Oct 31 13:29:57.527557 systemd[1]: Stopped target Path Units. Oct 31 13:29:57.528729 systemd[1]: Stopped target Remote File Systems. Oct 31 13:29:57.529984 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 31 13:29:57.531348 systemd[1]: Stopped target Slice Units. Oct 31 13:29:57.532565 systemd[1]: Stopped target Socket Units. Oct 31 13:29:57.533982 systemd[1]: Stopped target System Initialization. Oct 31 13:29:57.535236 systemd[1]: Stopped target Local File Systems. Oct 31 13:29:57.536450 systemd[1]: Stopped target Preparation for Local File Systems. Oct 31 13:29:57.537917 systemd[1]: Stopped target Swaps. Oct 31 13:29:57.539037 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 31 13:29:57.539143 systemd[1]: Stopped dracut pre-mount hook. Oct 31 13:29:57.540440 systemd[1]: Stopped target Local Encrypted Volumes. Oct 31 13:29:57.541531 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 31 13:29:57.545662 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 31 13:29:57.546693 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 31 13:29:57.546806 systemd[1]: Stopped dracut initqueue hook. Oct 31 13:29:57.550049 iscsid[375]: iscsid shutting down. Oct 31 13:29:57.548409 systemd[1]: Stopping Open-iSCSI... Oct 31 13:29:57.549441 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 31 13:29:57.549544 systemd[1]: Stopped Apply Kernel Variables. Oct 31 13:29:57.550759 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 31 13:29:57.550862 systemd[1]: Stopped Coldplug All udev Devices. Oct 31 13:29:57.552002 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 31 13:29:57.552092 systemd[1]: Stopped dracut pre-trigger hook. Oct 31 13:29:57.553273 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 31 13:29:57.557530 systemd[1]: iscsid.service: Deactivated successfully. Oct 31 13:29:57.557674 systemd[1]: Stopped Open-iSCSI. Oct 31 13:29:57.558929 systemd[1]: iscsid.socket: Deactivated successfully. Oct 31 13:29:57.558993 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 31 13:29:57.559960 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 31 13:29:57.561925 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 31 13:29:57.562027 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 31 13:29:57.572000 audit: BPF prog-id=9 op=UNLOAD Oct 31 13:29:57.563227 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 31 13:29:57.563335 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 31 13:29:57.565060 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 31 13:29:57.565155 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 31 13:29:57.567018 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 31 13:29:57.567063 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 31 13:29:57.568391 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 31 13:29:57.568430 systemd[1]: Closed udev Control Socket. Oct 31 13:29:57.569593 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 31 13:29:57.569638 systemd[1]: Closed udev Kernel Socket. Oct 31 13:29:57.570889 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 31 13:29:57.570926 systemd[1]: Stopped dracut pre-udev hook. Oct 31 13:29:57.572327 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 31 13:29:57.572364 systemd[1]: Stopped dracut cmdline hook. Oct 31 13:29:57.573563 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 31 13:29:57.573599 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 31 13:29:57.575870 systemd[1]: Starting Cleanup udev Database... Oct 31 13:29:57.576789 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 31 13:29:57.578365 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 31 13:29:57.578418 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 31 13:29:57.595000 audit: BPF prog-id=12 op=UNLOAD Oct 31 13:29:57.580011 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 31 13:29:57.580052 systemd[1]: Stopped Create List of Static Device Nodes. Oct 31 13:29:57.581434 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 31 13:29:57.581475 systemd[1]: Stopped Setup Virtual Console. Oct 31 13:29:57.582946 systemd[1]: rngd.service: Deactivated successfully. Oct 31 13:29:57.583050 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 31 13:29:57.584525 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 31 13:29:57.584640 systemd[1]: Finished Cleanup udev Database. Oct 31 13:29:57.585703 systemd[1]: Reached target Switch Root. Oct 31 13:29:57.587670 systemd[1]: Starting Switch Root... Oct 31 13:29:57.594162 systemd[1]: Switching root. Oct 31 13:29:57.609924 systemd-journald[270]: Journal stopped Oct 31 13:29:59.627670 systemd-journald[270]: Received SIGTERM from PID 1 (systemd). Oct 31 13:29:59.627718 kernel: SELinux: policy capability network_peer_controls=1 Oct 31 13:29:59.627730 kernel: SELinux: policy capability open_perms=1 Oct 31 13:29:59.627740 kernel: SELinux: policy capability extended_socket_class=1 Oct 31 13:29:59.627759 kernel: SELinux: policy capability always_check_network=0 Oct 31 13:29:59.627773 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 31 13:29:59.627783 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 31 13:29:59.627792 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 31 13:29:59.627802 systemd[1]: Successfully loaded SELinux policy in 36.696ms. Oct 31 13:29:59.627821 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.081ms. Oct 31 13:29:59.627833 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 31 13:29:59.627844 systemd[1]: Detected virtualization kvm. Oct 31 13:29:59.627856 systemd[1]: Detected architecture arm64. Oct 31 13:29:59.627867 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 31 13:29:59.627879 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 31 13:29:59.627890 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 31 13:29:59.627901 systemd[1]: Stopped Switch Root. Oct 31 13:29:59.627911 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 31 13:29:59.627922 systemd[1]: Created slice Slice /system/addon-config. Oct 31 13:29:59.627932 systemd[1]: Created slice Slice /system/addon-run. Oct 31 13:29:59.627945 systemd[1]: Created slice Slice /system/getty. Oct 31 13:29:59.627956 systemd[1]: Created slice Slice /system/modprobe. Oct 31 13:29:59.627966 systemd[1]: Created slice Slice /system/serial-getty. Oct 31 13:29:59.627976 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 31 13:29:59.627987 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 31 13:29:59.627997 systemd[1]: Created slice User and Session Slice. Oct 31 13:29:59.628007 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 31 13:29:59.628017 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 31 13:29:59.628027 systemd[1]: Set up automount Boot partition Automount Point. Oct 31 13:29:59.628038 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 31 13:29:59.628048 systemd[1]: Stopped target Switch Root. Oct 31 13:29:59.628058 systemd[1]: Stopped target Initrd File Systems. Oct 31 13:29:59.628068 systemd[1]: Stopped target Initrd Root File System. Oct 31 13:29:59.628078 systemd[1]: Reached target Remote Encrypted Volumes. Oct 31 13:29:59.628088 systemd[1]: Reached target Remote File Systems. Oct 31 13:29:59.628098 systemd[1]: Reached target Slice Units. Oct 31 13:29:59.628108 systemd[1]: Reached target Swaps. Oct 31 13:29:59.628118 systemd[1]: Reached target Verify torcx succeeded. Oct 31 13:29:59.628128 systemd[1]: Reached target Local Verity Protected Volumes. Oct 31 13:29:59.628138 systemd[1]: Listening on Process Core Dump Socket. Oct 31 13:29:59.628148 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 31 13:29:59.628159 systemd[1]: Listening on Network Service Netlink Socket. Oct 31 13:29:59.628169 systemd[1]: Listening on udev Control Socket. Oct 31 13:29:59.628179 systemd[1]: Listening on udev Kernel Socket. Oct 31 13:29:59.628189 systemd[1]: Mounting Huge Pages File System... Oct 31 13:29:59.628199 systemd[1]: Mounting POSIX Message Queue File System... Oct 31 13:29:59.628209 systemd[1]: Mounting External Media Directory... Oct 31 13:29:59.628219 systemd[1]: Mounting Kernel Debug File System... Oct 31 13:29:59.628230 systemd[1]: Mounting Kernel Trace File System... Oct 31 13:29:59.628241 systemd[1]: Mounting Temporary Directory /tmp... Oct 31 13:29:59.628251 systemd[1]: Starting Create missing system files... Oct 31 13:29:59.628261 systemd[1]: Starting Create List of Static Device Nodes... Oct 31 13:29:59.628272 systemd[1]: Starting Load Kernel Module configfs... Oct 31 13:29:59.628282 systemd[1]: Starting Load Kernel Module drm... Oct 31 13:29:59.628292 systemd[1]: Starting Load Kernel Module fuse... Oct 31 13:29:59.628303 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 31 13:29:59.628313 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 31 13:29:59.628324 systemd[1]: Stopped File System Check on Root Device. Oct 31 13:29:59.628334 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 31 13:29:59.628344 systemd[1]: Stopped systemd-fsck-usr.service. Oct 31 13:29:59.628354 systemd[1]: Stopped Journal Service. Oct 31 13:29:59.628363 kernel: fuse: init (API version 7.32) Oct 31 13:29:59.628373 systemd[1]: Starting Journal Service... Oct 31 13:29:59.628383 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 31 13:29:59.628393 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 31 13:29:59.628403 systemd[1]: Starting Apply Kernel Variables... Oct 31 13:29:59.628413 systemd[1]: Starting Coldplug All udev Devices... Oct 31 13:29:59.628424 systemd[1]: verity-setup.service: Deactivated successfully. Oct 31 13:29:59.628434 systemd[1]: Stopped verity-setup.service. Oct 31 13:29:59.628444 systemd[1]: Mounted Huge Pages File System. Oct 31 13:29:59.628456 systemd-journald[693]: Journal started Oct 31 13:29:59.628494 systemd-journald[693]: Runtime Journal (/run/log/journal/f90c9168c881436b9b049294c1ba7d19) is 6.0M, max 48.5M, 42.4M free. Oct 31 13:29:57.684000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 31 13:29:57.709000 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 31 13:29:57.709000 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 31 13:29:57.709000 audit: BPF prog-id=15 op=LOAD Oct 31 13:29:57.709000 audit: BPF prog-id=15 op=UNLOAD Oct 31 13:29:57.709000 audit: BPF prog-id=16 op=LOAD Oct 31 13:29:57.709000 audit: BPF prog-id=16 op=UNLOAD Oct 31 13:29:57.739000 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 31 13:29:59.506000 audit: BPF prog-id=17 op=LOAD Oct 31 13:29:59.506000 audit: BPF prog-id=18 op=LOAD Oct 31 13:29:59.506000 audit: BPF prog-id=19 op=LOAD Oct 31 13:29:59.506000 audit: BPF prog-id=13 op=UNLOAD Oct 31 13:29:59.506000 audit: BPF prog-id=14 op=UNLOAD Oct 31 13:29:59.517000 audit: BPF prog-id=20 op=LOAD Oct 31 13:29:59.517000 audit: BPF prog-id=17 op=UNLOAD Oct 31 13:29:59.517000 audit: BPF prog-id=21 op=LOAD Oct 31 13:29:59.517000 audit: BPF prog-id=22 op=LOAD Oct 31 13:29:59.517000 audit: BPF prog-id=18 op=UNLOAD Oct 31 13:29:59.517000 audit: BPF prog-id=19 op=UNLOAD Oct 31 13:29:59.517000 audit: BPF prog-id=23 op=LOAD Oct 31 13:29:59.517000 audit: BPF prog-id=20 op=UNLOAD Oct 31 13:29:59.517000 audit: BPF prog-id=24 op=LOAD Oct 31 13:29:59.517000 audit: BPF prog-id=25 op=LOAD Oct 31 13:29:59.517000 audit: BPF prog-id=21 op=UNLOAD Oct 31 13:29:59.517000 audit: BPF prog-id=22 op=UNLOAD Oct 31 13:29:59.529000 audit: BPF prog-id=23 op=UNLOAD Oct 31 13:29:59.612000 audit: BPF prog-id=26 op=LOAD Oct 31 13:29:59.612000 audit: BPF prog-id=27 op=LOAD Oct 31 13:29:59.612000 audit: BPF prog-id=28 op=LOAD Oct 31 13:29:59.612000 audit: BPF prog-id=24 op=UNLOAD Oct 31 13:29:59.612000 audit: BPF prog-id=25 op=UNLOAD Oct 31 13:29:59.626000 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 31 13:29:59.506536 systemd[1]: Queued start job for default target Multi-User System. Oct 31 13:29:57.737996 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" 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 31 13:29:59.518762 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 31 13:29:57.738272 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 31 13:29:57.738291 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 31 13:29:57.738629 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 31 13:29:57.738641 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 31 13:29:57.738675 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 31 13:29:57.738687 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 31 13:29:57.738986 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 31 13:29:57.739023 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 31 13:29:57.739039 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 31 13:29:57.739352 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" 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 31 13:29:57.739381 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" 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 31 13:29:59.630163 systemd[1]: Started Journal Service. Oct 31 13:29:57.739400 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" 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 31 13:29:57.739415 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 31 13:29:57.739503 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" 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 31 13:29:57.739519 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:57Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 31 13:29:59.419928 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:59Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 31 13:29:59.420197 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:59Z" 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 31 13:29:59.420298 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:59Z" 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 31 13:29:59.420475 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:59Z" 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 31 13:29:59.420575 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:59Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 31 13:29:59.420650 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-10-31T13:29:59Z" 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 31 13:29:59.630601 systemd[1]: Mounted POSIX Message Queue File System. Oct 31 13:29:59.631525 systemd[1]: Mounted External Media Directory. Oct 31 13:29:59.632436 systemd[1]: Mounted Kernel Debug File System. Oct 31 13:29:59.633316 systemd[1]: Mounted Kernel Trace File System. Oct 31 13:29:59.634193 systemd[1]: Mounted Temporary Directory /tmp. Oct 31 13:29:59.635262 systemd[1]: Finished Create missing system files. Oct 31 13:29:59.636412 systemd[1]: Finished Create List of Static Device Nodes. Oct 31 13:29:59.637510 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 31 13:29:59.637697 systemd[1]: Finished Load Kernel Module configfs. Oct 31 13:29:59.638648 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 31 13:29:59.638828 systemd[1]: Finished Load Kernel Module drm. Oct 31 13:29:59.639786 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 31 13:29:59.639952 systemd[1]: Finished Load Kernel Module fuse. Oct 31 13:29:59.641000 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 31 13:29:59.642185 systemd[1]: Finished Apply Kernel Variables. Oct 31 13:29:59.653422 systemd[1]: Mounting FUSE Control File System... Oct 31 13:29:59.655265 systemd[1]: Mounting Kernel Configuration File System... Oct 31 13:29:59.656117 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 31 13:29:59.657021 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 31 13:29:59.657948 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 31 13:29:59.658975 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 31 13:29:59.659855 systemd[1]: Starting Load/Save Random Seed... Oct 31 13:29:59.660666 systemd[1]: Condition check resulted in Create System Users being skipped. Oct 31 13:29:59.661600 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 31 13:29:59.663399 systemd[1]: Mounted FUSE Control File System. Oct 31 13:29:59.664663 systemd[1]: Mounted Kernel Configuration File System. Oct 31 13:29:59.665277 systemd-journald[693]: Time spent on flushing to /var/log/journal/f90c9168c881436b9b049294c1ba7d19 is 11.638ms for 670 entries. Oct 31 13:29:59.665277 systemd-journald[693]: System Journal (/var/log/journal/f90c9168c881436b9b049294c1ba7d19) is 16.0M, max 203.0M, 187.0M free. Oct 31 13:29:59.679000 audit: BPF prog-id=29 op=LOAD Oct 31 13:29:59.679000 audit: BPF prog-id=30 op=LOAD Oct 31 13:29:59.679000 audit: BPF prog-id=31 op=LOAD Oct 31 13:29:59.679000 audit: BPF prog-id=10 op=UNLOAD Oct 31 13:29:59.679000 audit: BPF prog-id=11 op=UNLOAD Oct 31 13:29:59.668981 systemd[1]: Finished Load/Save Random Seed. Oct 31 13:29:59.670299 systemd[1]: Condition check resulted in First Boot Complete being skipped. Oct 31 13:29:59.670640 systemd[1]: Finished Coldplug All udev Devices. Oct 31 13:29:59.677458 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 31 13:29:59.678774 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 31 13:29:59.681045 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 31 13:29:59.688229 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 31 13:29:59.704990 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 31 13:29:59.706000 audit: BPF prog-id=32 op=LOAD Oct 31 13:29:59.707660 systemd[1]: Starting Network Configuration... Oct 31 13:29:59.740660 systemd-networkd[715]: lo: Link UP Oct 31 13:29:59.740669 systemd-networkd[715]: lo: Gained carrier Oct 31 13:29:59.740983 systemd-networkd[715]: Enumeration completed Oct 31 13:29:59.741070 systemd[1]: Started Network Configuration. Oct 31 13:29:59.741226 systemd-udevd[720]: Using default interface naming scheme 'v249'. Oct 31 13:29:59.766077 udevadm[706]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 31 13:29:59.774047 systemd-networkd[715]: eth0: Link UP Oct 31 13:29:59.783663 systemd-networkd[715]: eth0: Gained carrier Oct 31 13:29:59.783696 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 31 13:29:59.792499 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 31 13:29:59.795748 systemd-networkd[715]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 31 13:29:59.800495 lvm[735]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 31 13:29:59.832746 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 31 13:29:59.833730 systemd[1]: Reached target Local Encrypted Volumes. Oct 31 13:29:59.846599 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 31 13:29:59.850101 lvm[736]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 31 13:29:59.878710 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 31 13:29:59.879677 systemd[1]: Reached target Preparation for Local File Systems. Oct 31 13:29:59.880602 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 31 13:29:59.880643 systemd[1]: Reached target Containers. Oct 31 13:29:59.891908 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 31 13:29:59.904080 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 31 13:29:59.906226 systemd[1]: Mounting /usr/share/oem... Oct 31 13:29:59.912210 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 31 13:29:59.912277 kernel: BTRFS info (device vda6): has skinny extents Oct 31 13:29:59.914522 systemd[1]: Mounted /usr/share/oem. Oct 31 13:29:59.915336 systemd[1]: Reached target Local File Systems. Oct 31 13:29:59.916380 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Oct 31 13:29:59.916799 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 31 13:29:59.916841 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 31 13:29:59.916872 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 31 13:29:59.924539 systemd[1]: Starting Create Volatile Files and Directories... Oct 31 13:29:59.930412 systemd-tmpfiles[759]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 31 13:29:59.931446 systemd-tmpfiles[759]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 31 13:29:59.958052 systemd-tmpfiles[759]: Detected autofs mount point /boot during canonicalization of /boot. Oct 31 13:29:59.958066 systemd-tmpfiles[759]: Skipping /boot Oct 31 13:29:59.963484 systemd-tmpfiles[759]: Detected autofs mount point /boot during canonicalization of /boot. Oct 31 13:29:59.963502 systemd-tmpfiles[759]: Skipping /boot Oct 31 13:29:59.992286 systemd[1]: Finished Create Volatile Files and Directories. Oct 31 13:30:00.006570 systemd[1]: Starting Load Security Auditing Rules... Oct 31 13:30:00.008322 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 31 13:30:00.009351 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Oct 31 13:30:00.009000 audit: BPF prog-id=33 op=LOAD Oct 31 13:30:00.010725 systemd[1]: Starting Network Name Resolution... Oct 31 13:30:00.011000 audit: BPF prog-id=34 op=LOAD Oct 31 13:30:00.013187 systemd[1]: Starting Network Time Synchronization... Oct 31 13:30:00.014098 systemd[1]: Condition check resulted in Update is Completed being skipped. Oct 31 13:30:00.015001 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 31 13:30:00.016344 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 31 13:30:00.017632 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 31 13:30:00.025193 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 31 13:30:00.036000 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 31 13:30:00.037378 augenrules[780]: No rules Oct 31 13:30:00.038353 systemd[1]: Finished Load Security Auditing Rules. Oct 31 13:30:00.050524 systemd-timesyncd[769]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 31 13:30:00.050918 systemd-resolved[763]: Positive Trust Anchors: Oct 31 13:30:00.050925 systemd-resolved[763]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 31 13:30:00.050954 systemd-resolved[763]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Oct 31 13:30:00.051785 systemd-resolved[763]: Defaulting to hostname 'linux'. Oct 31 13:30:00.054748 systemd[1]: Started Network Time Synchronization. Oct 31 13:30:00.055746 systemd[1]: Started Network Name Resolution. Oct 31 13:30:00.056551 systemd[1]: Reached target Network. Oct 31 13:30:00.057264 systemd[1]: Reached target Host and Network Name Lookups. Oct 31 13:30:00.058154 systemd[1]: Reached target System Initialization. Oct 31 13:30:00.059057 systemd[1]: Started Watch for update engine configuration changes. Oct 31 13:30:00.060057 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 31 13:30:00.061136 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 31 13:30:00.062068 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 31 13:30:00.062094 systemd[1]: Reached target Path Units. Oct 31 13:30:00.062873 systemd[1]: Reached target System Time Set. Oct 31 13:30:00.063875 systemd[1]: Started Daily Log Rotation. Oct 31 13:30:00.064631 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 31 13:30:00.065593 systemd[1]: Reached target Timer Units. Oct 31 13:30:00.066667 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 31 13:30:00.078241 systemd[1]: Starting Docker Socket for the API... Oct 31 13:30:00.081423 systemd[1]: Listening on OpenSSH Server Socket. Oct 31 13:30:00.082702 systemd[1]: Listening on Docker Socket for the API. Oct 31 13:30:00.083527 systemd[1]: Reached target Socket Units. Oct 31 13:30:00.084286 systemd[1]: Reached target Basic System. Oct 31 13:30:00.085044 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 31 13:30:00.085074 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 31 13:30:00.085981 systemd[1]: Started D-Bus System Message Bus. Oct 31 13:30:00.089002 systemd[1]: Starting Extend Filesystems... Oct 31 13:30:00.089768 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 31 13:30:00.090739 systemd[1]: Starting Generate /run/flatcar/motd... Oct 31 13:30:00.092380 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 31 13:30:00.094858 systemd[1]: Starting Generate sshd host keys... Oct 31 13:30:00.096204 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 31 13:30:00.096244 systemd[1]: Reached target Load system-provided cloud configs. Oct 31 13:30:00.098647 extend-filesystems[790]: Found vda Oct 31 13:30:00.098647 extend-filesystems[790]: Found vda1 Oct 31 13:30:00.098647 extend-filesystems[790]: Found vda2 Oct 31 13:30:00.098647 extend-filesystems[790]: Found vda3 Oct 31 13:30:00.101558 extend-filesystems[790]: Found usr Oct 31 13:30:00.101558 extend-filesystems[790]: Found vda4 Oct 31 13:30:00.101558 extend-filesystems[790]: Found vda6 Oct 31 13:30:00.101558 extend-filesystems[790]: Found vda7 Oct 31 13:30:00.101558 extend-filesystems[790]: Found vda9 Oct 31 13:30:00.101558 extend-filesystems[790]: Checking size of /dev/vda9 Oct 31 13:30:00.102164 systemd[1]: Starting User Login Management... Oct 31 13:30:00.103313 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 31 13:30:00.104134 systemd[1]: Starting Update Engine... Oct 31 13:30:00.105351 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 31 13:30:00.105373 systemd[1]: Reached target Load user-provided cloud configs. Oct 31 13:30:00.107251 systemd[1]: motdgen.service: Deactivated successfully. Oct 31 13:30:00.107473 systemd[1]: Finished Generate /run/flatcar/motd. Oct 31 13:30:00.110735 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 31 13:30:00.114851 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 31 13:30:00.119236 extend-filesystems[790]: Old size kept for /dev/vda9 Oct 31 13:30:00.119567 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 31 13:30:00.119830 systemd[1]: Finished Extend Filesystems. Oct 31 13:30:00.136249 systemd-logind[804]: Watching system buttons on /dev/input/event0 (Power Button) Oct 31 13:30:00.136408 systemd-logind[804]: New seat seat0. Oct 31 13:30:00.142018 systemd[1]: Started User Login Management. Oct 31 13:30:00.154398 update_engine[805]: I1031 13:30:00.154109 805 main.cc:89] Flatcar Update Engine starting Oct 31 13:30:00.155313 update_engine[805]: I1031 13:30:00.155293 805 payload_state.cc:360] Current Response Signature = Oct 31 13:30:00.155313 update_engine[805]: NumURLs = 1 Oct 31 13:30:00.155313 update_engine[805]: Url0 = http://10.0.0.5:34567/packages/update.gz Oct 31 13:30:00.155313 update_engine[805]: Payload Size = 426251591 Oct 31 13:30:00.155313 update_engine[805]: Payload Sha256 Hash = qwysf93IzFKZIIEIOAr8FB/Ur4+2vzR6efmfEvB0U+Q= Oct 31 13:30:00.155313 update_engine[805]: Is Delta Payload = 0 Oct 31 13:30:00.155313 update_engine[805]: Max Failure Count Per Url = 10 Oct 31 13:30:00.155313 update_engine[805]: Disable Payload Backoff = 1 Oct 31 13:30:00.155787 update_engine[805]: I1031 13:30:00.155768 805 payload_state.cc:381] Payload Attempt Number = 0 Oct 31 13:30:00.156067 update_engine[805]: I1031 13:30:00.156050 805 payload_state.cc:404] Current URL Index = 0 Oct 31 13:30:00.156321 update_engine[805]: I1031 13:30:00.156306 805 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 31 13:30:00.156583 update_engine[805]: I1031 13:30:00.156550 805 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 31 13:30:00.157257 systemd[1]: Finished Generate sshd host keys. Oct 31 13:30:00.158855 update_engine[805]: I1031 13:30:00.158823 805 update_check_scheduler.cc:74] Next update check in 5m41s Oct 31 13:30:00.172683 systemd[1]: Starting Generate /run/issue... Oct 31 13:30:00.173488 systemd[1]: Started Update Engine. Oct 31 13:30:00.176963 systemd[1]: issuegen.service: Deactivated successfully. Oct 31 13:30:00.177199 systemd[1]: Finished Generate /run/issue. Oct 31 13:30:00.179175 systemd[1]: Starting Permit User Sessions... Oct 31 13:30:00.183508 systemd[1]: Finished Permit User Sessions. Oct 31 13:30:00.185574 systemd[1]: Started Getty on tty1. Oct 31 13:30:00.187324 systemd[1]: Started Serial Getty on ttyAMA0. Oct 31 13:30:00.188296 systemd[1]: Reached target Login Prompts. Oct 31 13:30:00.189234 systemd[1]: Reached target Multi-User System. Oct 31 13:30:00.191137 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 31 13:30:00.196007 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 31 13:30:00.196224 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 31 13:30:00.197237 systemd[1]: Startup finished in 698ms (kernel) + 1.091s (initrd) + 2.551s (userspace) = 4.341s. Oct 31 13:30:01.774867 systemd-networkd[715]: eth0: Gained IPv6LL Oct 31 13:30:09.956588 systemd[1]: Created slice Slice /system/sshd. Oct 31 13:30:09.957704 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53702). Oct 31 13:30:10.001487 sshd[829]: Accepted publickey for core from 10.0.0.1 port 53702 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:30:10.003216 sshd[829]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:30:10.016049 systemd[1]: Created slice User Slice of UID 500. Oct 31 13:30:10.017073 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 31 13:30:10.018543 systemd-logind[804]: New session 1 of user core. Oct 31 13:30:10.022854 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 31 13:30:10.024086 systemd[1]: Starting User Manager for UID 500... Oct 31 13:30:10.026111 systemd[832]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:30:10.070844 systemd[832]: Queued start job for default target Main User Target. Oct 31 13:30:10.070979 systemd[832]: Reached target Paths. Oct 31 13:30:10.070993 systemd[832]: Reached target Sockets. Oct 31 13:30:10.071004 systemd[832]: Reached target Timers. Oct 31 13:30:10.071014 systemd[832]: Reached target Basic System. Oct 31 13:30:10.071054 systemd[832]: Reached target Main User Target. Oct 31 13:30:10.071066 systemd[832]: Startup finished in 41ms. Oct 31 13:30:10.071124 systemd[1]: Started User Manager for UID 500. Oct 31 13:30:10.083827 systemd[1]: Started Session 1 of User core. Oct 31 13:30:10.146076 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53718). Oct 31 13:30:10.186140 sshd[841]: Accepted publickey for core from 10.0.0.1 port 53718 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:30:10.187049 sshd[841]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:30:10.189526 systemd-logind[804]: New session 2 of user core. Oct 31 13:30:10.200742 systemd[1]: Started Session 2 of User core. Oct 31 13:30:10.252128 sshd[841]: pam_unix(sshd:session): session closed for user core Oct 31 13:30:10.260850 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53726). Oct 31 13:30:10.261861 systemd[1]: session-2.scope: Deactivated successfully. Oct 31 13:30:10.262487 systemd-logind[804]: Session 2 logged out. Waiting for processes to exit. Oct 31 13:30:10.262625 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:53718.service: Deactivated successfully. Oct 31 13:30:10.263394 systemd-logind[804]: Removed session 2. Oct 31 13:30:10.300968 sshd[846]: Accepted publickey for core from 10.0.0.1 port 53726 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:30:10.301791 sshd[846]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:30:10.304529 systemd-logind[804]: New session 3 of user core. Oct 31 13:30:10.317742 systemd[1]: Started Session 3 of User core. Oct 31 13:30:10.364969 sshd[846]: pam_unix(sshd:session): session closed for user core Oct 31 13:30:10.373099 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:53726.service: Deactivated successfully. Oct 31 13:30:10.373618 systemd[1]: session-3.scope: Deactivated successfully. Oct 31 13:30:10.374181 systemd-logind[804]: Session 3 logged out. Waiting for processes to exit. Oct 31 13:30:10.375074 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53734). Oct 31 13:30:10.375617 systemd-logind[804]: Removed session 3. Oct 31 13:30:10.414902 sshd[853]: Accepted publickey for core from 10.0.0.1 port 53734 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:30:10.416060 sshd[853]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:30:10.418505 systemd-logind[804]: New session 4 of user core. Oct 31 13:30:10.429805 systemd[1]: Started Session 4 of User core. Oct 31 13:30:10.482229 sshd[853]: pam_unix(sshd:session): session closed for user core Oct 31 13:30:10.492421 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:53734.service: Deactivated successfully. Oct 31 13:30:10.492968 systemd[1]: session-4.scope: Deactivated successfully. Oct 31 13:30:10.493546 systemd-logind[804]: Session 4 logged out. Waiting for processes to exit. Oct 31 13:30:10.494473 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53742). Oct 31 13:30:10.495330 systemd-logind[804]: Removed session 4. Oct 31 13:30:10.535012 sshd[859]: Accepted publickey for core from 10.0.0.1 port 53742 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:30:10.536106 sshd[859]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:30:10.538408 systemd-logind[804]: New session 5 of user core. Oct 31 13:30:10.547747 systemd[1]: Started Session 5 of User core. Oct 31 13:30:10.605626 sudo[862]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 31 13:30:10.605844 sudo[862]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 31 13:30:10.622124 sudo[862]: pam_unix(sudo:session): session closed for user root Oct 31 13:30:10.624827 sshd[859]: pam_unix(sshd:session): session closed for user core Oct 31 13:30:10.641413 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53756). Oct 31 13:30:10.644496 dbus-daemon[789]: [system] Reloaded configuration Oct 31 13:30:10.648181 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:53742.service: Deactivated successfully. Oct 31 13:30:10.648843 systemd[1]: session-5.scope: Deactivated successfully. Oct 31 13:30:10.649462 systemd-logind[804]: Session 5 logged out. Waiting for processes to exit. Oct 31 13:30:10.650151 systemd-logind[804]: Removed session 5. Oct 31 13:30:10.682583 sshd[865]: Accepted publickey for core from 10.0.0.1 port 53756 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:30:10.683590 sshd[865]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:30:10.686077 systemd-logind[804]: New session 6 of user core. Oct 31 13:30:10.692748 systemd[1]: Started Session 6 of User core. Oct 31 13:30:10.742698 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 31 13:30:10.742891 sudo[870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 31 13:30:10.745305 sudo[870]: pam_unix(sudo:session): session closed for user root Oct 31 13:30:10.748770 sudo[869]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 31 13:30:10.748967 sudo[869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 31 13:30:10.764499 systemd[1]: Stopping Load Security Auditing Rules... Oct 31 13:30:10.763000 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 31 13:30:10.765574 auditctl[873]: No rules Oct 31 13:30:10.766174 kernel: kauditd_printk_skb: 49 callbacks suppressed Oct 31 13:30:10.766206 kernel: audit: type=1305 audit(1761917410.763:60): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 31 13:30:10.766421 systemd[1]: audit-rules.service: Deactivated successfully. Oct 31 13:30:10.766670 systemd[1]: Stopped Load Security Auditing Rules. Oct 31 13:30:10.767928 systemd[1]: Starting Load Security Auditing Rules... Oct 31 13:30:10.781594 augenrules[890]: No rules Oct 31 13:30:10.782225 systemd[1]: Finished Load Security Auditing Rules. Oct 31 13:30:10.782933 sudo[869]: pam_unix(sudo:session): session closed for user root Oct 31 13:30:10.783984 sshd[865]: pam_unix(sshd:session): session closed for user core Oct 31 13:30:10.802669 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:53756.service: Deactivated successfully. Oct 31 13:30:10.803204 systemd[1]: session-6.scope: Deactivated successfully. Oct 31 13:30:10.803795 systemd-logind[804]: Session 6 logged out. Waiting for processes to exit. Oct 31 13:30:10.804717 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53766). Oct 31 13:30:10.805185 systemd-logind[804]: Removed session 6. Oct 31 13:30:10.851644 sshd[896]: Accepted publickey for core from 10.0.0.1 port 53766 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:30:10.852590 sshd[896]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:30:10.854620 kernel: audit: type=1006 audit(1761917410.850:61): pid=896 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Oct 31 13:30:10.856024 systemd-logind[804]: New session 7 of user core. Oct 31 13:30:10.864742 systemd[1]: Started Session 7 of User core. Oct 31 13:30:10.912661 sshd[896]: pam_unix(sshd:session): session closed for user core Oct 31 13:30:10.921091 systemd[1]: sshd@6-10.0.0.6:22-10.0.0.1:53766.service: Deactivated successfully. Oct 31 13:30:10.921600 systemd[1]: session-7.scope: Deactivated successfully. Oct 31 13:30:10.922169 systemd-logind[804]: Session 7 logged out. Waiting for processes to exit. Oct 31 13:30:10.923056 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53770). Oct 31 13:30:10.923668 systemd-logind[804]: Removed session 7. Oct 31 13:30:10.963180 sshd[903]: Accepted publickey for core from 10.0.0.1 port 53770 ssh2: RSA SHA256:PD05pPq0MsHkWACXZrHSBwEXfUJbYrflEJ/loaOlZuI Oct 31 13:30:10.964241 sshd[903]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 31 13:30:10.966633 kernel: audit: type=1006 audit(1761917410.963:62): pid=903 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Oct 31 13:30:10.967933 systemd-logind[804]: New session 8 of user core. Oct 31 13:30:10.981751 systemd[1]: Started Session 8 of User core. Oct 31 13:30:11.029577 sshd[903]: pam_unix(sshd:session): session closed for user core Oct 31 13:30:11.031585 systemd[1]: sshd@7-10.0.0.6:22-10.0.0.1:53770.service: Deactivated successfully. Oct 31 13:30:11.032207 systemd[1]: session-8.scope: Deactivated successfully. Oct 31 13:30:11.032741 systemd-logind[804]: Session 8 logged out. Waiting for processes to exit. Oct 31 13:30:11.033469 systemd-logind[804]: Removed session 8.