Oct 28 04:31:52.683069 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 28 04:31:52.683086 kernel: Linux version 5.10.107-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo 9.3.0-r1 p3) 9.3.0, GNU ld (Gentoo 2.36.1 p5) 2.36.1) #1 SMP PREEMPT Tue Mar 22 19:39:09 -00 2022 Oct 28 04:31:52.683095 kernel: efi: EFI v2.70 by EDK II Oct 28 04:31:52.683100 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 28 04:31:52.683105 kernel: efi: seeding entropy pool Oct 28 04:31:52.683110 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 28 04:31:52.683116 kernel: ACPI: Early table checksum verification disabled Oct 28 04:31:52.683121 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 28 04:31:52.683126 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 28 04:31:52.683132 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:31:52.683138 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:31:52.683143 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:31:52.683149 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:31:52.683154 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:31:52.683160 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:31:52.683166 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:31:52.683172 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:31:52.683178 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:31:52.683184 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 28 04:31:52.683189 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 28 04:31:52.683194 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:31:52.683200 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 28 04:31:52.683205 kernel: Zone ranges: Oct 28 04:31:52.683210 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:31:52.683216 kernel: DMA32 empty Oct 28 04:31:52.683221 kernel: Normal empty Oct 28 04:31:52.683226 kernel: Movable zone start for each node Oct 28 04:31:52.683236 kernel: Early memory node ranges Oct 28 04:31:52.683242 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 28 04:31:52.683247 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 28 04:31:52.683252 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 28 04:31:52.683258 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 28 04:31:52.683263 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 28 04:31:52.683269 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 28 04:31:52.683274 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 28 04:31:52.683279 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 28 04:31:52.683285 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 28 04:31:52.683290 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 28 04:31:52.683295 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 28 04:31:52.683301 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:31:52.683310 kernel: On node 0 totalpages: 643072 Oct 28 04:31:52.683316 kernel: DMA zone: 10048 pages used for memmap Oct 28 04:31:52.683321 kernel: DMA zone: 0 pages reserved Oct 28 04:31:52.683327 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 28 04:31:52.683333 kernel: psci: probing for conduit method from ACPI. Oct 28 04:31:52.683339 kernel: psci: PSCIv1.1 detected in firmware. Oct 28 04:31:52.683344 kernel: psci: Using standard PSCI v0.2 function IDs Oct 28 04:31:52.683350 kernel: psci: Trusted OS migration not required Oct 28 04:31:52.683357 kernel: psci: SMC Calling Convention v1.1 Oct 28 04:31:52.683362 kernel: ACPI: SRAT not present Oct 28 04:31:52.683368 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 28 04:31:52.683374 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 28 04:31:52.683380 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 28 04:31:52.683386 kernel: Detected PIPT I-cache on CPU0 Oct 28 04:31:52.683392 kernel: CPU features: detected: GIC system register CPU interface Oct 28 04:31:52.683397 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 28 04:31:52.683403 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 28 04:31:52.683409 kernel: CPU features: detected: Hardware dirty bit management Oct 28 04:31:52.683415 kernel: CPU features: detected: Spectre-v4 Oct 28 04:31:52.683422 kernel: CPU features: detected: ARM erratum 1418040 Oct 28 04:31:52.683428 kernel: CPU features: detected: Spectre-BHB Oct 28 04:31:52.683433 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 28 04:31:52.683439 kernel: Policy zone: DMA Oct 28 04:31:52.683446 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 28 04:31:52.683452 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 28 04:31:52.683458 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 28 04:31:52.683463 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 28 04:31:52.683470 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 28 04:31:52.683475 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 28 04:31:52.683481 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 28 04:31:52.683488 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 28 04:31:52.683494 kernel: rcu: RCU event tracing is enabled. Oct 28 04:31:52.683500 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 28 04:31:52.683506 kernel: Trampoline variant of Tasks RCU enabled. Oct 28 04:31:52.683512 kernel: Tracing variant of Tasks RCU enabled. Oct 28 04:31:52.683518 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 28 04:31:52.683524 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 28 04:31:52.683529 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 28 04:31:52.683535 kernel: GICv3: 256 SPIs implemented Oct 28 04:31:52.683540 kernel: GICv3: 0 Extended SPIs implemented Oct 28 04:31:52.683546 kernel: GICv3: Distributor has no Range Selector support Oct 28 04:31:52.683552 kernel: GICv3: 16 PPIs implemented Oct 28 04:31:52.683559 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 28 04:31:52.683564 kernel: ACPI: SRAT not present Oct 28 04:31:52.683570 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 28 04:31:52.683575 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 28 04:31:52.683581 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 28 04:31:52.683587 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 28 04:31:52.683596 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 28 04:31:52.683602 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:31:52.683608 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 28 04:31:52.683614 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 28 04:31:52.683620 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 28 04:31:52.683626 kernel: arm-pv: using stolen time PV Oct 28 04:31:52.683634 kernel: Console: colour dummy device 80x25 Oct 28 04:31:52.683640 kernel: ACPI: Core revision 20200925 Oct 28 04:31:52.683646 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 28 04:31:52.683652 kernel: pid_max: default: 32768 minimum: 301 Oct 28 04:31:52.683658 kernel: LSM: Security Framework initializing Oct 28 04:31:52.683664 kernel: SELinux: Initializing. Oct 28 04:31:52.683670 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:31:52.683676 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:31:52.683682 kernel: rcu: Hierarchical SRCU implementation. Oct 28 04:31:52.683689 kernel: Platform MSI: ITS@0x8080000 domain created Oct 28 04:31:52.683695 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 28 04:31:52.683701 kernel: Remapping and enabling EFI services. Oct 28 04:31:52.683707 kernel: smp: Bringing up secondary CPUs ... Oct 28 04:31:52.683713 kernel: Detected PIPT I-cache on CPU1 Oct 28 04:31:52.683719 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 28 04:31:52.683725 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 28 04:31:52.683734 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:31:52.683746 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 28 04:31:52.683753 kernel: Detected PIPT I-cache on CPU2 Oct 28 04:31:52.683761 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 28 04:31:52.683768 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 28 04:31:52.683774 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:31:52.683780 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 28 04:31:52.683786 kernel: Detected PIPT I-cache on CPU3 Oct 28 04:31:52.683796 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 28 04:31:52.683802 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 28 04:31:52.683810 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:31:52.683816 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 28 04:31:52.683822 kernel: smp: Brought up 1 node, 4 CPUs Oct 28 04:31:52.683828 kernel: SMP: Total of 4 processors activated. Oct 28 04:31:52.683834 kernel: CPU features: detected: Privileged Access Never Oct 28 04:31:52.683841 kernel: CPU features: detected: LSE atomic instructions Oct 28 04:31:52.683847 kernel: CPU features: detected: User Access Override Oct 28 04:31:52.683853 kernel: CPU features: detected: 32-bit EL0 Support Oct 28 04:31:52.683859 kernel: CPU features: detected: Common not Private translations Oct 28 04:31:52.683866 kernel: CPU features: detected: RAS Extension Support Oct 28 04:31:52.683873 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 28 04:31:52.683879 kernel: CPU features: detected: CRC32 instructions Oct 28 04:31:52.683910 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 28 04:31:52.683917 kernel: CPU: All CPU(s) started at EL1 Oct 28 04:31:52.683923 kernel: alternatives: patching kernel code Oct 28 04:31:52.683930 kernel: devtmpfs: initialized Oct 28 04:31:52.683936 kernel: KASLR enabled Oct 28 04:31:52.683943 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 28 04:31:52.683950 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 28 04:31:52.683956 kernel: pinctrl core: initialized pinctrl subsystem Oct 28 04:31:52.683962 kernel: SMBIOS 3.0.0 present. Oct 28 04:31:52.683968 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 28 04:31:52.683975 kernel: NET: Registered protocol family 16 Oct 28 04:31:52.683981 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 28 04:31:52.683987 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 28 04:31:52.683995 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 28 04:31:52.684001 kernel: audit: initializing netlink subsys (disabled) Oct 28 04:31:52.684007 kernel: audit: type=2000 audit(0.032:1): state=initialized audit_enabled=0 res=1 Oct 28 04:31:52.684014 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 28 04:31:52.684020 kernel: cpuidle: using governor menu Oct 28 04:31:52.684026 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 28 04:31:52.684033 kernel: ASID allocator initialised with 32768 entries Oct 28 04:31:52.684039 kernel: ACPI: bus type PCI registered Oct 28 04:31:52.684045 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 28 04:31:52.684052 kernel: Serial: AMBA PL011 UART driver Oct 28 04:31:52.684064 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 28 04:31:52.684070 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 28 04:31:52.684076 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 28 04:31:52.684083 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 28 04:31:52.684089 kernel: cryptd: max_cpu_qlen set to 1000 Oct 28 04:31:52.684095 kernel: ACPI: Added _OSI(Module Device) Oct 28 04:31:52.684102 kernel: ACPI: Added _OSI(Processor Device) Oct 28 04:31:52.684108 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 28 04:31:52.684116 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 28 04:31:52.684123 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 28 04:31:52.684129 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 28 04:31:52.684135 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 28 04:31:52.684142 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 28 04:31:52.684148 kernel: ACPI: Interpreter enabled Oct 28 04:31:52.684154 kernel: ACPI: Using GIC for interrupt routing Oct 28 04:31:52.684160 kernel: ACPI: MCFG table detected, 1 entries Oct 28 04:31:52.684166 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 28 04:31:52.684173 kernel: printk: console [ttyAMA0] enabled Oct 28 04:31:52.684180 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 28 04:31:52.684288 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 28 04:31:52.684347 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 28 04:31:52.684401 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 28 04:31:52.684456 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 28 04:31:52.684510 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 28 04:31:52.684519 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 28 04:31:52.684527 kernel: PCI host bridge to bus 0000:00 Oct 28 04:31:52.684587 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 28 04:31:52.684647 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 28 04:31:52.684697 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 28 04:31:52.684756 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 28 04:31:52.684828 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 28 04:31:52.684908 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 28 04:31:52.684972 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 28 04:31:52.685032 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 28 04:31:52.685095 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 04:31:52.685156 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 04:31:52.685218 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 28 04:31:52.685280 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 28 04:31:52.685333 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 28 04:31:52.685388 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 28 04:31:52.685450 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 28 04:31:52.685459 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 28 04:31:52.685465 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 28 04:31:52.685472 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 28 04:31:52.685478 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 28 04:31:52.685485 kernel: vgaarb: loaded Oct 28 04:31:52.685491 kernel: Registered efivars operations Oct 28 04:31:52.685498 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 28 04:31:52.685506 kernel: VFS: Disk quotas dquot_6.6.0 Oct 28 04:31:52.685512 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 28 04:31:52.685519 kernel: pnp: PnP ACPI init Oct 28 04:31:52.685587 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 28 04:31:52.685651 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 28 04:31:52.685660 kernel: pnp: PnP ACPI: found 1 devices Oct 28 04:31:52.685667 kernel: NET: Registered protocol family 2 Oct 28 04:31:52.685674 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 28 04:31:52.685683 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 28 04:31:52.685689 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 28 04:31:52.685696 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 28 04:31:52.685702 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 28 04:31:52.685709 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:31:52.685716 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:31:52.685722 kernel: NET: Registered protocol family 1 Oct 28 04:31:52.685729 kernel: PCI: CLS 0 bytes, default 64 Oct 28 04:31:52.685735 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 28 04:31:52.685785 kernel: kvm [1]: HYP mode not available Oct 28 04:31:52.685793 kernel: Initialise system trusted keyrings Oct 28 04:31:52.685800 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 28 04:31:52.685806 kernel: Key type asymmetric registered Oct 28 04:31:52.685812 kernel: Asymmetric key parser 'x509' registered Oct 28 04:31:52.685819 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 28 04:31:52.685825 kernel: io scheduler mq-deadline registered Oct 28 04:31:52.685832 kernel: io scheduler kyber registered Oct 28 04:31:52.685838 kernel: io scheduler bfq registered Oct 28 04:31:52.685847 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 28 04:31:52.685853 kernel: ACPI: Power Button [PWRB] Oct 28 04:31:52.685860 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 28 04:31:52.685955 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 28 04:31:52.685966 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 28 04:31:52.685973 kernel: msm_serial: driver initialized Oct 28 04:31:52.685979 kernel: random: fast init done Oct 28 04:31:52.685985 kernel: random: crng init done Oct 28 04:31:52.685992 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 28 04:31:52.685998 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 28 04:31:52.686007 kernel: thunder_xcv, ver 1.0 Oct 28 04:31:52.686013 kernel: thunder_bgx, ver 1.0 Oct 28 04:31:52.686019 kernel: nicpf, ver 1.0 Oct 28 04:31:52.686026 kernel: nicvf, ver 1.0 Oct 28 04:31:52.686101 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 28 04:31:52.686156 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-28T04:31:52 UTC (1761625912) Oct 28 04:31:52.686165 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 28 04:31:52.686171 kernel: NET: Registered protocol family 10 Oct 28 04:31:52.686179 kernel: Segment Routing with IPv6 Oct 28 04:31:52.686185 kernel: NET: Registered protocol family 17 Oct 28 04:31:52.686192 kernel: Key type dns_resolver registered Oct 28 04:31:52.686198 kernel: registered taskstats version 1 Oct 28 04:31:52.686205 kernel: Loading compiled-in X.509 certificates Oct 28 04:31:52.686211 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 28 04:31:52.686218 kernel: Key type ._fscrypt registered Oct 28 04:31:52.686224 kernel: Key type .fscrypt registered Oct 28 04:31:52.686234 kernel: Key type fscrypt-provisioning registered Oct 28 04:31:52.686242 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 28 04:31:52.686248 kernel: ima: Allocated hash algorithm: sha1 Oct 28 04:31:52.686255 kernel: ima: No architecture policies found Oct 28 04:31:52.686261 kernel: Freeing unused kernel memory: 34240K Oct 28 04:31:52.686267 kernel: Run /init as init process Oct 28 04:31:52.686274 kernel: with arguments: Oct 28 04:31:52.686280 kernel: /init Oct 28 04:31:52.686286 kernel: with environment: Oct 28 04:31:52.686292 kernel: HOME=/ Oct 28 04:31:52.686298 kernel: TERM=linux Oct 28 04:31:52.686305 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 28 04:31:52.686313 systemd[1]: systemd 249 running in system mode (+PAM -AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Oct 28 04:31:52.686322 systemd[1]: Detected virtualization kvm. Oct 28 04:31:52.686329 systemd[1]: Detected architecture arm64. Oct 28 04:31:52.686336 systemd[1]: Running in initial RAM disk. Oct 28 04:31:52.686342 systemd[1]: No hostname configured, using default hostname. Oct 28 04:31:52.686349 systemd[1]: Hostname set to . Oct 28 04:31:52.686357 systemd[1]: Initializing machine ID from VM UUID. Oct 28 04:31:52.686364 systemd[1]: Queued start job for default target Initrd Default Target. Oct 28 04:31:52.686371 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 04:31:52.686378 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 04:31:52.686384 systemd[1]: Reached target Path Units. Oct 28 04:31:52.686391 systemd[1]: Reached target Slice Units. Oct 28 04:31:52.686398 systemd[1]: Reached target Swaps. Oct 28 04:31:52.686404 systemd[1]: Reached target Timer Units. Oct 28 04:31:52.686413 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 28 04:31:52.686420 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 28 04:31:52.686427 systemd[1]: Listening on Journal Audit Socket. Oct 28 04:31:52.686434 systemd[1]: Listening on Journal Socket (/dev/log). Oct 28 04:31:52.686441 systemd[1]: Listening on Journal Socket. Oct 28 04:31:52.686448 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 04:31:52.686455 systemd[1]: Listening on udev Control Socket. Oct 28 04:31:52.686462 systemd[1]: Listening on udev Kernel Socket. Oct 28 04:31:52.686469 systemd[1]: Reached target Socket Units. Oct 28 04:31:52.686478 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 04:31:52.686485 systemd[1]: Finished Network Cleanup. Oct 28 04:31:52.686492 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 28 04:31:52.686499 systemd[1]: Starting Journal Service... Oct 28 04:31:52.686506 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 04:31:52.686513 systemd[1]: Starting Apply Kernel Variables... Oct 28 04:31:52.686520 systemd[1]: Starting Setup Virtual Console... Oct 28 04:31:52.686527 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 04:31:52.686533 systemd[1]: Finished Apply Kernel Variables. Oct 28 04:31:52.686542 systemd[1]: Finished Setup Virtual Console. Oct 28 04:31:52.686549 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 28 04:31:52.686562 systemd-journald[278]: Journal started Oct 28 04:31:52.686599 systemd-journald[278]: Runtime Journal (/run/log/journal/f584566887b64c39b8181653a7f79892) is 6.0M, max 48.5M, 42.4M free. Oct 28 04:31:52.690526 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 04:31:52.690553 systemd[1]: Started Journal Service. Oct 28 04:31:52.691558 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 04:31:52.702825 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 28 04:31:52.704691 systemd[1]: Starting dracut cmdline hook... Oct 28 04:31:52.713429 dracut-cmdline[296]: dracut-dracut-053 Oct 28 04:31:52.715702 dracut-cmdline[296]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 28 04:31:52.771907 kernel: SCSI subsystem initialized Oct 28 04:31:52.775898 kernel: Loading iSCSI transport class v2.0-870. Oct 28 04:31:52.781919 kernel: iscsi: registered transport (tcp) Oct 28 04:31:52.792979 kernel: iscsi: registered transport (qla4xxx) Oct 28 04:31:52.793001 kernel: QLogic iSCSI HBA Driver Oct 28 04:31:52.802872 systemd[1]: Finished dracut cmdline hook. Oct 28 04:31:52.804468 systemd[1]: Starting dracut pre-udev hook... Oct 28 04:31:52.818169 kernel: device-mapper: uevent: version 1.0.3 Oct 28 04:31:52.818203 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 28 04:31:52.852924 kernel: raid6: neonx8 gen() 13779 MB/s Oct 28 04:31:52.869910 kernel: raid6: neonx8 xor() 10744 MB/s Oct 28 04:31:52.886911 kernel: raid6: neonx4 gen() 13609 MB/s Oct 28 04:31:52.903903 kernel: raid6: neonx4 xor() 11565 MB/s Oct 28 04:31:52.920904 kernel: raid6: neonx2 gen() 13034 MB/s Oct 28 04:31:52.937910 kernel: raid6: neonx2 xor() 9888 MB/s Oct 28 04:31:52.954908 kernel: raid6: neonx1 gen() 10926 MB/s Oct 28 04:31:52.971910 kernel: raid6: neonx1 xor() 8810 MB/s Oct 28 04:31:52.988929 kernel: raid6: int64x8 gen() 6833 MB/s Oct 28 04:31:53.005917 kernel: raid6: int64x8 xor() 3796 MB/s Oct 28 04:31:53.022915 kernel: raid6: int64x4 gen() 6915 MB/s Oct 28 04:31:53.039914 kernel: raid6: int64x4 xor() 3835 MB/s Oct 28 04:31:53.056914 kernel: raid6: int64x2 gen() 6188 MB/s Oct 28 04:31:53.073913 kernel: raid6: int64x2 xor() 3319 MB/s Oct 28 04:31:53.090912 kernel: raid6: int64x1 gen() 5009 MB/s Oct 28 04:31:53.108081 kernel: raid6: int64x1 xor() 2597 MB/s Oct 28 04:31:53.108093 kernel: raid6: using algorithm neonx8 gen() 13779 MB/s Oct 28 04:31:53.108101 kernel: raid6: .... xor() 10744 MB/s, rmw enabled Oct 28 04:31:53.109257 kernel: raid6: using neon recovery algorithm Oct 28 04:31:53.118906 kernel: xor: measuring software checksum speed Oct 28 04:31:53.119908 kernel: 8regs : 17152 MB/sec Oct 28 04:31:53.120907 kernel: 32regs : 20765 MB/sec Oct 28 04:31:53.122162 kernel: arm64_neon : 28834 MB/sec Oct 28 04:31:53.122174 kernel: xor: using function: arm64_neon (28834 MB/sec) Oct 28 04:31:53.165915 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 28 04:31:53.176249 systemd[1]: Finished dracut pre-udev hook. Oct 28 04:31:53.177000 audit: BPF prog-id=6 op=LOAD Oct 28 04:31:53.177000 audit: BPF prog-id=7 op=LOAD Oct 28 04:31:53.179833 kernel: audit: type=1334 audit(1761625913.177:2): prog-id=6 op=LOAD Oct 28 04:31:53.179867 kernel: audit: type=1334 audit(1761625913.177:3): prog-id=7 op=LOAD Oct 28 04:31:53.179876 kernel: audit: type=1334 audit(1761625913.177:4): prog-id=8 op=LOAD Oct 28 04:31:53.177000 audit: BPF prog-id=8 op=LOAD Oct 28 04:31:53.179256 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 04:31:53.191719 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 04:31:53.193457 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 04:31:53.197483 systemd[1]: Starting dracut pre-trigger hook... Oct 28 04:31:53.199984 kernel: audit: type=1334 audit(1761625913.198:5): prog-id=9 op=LOAD Oct 28 04:31:53.198000 audit: BPF prog-id=9 op=LOAD Oct 28 04:31:53.199434 systemd[1]: Starting Network Configuration... Oct 28 04:31:53.207951 dracut-pre-trigger[426]: rd.md=0: removing MD RAID activation Oct 28 04:31:53.217068 systemd-networkd[428]: lo: Link UP Oct 28 04:31:53.217075 systemd-networkd[428]: lo: Gained carrier Oct 28 04:31:53.219000 audit: BPF prog-id=10 op=LOAD Oct 28 04:31:53.217349 systemd-networkd[428]: Enumeration completed Oct 28 04:31:53.221840 kernel: audit: type=1334 audit(1761625913.219:6): prog-id=10 op=LOAD Oct 28 04:31:53.217436 systemd[1]: Started Network Configuration. Oct 28 04:31:53.219822 systemd[1]: Starting Network Name Resolution... Oct 28 04:31:53.234422 systemd[1]: Finished dracut pre-trigger hook. Oct 28 04:31:53.236047 systemd[1]: Starting Coldplug All udev Devices... Oct 28 04:31:53.246418 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 04:31:53.248294 systemd-resolved[448]: Positive Trust Anchors: Oct 28 04:31:53.248301 systemd-resolved[448]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 04:31:53.248334 systemd-resolved[448]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Oct 28 04:31:53.248628 systemd-resolved[448]: Defaulting to hostname 'linux'. Oct 28 04:31:53.249822 systemd[1]: Started Network Name Resolution. Oct 28 04:31:53.252987 systemd[1]: Reached target Network. Oct 28 04:31:53.255194 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 04:31:53.257732 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 28 04:31:53.265592 systemd[1]: Finished Coldplug All udev Devices. Oct 28 04:31:53.270850 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 28 04:31:53.272686 systemd[1]: Starting Open-iSCSI... Oct 28 04:31:53.275234 iscsid[480]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 28 04:31:53.275234 iscsid[480]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log Oct 28 04:31:53.275234 iscsid[480]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Oct 28 04:31:53.275234 iscsid[480]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 28 04:31:53.275234 iscsid[480]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 28 04:31:53.275234 iscsid[480]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 28 04:31:53.275234 iscsid[480]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 28 04:31:53.279064 systemd[1]: Started Open-iSCSI. Oct 28 04:31:53.283685 systemd[1]: Starting dracut initqueue hook... Oct 28 04:31:53.302314 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 28 04:31:53.302441 kernel: vda: detected capacity change from 0 to 4756340736 Oct 28 04:31:53.314170 systemd-udevd[469]: Using default interface naming scheme 'v249'. Oct 28 04:31:53.316950 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 04:31:53.319691 systemd-networkd[428]: eth0: Link UP Oct 28 04:31:53.331907 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (467) Oct 28 04:31:53.336597 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 28 04:31:53.337829 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 28 04:31:53.342013 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 28 04:31:53.344834 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Oct 28 04:31:53.347774 systemd[1]: Found device /dev/disk/by-label/OEM. Oct 28 04:31:53.349063 systemd[1]: Finished dracut initqueue hook. Oct 28 04:31:53.350468 systemd[1]: Reached target Initrd Root Device. Oct 28 04:31:53.351924 systemd[1]: Reached target Preparation for Remote File Systems. Oct 28 04:31:53.353796 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 04:31:53.355695 systemd[1]: Reached target Remote File Systems. Oct 28 04:31:53.358123 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 28 04:31:53.359776 systemd[1]: Starting dracut pre-mount hook... Oct 28 04:31:53.367899 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 04:31:53.369122 systemd[1]: Finished dracut pre-mount hook. Oct 28 04:31:54.362930 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 28 04:31:54.362952 systemd-networkd[428]: eth0: Gained carrier Oct 28 04:31:54.368967 systemd-networkd[428]: eth0: DHCPv4 address 10.0.0.5/16 via 10.0.0.1 Oct 28 04:31:54.374912 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 04:31:54.375134 disk-uuid[504]: The operation has completed successfully. Oct 28 04:31:54.404902 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 28 04:31:54.405032 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 28 04:31:54.406849 systemd[1]: Starting Ignition (setup)... Oct 28 04:31:54.415503 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 04:31:54.415537 kernel: BTRFS info (device vda6): has skinny extents Oct 28 04:31:54.422111 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 28 04:31:54.428051 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 28 04:31:54.428182 systemd[1]: Finished Ignition (setup). Oct 28 04:31:54.430493 systemd[1]: Starting Ignition (disks)... Oct 28 04:31:54.443028 ignition[540]: Ignition v0.36.1-15-gde4e6cc9 Oct 28 04:31:54.443059 ignition[540]: Stage: disks Oct 28 04:31:54.443071 ignition[540]: reading system config file "/usr/lib/ignition/base.ign" Oct 28 04:31:54.443083 ignition[540]: no config at "/usr/lib/ignition/base.ign" Oct 28 04:31:54.443132 ignition[540]: parsed url from cmdline: "" Oct 28 04:31:54.443136 ignition[540]: no config URL provided Oct 28 04:31:54.443141 ignition[540]: reading system config file "/usr/lib/ignition/user.ign" Oct 28 04:31:54.443165 ignition[540]: no config at "/usr/lib/ignition/user.ign" Oct 28 04:31:54.443187 ignition[540]: op(1): [started] loading QEMU firmware config module Oct 28 04:31:54.443193 ignition[540]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 28 04:31:54.444835 ignition[540]: op(1): [finished] loading QEMU firmware config module Oct 28 04:31:54.458785 ignition[540]: parsing config with SHA512: 298274c3cb78495930f2f55a2e7c2afd9211812a9eaae26555099d1f1d8f497857d79ac55ce4a63d10b4f1f244bebb6badd0108c4d0d4ac71e8d83429fe61348 Oct 28 04:31:54.460954 ignition[540]: disks: disks passed Oct 28 04:31:54.460967 ignition[540]: Ignition finished successfully Oct 28 04:31:54.461566 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 28 04:31:54.461696 systemd[1]: Finished Ignition (disks). Oct 28 04:31:54.463323 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 04:31:54.465717 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 28 04:31:54.468184 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 28 04:31:54.479906 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 28 04:31:54.480938 systemd-fsck[554]: ROOT: clean, 528/553792 files, 37752/553472 blocks Oct 28 04:31:54.484502 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 28 04:31:54.486611 systemd[1]: Mounting /sysroot... Oct 28 04:31:54.505258 systemd[1]: Found device /dev/mapper/usr. Oct 28 04:31:54.507359 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 28 04:31:54.509989 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 28 04:31:54.519148 systemd-fsck[567]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 28 04:31:54.519148 systemd-fsck[567]: You must have r/w access to the filesystem or be root Oct 28 04:31:54.522679 systemd-fsck[564]: fsck failed with exit status 8. Oct 28 04:31:54.522689 systemd-fsck[564]: Ignoring error. Oct 28 04:31:54.524160 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 28 04:31:54.528862 systemd[1]: Mounting /sysusr/usr... Oct 28 04:31:54.539617 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 28 04:31:54.539655 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 28 04:31:54.540437 systemd[1]: Mounted /sysroot. Oct 28 04:31:54.541195 systemd[1]: Reached target Initrd Root File System. Oct 28 04:31:54.557911 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 28 04:31:54.558422 systemd[1]: Mounted /sysusr/usr. Oct 28 04:31:54.559191 systemd[1]: Reached target Local File Systems. Oct 28 04:31:54.560468 systemd[1]: Reached target System Initialization. Oct 28 04:31:54.561942 systemd[1]: Reached target Basic System. Oct 28 04:31:54.564392 systemd[1]: Mounting /sysroot/usr... Oct 28 04:31:54.566593 systemd[1]: Mounted /sysroot/usr. Oct 28 04:31:54.567967 systemd[1]: Starting Root filesystem setup... Oct 28 04:31:54.605025 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 28 04:31:54.605163 systemd[1]: Finished Root filesystem setup. Oct 28 04:31:54.607561 systemd[1]: Starting Ignition (files)... Oct 28 04:31:54.609027 systemd[1]: Starting /sysroot/boot... Oct 28 04:31:54.611531 ignition[584]: Ignition v0.36.1-15-gde4e6cc9 Oct 28 04:31:54.611547 ignition[584]: Stage: files Oct 28 04:31:54.611557 ignition[584]: reading system config file "/usr/lib/ignition/base.ign" Oct 28 04:31:54.611568 ignition[584]: no config at "/usr/lib/ignition/base.ign" Oct 28 04:31:54.612275 ignition[584]: files: compiled without relabeling support, skipping Oct 28 04:31:54.627287 systemd[1]: Finished /sysroot/boot. Oct 28 04:31:54.640699 ignition[584]: files: createUsers: op(1): [started] creating or modifying user "core" Oct 28 04:31:54.640713 ignition[584]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Oct 28 04:31:54.642684 ignition[584]: files: createUsers: op(1): [finished] creating or modifying user "core" Oct 28 04:31:54.642692 ignition[584]: files: createUsers: op(2): [started] adding ssh keys to user "core" Oct 28 04:31:54.646957 ignition[584]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Oct 28 04:31:54.646982 ignition[584]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Oct 28 04:31:54.648440 ignition[584]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Oct 28 04:31:54.648448 ignition[584]: files: op(4): [started] processing unit "coreos-metadata.service" Oct 28 04:31:54.651483 systemd[1]: ignition-files.service: Deactivated successfully. Oct 28 04:31:54.648536 ignition[584]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 28 04:31:54.651595 systemd[1]: Finished Ignition (files). Oct 28 04:31:54.650848 ignition[584]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 28 04:31:54.653317 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Oct 28 04:31:54.650855 ignition[584]: files: op(4): [finished] processing unit "coreos-metadata.service" Oct 28 04:31:54.654002 systemd[1]: Starting Ignition (record completion)... Oct 28 04:31:54.650860 ignition[584]: files: files passed Oct 28 04:31:54.655550 systemd[1]: Starting Reload Configuration from the Real Root... Oct 28 04:31:54.650863 ignition[584]: Ignition finished successfully Oct 28 04:31:54.672513 kernel: audit: type=1334 audit(1761625914.667:7): prog-id=6 op=UNLOAD Oct 28 04:31:54.672536 kernel: audit: type=1334 audit(1761625914.667:8): prog-id=10 op=UNLOAD Oct 28 04:31:54.672553 kernel: audit: type=1334 audit(1761625914.667:9): prog-id=9 op=UNLOAD Oct 28 04:31:54.672562 kernel: audit: type=1334 audit(1761625914.667:10): prog-id=3 op=UNLOAD Oct 28 04:31:54.667000 audit: BPF prog-id=6 op=UNLOAD Oct 28 04:31:54.667000 audit: BPF prog-id=10 op=UNLOAD Oct 28 04:31:54.667000 audit: BPF prog-id=9 op=UNLOAD Oct 28 04:31:54.667000 audit: BPF prog-id=3 op=UNLOAD Oct 28 04:31:54.657087 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 28 04:31:54.657194 systemd[1]: Finished Ignition (record completion). Oct 28 04:31:54.660978 systemd[1]: Reloading. Oct 28 04:31:54.751000 audit: BPF prog-id=11 op=LOAD Oct 28 04:31:54.751000 audit: BPF prog-id=12 op=LOAD Oct 28 04:31:54.751000 audit: BPF prog-id=13 op=LOAD Oct 28 04:31:54.751000 audit: BPF prog-id=7 op=UNLOAD Oct 28 04:31:54.751000 audit: BPF prog-id=8 op=UNLOAD Oct 28 04:31:54.752000 audit: BPF prog-id=14 op=LOAD Oct 28 04:31:54.752000 audit: BPF prog-id=15 op=LOAD Oct 28 04:31:54.752000 audit: BPF prog-id=16 op=LOAD Oct 28 04:31:54.753000 audit: BPF prog-id=17 op=LOAD Oct 28 04:31:54.753000 audit: BPF prog-id=18 op=LOAD Oct 28 04:31:54.753000 audit: BPF prog-id=4 op=UNLOAD Oct 28 04:31:54.753000 audit: BPF prog-id=5 op=UNLOAD Oct 28 04:31:54.768813 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 28 04:31:54.770084 systemd[1]: Finished Reload Configuration from the Real Root. Oct 28 04:31:54.772194 systemd[1]: Reached target Initrd File Systems. Oct 28 04:31:54.773857 systemd[1]: Reached target Initrd Default Target. Oct 28 04:31:54.774744 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 28 04:31:54.775444 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 28 04:31:54.785693 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 28 04:31:54.787368 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 28 04:31:54.793591 systemd[1]: Stopped target Host and Network Name Lookups. Oct 28 04:31:54.794711 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 04:31:54.796473 systemd[1]: Stopped target Timer Units. Oct 28 04:31:54.797899 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 28 04:31:54.798023 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 28 04:31:54.799460 systemd[1]: Stopped target Initrd Default Target. Oct 28 04:31:54.801116 systemd[1]: Stopped target Basic System. Oct 28 04:31:54.802560 systemd[1]: Stopped target Initrd Root Device. Oct 28 04:31:54.804005 systemd[1]: Stopped target Path Units. Oct 28 04:31:54.805392 systemd[1]: Stopped target Remote File Systems. Oct 28 04:31:54.806847 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 28 04:31:54.808470 systemd[1]: Stopped target Slice Units. Oct 28 04:31:54.809877 systemd[1]: Stopped target Socket Units. Oct 28 04:31:54.811637 systemd[1]: Stopped target System Initialization. Oct 28 04:31:54.813023 systemd[1]: Stopped target Local File Systems. Oct 28 04:31:54.814368 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 04:31:54.815964 systemd[1]: Stopped target Swaps. Oct 28 04:31:54.817340 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 28 04:31:54.817464 systemd[1]: Stopped dracut pre-mount hook. Oct 28 04:31:54.818964 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 04:31:54.820299 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 04:31:54.824921 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 04:31:54.826146 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 28 04:31:54.826258 systemd[1]: Stopped dracut initqueue hook. Oct 28 04:31:54.829965 iscsid[480]: iscsid shutting down. Oct 28 04:31:54.827978 systemd[1]: Stopping Open-iSCSI... Oct 28 04:31:54.830066 systemd[1]: Stopping /sysroot/boot... Oct 28 04:31:54.830610 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 28 04:31:54.830763 systemd[1]: Stopped Coldplug All udev Devices. Oct 28 04:31:54.832068 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 28 04:31:54.832151 systemd[1]: Stopped dracut pre-trigger hook. Oct 28 04:31:54.834246 systemd[1]: iscsid.service: Deactivated successfully. Oct 28 04:31:54.834376 systemd[1]: Stopped Open-iSCSI. Oct 28 04:31:54.836158 systemd[1]: iscsid.socket: Deactivated successfully. Oct 28 04:31:54.836219 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 28 04:31:54.838015 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 28 04:31:54.839334 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 28 04:31:54.839464 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 28 04:31:54.841282 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 28 04:31:54.841387 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 28 04:31:54.843542 systemd[1]: Stopped target Network. Oct 28 04:31:54.845010 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 28 04:31:54.845072 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 28 04:31:54.855000 audit: BPF prog-id=14 op=UNLOAD Oct 28 04:31:54.846493 systemd[1]: Stopping Network Name Resolution... Oct 28 04:31:54.848115 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 28 04:31:54.848227 systemd[1]: Stopped /sysroot/boot. Oct 28 04:31:54.852373 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 28 04:31:54.852484 systemd[1]: Stopped Network Name Resolution. Oct 28 04:31:54.854046 systemd[1]: Stopping Network Configuration... Oct 28 04:31:54.858194 systemd-networkd[428]: eth0: DHCP lease lost Oct 28 04:31:54.869952 systemd-networkd[428]: eth0: DHCPv6 lease lost Oct 28 04:31:54.871773 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 28 04:31:54.871909 systemd[1]: Stopped Network Configuration. Oct 28 04:31:54.873902 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 28 04:31:54.873936 systemd[1]: Closed Network Service Netlink Socket. Oct 28 04:31:54.876122 systemd[1]: Stopping Network Cleanup... Oct 28 04:31:54.876908 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 04:31:54.876982 systemd[1]: Stopped Apply Kernel Variables. Oct 28 04:31:54.883000 audit: BPF prog-id=15 op=UNLOAD Oct 28 04:31:54.878580 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 28 04:31:54.883829 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 28 04:31:54.884031 systemd[1]: Stopped Network Cleanup. Oct 28 04:31:54.888525 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 28 04:31:54.888670 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 28 04:31:54.890900 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 28 04:31:54.890943 systemd[1]: Closed udev Control Socket. Oct 28 04:31:54.892488 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 28 04:31:54.895000 audit: BPF prog-id=11 op=UNLOAD Oct 28 04:31:54.892527 systemd[1]: Closed udev Kernel Socket. Oct 28 04:31:54.894055 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 28 04:31:54.894101 systemd[1]: Stopped dracut pre-udev hook. Oct 28 04:31:54.895420 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 28 04:31:54.895459 systemd[1]: Stopped dracut cmdline hook. Oct 28 04:31:54.896983 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 28 04:31:54.897025 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 28 04:31:54.899372 systemd[1]: Starting Cleanup udev Database... Oct 28 04:31:54.900273 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 28 04:31:54.901612 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 04:31:54.901677 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 04:31:54.903369 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 28 04:31:54.903414 systemd[1]: Stopped Create List of Static Device Nodes. Oct 28 04:31:54.904800 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 04:31:54.904846 systemd[1]: Stopped Setup Virtual Console. Oct 28 04:31:54.906714 systemd[1]: rngd.service: Deactivated successfully. Oct 28 04:31:54.906844 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 28 04:31:54.908444 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 28 04:31:54.908546 systemd[1]: Finished Cleanup udev Database. Oct 28 04:31:54.909779 systemd[1]: Reached target Switch Root. Oct 28 04:31:54.912866 systemd[1]: Starting Switch Root... Oct 28 04:31:54.922000 audit: BPF prog-id=16 op=UNLOAD Oct 28 04:31:54.919454 systemd[1]: Switching root. Oct 28 04:31:54.938231 systemd-journald[278]: Journal stopped Oct 28 04:31:57.132255 systemd-journald[278]: Received SIGTERM from PID 1 (systemd). Oct 28 04:31:57.132331 kernel: SELinux: policy capability network_peer_controls=1 Oct 28 04:31:57.132344 kernel: SELinux: policy capability open_perms=1 Oct 28 04:31:57.132354 kernel: SELinux: policy capability extended_socket_class=1 Oct 28 04:31:57.132382 kernel: SELinux: policy capability always_check_network=0 Oct 28 04:31:57.132398 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 28 04:31:57.132407 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 28 04:31:57.132419 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 28 04:31:57.132430 systemd[1]: Successfully loaded SELinux policy in 32.960ms. Oct 28 04:31:57.132443 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.616ms. Oct 28 04:31:57.132453 systemd[1]: systemd 249 running in system mode (+PAM -AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Oct 28 04:31:57.132464 systemd[1]: Detected virtualization kvm. Oct 28 04:31:57.132525 systemd[1]: Detected architecture arm64. Oct 28 04:31:57.132625 systemd[1]: Detected first boot. Oct 28 04:31:57.132636 systemd[1]: Initializing machine ID from VM UUID. Oct 28 04:31:57.132646 systemd[1]: Populated /etc with preset unit settings. Oct 28 04:31:57.132661 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Oct 28 04:31:57.132673 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 28 04:31:57.132696 kernel: kauditd_printk_skb: 24 callbacks suppressed Oct 28 04:31:57.132707 kernel: audit: type=1334 audit(1761625916.989:35): prog-id=21 op=LOAD Oct 28 04:31:57.132716 kernel: audit: type=1334 audit(1761625916.990:36): prog-id=22 op=LOAD Oct 28 04:31:57.132733 kernel: audit: type=1334 audit(1761625916.991:37): prog-id=23 op=LOAD Oct 28 04:31:57.132742 kernel: audit: type=1334 audit(1761625916.991:38): prog-id=17 op=UNLOAD Oct 28 04:31:57.132750 kernel: audit: type=1334 audit(1761625916.991:39): prog-id=18 op=UNLOAD Oct 28 04:31:57.132907 kernel: audit: type=1334 audit(1761625917.004:40): prog-id=24 op=LOAD Oct 28 04:31:57.132921 kernel: audit: type=1334 audit(1761625917.004:41): prog-id=21 op=UNLOAD Oct 28 04:31:57.132934 kernel: audit: type=1334 audit(1761625917.005:42): prog-id=25 op=LOAD Oct 28 04:31:57.132944 kernel: audit: type=1334 audit(1761625917.006:43): prog-id=26 op=LOAD Oct 28 04:31:57.132953 kernel: audit: type=1334 audit(1761625917.006:44): prog-id=22 op=UNLOAD Oct 28 04:31:57.132964 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 28 04:31:57.132975 systemd[1]: Stopped Switch Root. Oct 28 04:31:57.132986 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 28 04:31:57.132998 systemd[1]: Created slice Slice /system/addon-config. Oct 28 04:31:57.133007 systemd[1]: Created slice Slice /system/addon-run. Oct 28 04:31:57.133017 systemd[1]: Created slice Slice /system/getty. Oct 28 04:31:57.133027 systemd[1]: Created slice Slice /system/modprobe. Oct 28 04:31:57.133037 systemd[1]: Created slice Slice /system/serial-getty. Oct 28 04:31:57.133047 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 28 04:31:57.133057 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 28 04:31:57.133066 systemd[1]: Created slice User and Session Slice. Oct 28 04:31:57.133076 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 04:31:57.133088 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 28 04:31:57.133097 systemd[1]: Set up automount Boot partition Automount Point. Oct 28 04:31:57.133107 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 28 04:31:57.133117 systemd[1]: Stopped target Switch Root. Oct 28 04:31:57.133127 systemd[1]: Stopped target Initrd File Systems. Oct 28 04:31:57.133137 systemd[1]: Stopped target Initrd Root File System. Oct 28 04:31:57.133147 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 04:31:57.133156 systemd[1]: Reached target Remote File Systems. Oct 28 04:31:57.133166 systemd[1]: Reached target Slice Units. Oct 28 04:31:57.133176 systemd[1]: Reached target Swaps. Oct 28 04:31:57.133186 systemd[1]: Reached target Verify torcx succeeded. Oct 28 04:31:57.133196 systemd[1]: Reached target Local Verity Protected Volumes. Oct 28 04:31:57.133206 systemd[1]: Listening on Process Core Dump Socket. Oct 28 04:31:57.133215 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 28 04:31:57.133224 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 04:31:57.133234 systemd[1]: Listening on udev Control Socket. Oct 28 04:31:57.133245 systemd[1]: Listening on udev Kernel Socket. Oct 28 04:31:57.133255 systemd[1]: Mounting Huge Pages File System... Oct 28 04:31:57.133264 systemd[1]: Mounting POSIX Message Queue File System... Oct 28 04:31:57.133319 systemd[1]: Mounting External Media Directory... Oct 28 04:31:57.133337 systemd[1]: Mounting Kernel Debug File System... Oct 28 04:31:57.133353 systemd[1]: Mounting Kernel Trace File System... Oct 28 04:31:57.133363 systemd[1]: Mounting Temporary Directory /tmp... Oct 28 04:31:57.133419 systemd[1]: Starting Create missing system files... Oct 28 04:31:57.133435 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 04:31:57.133446 systemd[1]: Starting Load Kernel Module configfs... Oct 28 04:31:57.133456 systemd[1]: Starting Load Kernel Module drm... Oct 28 04:31:57.133466 systemd[1]: Starting Load Kernel Module fuse... Oct 28 04:31:57.133475 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 28 04:31:57.133487 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 28 04:31:57.133497 systemd[1]: Stopped File System Check on Root Device. Oct 28 04:31:57.133507 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 28 04:31:57.133517 systemd[1]: Stopped systemd-fsck-usr.service. Oct 28 04:31:57.133527 kernel: fuse: init (API version 7.32) Oct 28 04:31:57.133536 systemd[1]: Stopped Journal Service. Oct 28 04:31:57.133546 systemd[1]: Starting Journal Service... Oct 28 04:31:57.133556 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 04:31:57.133566 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 28 04:31:57.133578 systemd[1]: Starting Apply Kernel Variables... Oct 28 04:31:57.133587 systemd[1]: Starting Coldplug All udev Devices... Oct 28 04:31:57.133597 systemd[1]: verity-setup.service: Deactivated successfully. Oct 28 04:31:57.133607 systemd[1]: Stopped verity-setup.service. Oct 28 04:31:57.133620 systemd-journald[798]: Journal started Oct 28 04:31:57.133688 systemd-journald[798]: Runtime Journal (/run/log/journal/f584566887b64c39b8181653a7f79892) is 6.0M, max 48.5M, 42.4M free. Oct 28 04:31:55.008000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 28 04:31:55.041000 audit[1]: AVC avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Oct 28 04:31:55.041000 audit[1]: AVC avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Oct 28 04:31:55.041000 audit: BPF prog-id=19 op=LOAD Oct 28 04:31:55.041000 audit: BPF prog-id=19 op=UNLOAD Oct 28 04:31:55.041000 audit: BPF prog-id=20 op=LOAD Oct 28 04:31:55.041000 audit: BPF prog-id=20 op=UNLOAD Oct 28 04:31:55.084000 audit[748]: AVC avc: denied { associate } for pid=748 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Oct 28 04:31:56.989000 audit: BPF prog-id=21 op=LOAD Oct 28 04:31:56.990000 audit: BPF prog-id=22 op=LOAD Oct 28 04:31:56.991000 audit: BPF prog-id=23 op=LOAD Oct 28 04:31:56.991000 audit: BPF prog-id=17 op=UNLOAD Oct 28 04:31:56.991000 audit: BPF prog-id=18 op=UNLOAD Oct 28 04:31:57.004000 audit: BPF prog-id=24 op=LOAD Oct 28 04:31:57.004000 audit: BPF prog-id=21 op=UNLOAD Oct 28 04:31:57.005000 audit: BPF prog-id=25 op=LOAD Oct 28 04:31:57.006000 audit: BPF prog-id=26 op=LOAD Oct 28 04:31:57.006000 audit: BPF prog-id=22 op=UNLOAD Oct 28 04:31:57.006000 audit: BPF prog-id=23 op=UNLOAD Oct 28 04:31:57.008000 audit: BPF prog-id=27 op=LOAD Oct 28 04:31:57.008000 audit: BPF prog-id=24 op=UNLOAD Oct 28 04:31:57.009000 audit: BPF prog-id=28 op=LOAD Oct 28 04:31:57.009000 audit: BPF prog-id=29 op=LOAD Oct 28 04:31:57.009000 audit: BPF prog-id=25 op=UNLOAD Oct 28 04:31:57.009000 audit: BPF prog-id=26 op=UNLOAD Oct 28 04:31:57.018000 audit: BPF prog-id=27 op=UNLOAD Oct 28 04:31:57.116000 audit: BPF prog-id=30 op=LOAD Oct 28 04:31:57.116000 audit: BPF prog-id=31 op=LOAD Oct 28 04:31:57.116000 audit: BPF prog-id=32 op=LOAD Oct 28 04:31:57.116000 audit: BPF prog-id=28 op=UNLOAD Oct 28 04:31:57.116000 audit: BPF prog-id=29 op=UNLOAD Oct 28 04:31:57.130000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 28 04:31:56.989656 systemd[1]: Queued start job for default target Multi-User System. Oct 28 04:31:55.081361 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3033.2.4 /usr/share/oem/torcx/store /var/lib/torcx/store/3033.2.4 /var/lib/torcx/store]" Oct 28 04:31:57.010425 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 28 04:31:55.081714 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 04:31:55.081746 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 04:31:55.083592 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 28 04:31:55.083607 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 28 04:31:55.083643 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 28 04:31:55.083657 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 28 04:31:55.083971 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 28 04:31:55.084015 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 04:31:55.084030 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 04:31:55.084622 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Oct 28 04:31:55.084654 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Oct 28 04:31:55.084675 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3033.2.4: no such file or directory" path=/usr/share/oem/torcx/store/3033.2.4 Oct 28 04:31:55.084691 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 28 04:31:55.084709 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3033.2.4: no such file or directory" path=/var/lib/torcx/store/3033.2.4 Oct 28 04:31:55.084723 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:55Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 28 04:31:56.808059 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:56Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:31:56.808341 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:56Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:31:56.808449 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:56Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:31:56.808574 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:56Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:31:56.808629 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:56Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 28 04:31:56.808685 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-10-28T04:31:56Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Oct 28 04:31:57.136512 systemd[1]: Started Journal Service. Oct 28 04:31:57.137080 systemd[1]: Mounted Huge Pages File System. Oct 28 04:31:57.138014 systemd[1]: Mounted POSIX Message Queue File System. Oct 28 04:31:57.139046 systemd[1]: Mounted External Media Directory. Oct 28 04:31:57.140000 systemd[1]: Mounted Kernel Debug File System. Oct 28 04:31:57.140980 systemd[1]: Mounted Kernel Trace File System. Oct 28 04:31:57.141975 systemd[1]: Mounted Temporary Directory /tmp. Oct 28 04:31:57.143213 systemd[1]: Finished Create missing system files. Oct 28 04:31:57.144521 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 04:31:57.145841 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 28 04:31:57.146073 systemd[1]: Finished Load Kernel Module configfs. Oct 28 04:31:57.147157 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 04:31:57.147345 systemd[1]: Finished Load Kernel Module drm. Oct 28 04:31:57.148371 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 28 04:31:57.148559 systemd[1]: Finished Load Kernel Module fuse. Oct 28 04:31:57.158391 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 28 04:31:57.159769 systemd[1]: Finished Apply Kernel Variables. Oct 28 04:31:57.163058 systemd[1]: Mounting FUSE Control File System... Oct 28 04:31:57.165012 systemd[1]: Mounting Kernel Configuration File System... Oct 28 04:31:57.165915 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 28 04:31:57.167609 systemd[1]: Starting Rebuild Hardware Database... Oct 28 04:31:57.169956 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 28 04:31:57.171047 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 28 04:31:57.172266 systemd[1]: Starting Load/Save Random Seed... Oct 28 04:31:57.175020 systemd-journald[798]: Time spent on flushing to /var/log/journal/f584566887b64c39b8181653a7f79892 is 8.504ms for 784 entries. Oct 28 04:31:57.175020 systemd-journald[798]: System Journal (/var/log/journal/f584566887b64c39b8181653a7f79892) is 8.0M, max 203.0M, 195.0M free. Oct 28 04:31:57.174344 systemd[1]: Starting Create System Users... Oct 28 04:31:57.177965 systemd[1]: Mounted FUSE Control File System. Oct 28 04:31:57.179232 systemd[1]: Mounted Kernel Configuration File System. Oct 28 04:31:57.181554 systemd[1]: Finished Load/Save Random Seed. Oct 28 04:31:57.184803 systemd[1]: Finished Coldplug All udev Devices. Oct 28 04:31:57.186052 systemd[1]: Reached target First Boot Complete. Oct 28 04:31:57.189977 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 28 04:31:57.192797 systemd-sysusers[810]: Creating group sgx with gid 999. Oct 28 04:31:57.193958 systemd-sysusers[810]: Creating group systemd-oom with gid 998. Oct 28 04:31:57.194689 systemd-sysusers[810]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Oct 28 04:31:57.195832 systemd-sysusers[810]: Creating group systemd-timesync with gid 997. Oct 28 04:31:57.196610 systemd-sysusers[810]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Oct 28 04:31:57.197547 systemd-sysusers[810]: Creating group systemd-coredump with gid 996. Oct 28 04:31:57.199140 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 28 04:31:57.200879 systemd-sysusers[810]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Oct 28 04:31:57.222301 systemd[1]: Finished Create System Users. Oct 28 04:31:57.224451 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 04:31:57.241582 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 04:31:57.453222 systemd[1]: Finished Rebuild Hardware Database. Oct 28 04:31:57.464000 audit: BPF prog-id=33 op=LOAD Oct 28 04:31:57.464000 audit: BPF prog-id=34 op=LOAD Oct 28 04:31:57.464000 audit: BPF prog-id=35 op=LOAD Oct 28 04:31:57.464000 audit: BPF prog-id=12 op=UNLOAD Oct 28 04:31:57.464000 audit: BPF prog-id=13 op=UNLOAD Oct 28 04:31:57.466499 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 04:31:57.491024 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 04:31:57.503274 systemd[1]: Starting Network Configuration... Oct 28 04:31:57.501000 audit: BPF prog-id=36 op=LOAD Oct 28 04:31:57.527407 systemd-udevd[826]: Using default interface naming scheme 'v249'. Oct 28 04:31:57.542036 systemd-networkd[835]: lo: Link UP Oct 28 04:31:57.542048 systemd-networkd[835]: lo: Gained carrier Oct 28 04:31:57.542456 systemd-networkd[835]: Enumeration completed Oct 28 04:31:57.542556 systemd[1]: Started Network Configuration. Oct 28 04:31:57.545003 systemd-networkd[835]: eth0: Link UP Oct 28 04:31:57.551070 systemd-networkd[835]: eth0: Gained carrier Oct 28 04:31:57.557520 udevadm[812]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 28 04:31:57.559090 systemd-networkd[835]: eth0: DHCPv4 address 10.0.0.5/16 via 10.0.0.1 Oct 28 04:31:57.583116 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 28 04:31:57.592058 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 04:31:57.600510 lvm[843]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 04:31:57.629014 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 04:31:57.630195 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 04:31:57.638034 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 04:31:57.641602 lvm[844]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 04:31:57.672140 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 04:31:57.673341 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 04:31:57.674535 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 28 04:31:57.674566 systemd[1]: Reached target Containers. Oct 28 04:31:57.694179 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 28 04:31:57.708921 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 28 04:31:57.719030 systemd[1]: Mounting /usr/share/oem... Oct 28 04:31:57.725597 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 04:31:57.725676 kernel: BTRFS info (device vda6): has skinny extents Oct 28 04:31:57.728104 systemd[1]: Mounted /usr/share/oem. Oct 28 04:31:57.729013 systemd[1]: Reached target Local File Systems. Oct 28 04:31:57.731135 systemd[1]: Starting Rebuild Dynamic Linker Cache... Oct 28 04:31:57.732376 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 28 04:31:57.732429 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 28 04:31:57.734014 systemd[1]: Starting Commit a transient machine-id on disk... Oct 28 04:31:57.736353 systemd[1]: Starting Create Volatile Files and Directories... Oct 28 04:31:57.742792 systemd-tmpfiles[869]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 28 04:31:57.744227 systemd-tmpfiles[869]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 28 04:31:57.753143 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 28 04:31:57.754281 systemd[1]: Finished Commit a transient machine-id on disk. Oct 28 04:31:57.781527 systemd-tmpfiles[869]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 04:31:57.781793 systemd-tmpfiles[869]: Skipping /boot Oct 28 04:31:57.790605 systemd-tmpfiles[869]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 04:31:57.790792 systemd-tmpfiles[869]: Skipping /boot Oct 28 04:31:57.818792 systemd[1]: Finished Rebuild Dynamic Linker Cache. Oct 28 04:31:57.836327 systemd[1]: Finished Create Volatile Files and Directories. Oct 28 04:31:57.838744 systemd[1]: Starting Load Security Auditing Rules... Oct 28 04:31:57.840945 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 28 04:31:57.843365 systemd[1]: Starting Rebuild Journal Catalog... Oct 28 04:31:57.844000 audit: BPF prog-id=37 op=LOAD Oct 28 04:31:57.847354 systemd[1]: Starting Network Name Resolution... Oct 28 04:31:57.848000 audit: BPF prog-id=38 op=LOAD Oct 28 04:31:57.850048 systemd[1]: Starting Network Time Synchronization... Oct 28 04:31:57.852266 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 28 04:31:57.854016 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 28 04:31:57.855596 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 28 04:31:57.858353 systemd[1]: Finished Rebuild Journal Catalog. Oct 28 04:31:57.873115 systemd[1]: Starting Update is Completed... Oct 28 04:31:57.877345 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 28 04:31:57.890361 systemd[1]: Finished Update is Completed. Oct 28 04:31:57.894000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 28 04:31:57.895359 systemd[1]: Started Network Time Synchronization. Oct 28 04:31:57.895495 augenrules[892]: No rules Oct 28 04:31:57.896538 systemd-timesyncd[880]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 28 04:31:57.896707 systemd[1]: Reached target System Time Set. Oct 28 04:31:57.898237 systemd-resolved[879]: Positive Trust Anchors: Oct 28 04:31:57.898249 systemd-resolved[879]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 04:31:57.898278 systemd-resolved[879]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Oct 28 04:31:57.898483 systemd[1]: Finished Load Security Auditing Rules. Oct 28 04:31:57.899364 systemd-resolved[879]: Defaulting to hostname 'linux'. Oct 28 04:31:57.905121 systemd[1]: Started Network Name Resolution. Oct 28 04:31:57.906093 systemd[1]: Reached target Network. Oct 28 04:31:57.906904 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 04:31:57.907923 systemd[1]: Reached target System Initialization. Oct 28 04:31:57.908917 systemd[1]: Started Watch for update engine configuration changes. Oct 28 04:31:57.910004 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 04:31:57.911281 systemd[1]: Started Daily Log Rotation. Oct 28 04:31:57.912192 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 28 04:31:57.913412 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 28 04:31:57.914442 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 28 04:31:57.914478 systemd[1]: Reached target Path Units. Oct 28 04:31:57.915256 systemd[1]: Reached target Timer Units. Oct 28 04:31:57.916527 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 28 04:31:57.918653 systemd[1]: Starting Docker Socket for the API... Oct 28 04:31:57.921841 systemd[1]: Listening on OpenSSH Server Socket. Oct 28 04:31:57.923308 systemd[1]: Listening on Docker Socket for the API. Oct 28 04:31:57.924292 systemd[1]: Reached target Socket Units. Oct 28 04:31:57.925141 systemd[1]: Reached target Basic System. Oct 28 04:31:57.925992 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 28 04:31:57.926024 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 28 04:31:57.927274 systemd[1]: Started D-Bus System Message Bus. Oct 28 04:31:57.930760 systemd[1]: Starting Extend Filesystems... Oct 28 04:31:57.931707 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 28 04:31:57.932830 systemd[1]: Starting Generate /run/flatcar/motd... Oct 28 04:31:57.934983 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 28 04:31:57.938078 systemd[1]: Starting Generate sshd host keys... Oct 28 04:31:57.939356 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 28 04:31:57.939388 systemd[1]: Reached target Load system-provided cloud configs. Oct 28 04:31:57.942177 extend-filesystems[901]: Found vda Oct 28 04:31:57.943353 extend-filesystems[901]: Found vda1 Oct 28 04:31:57.943353 extend-filesystems[901]: Found vda2 Oct 28 04:31:57.943353 extend-filesystems[901]: Found vda3 Oct 28 04:31:57.943353 extend-filesystems[901]: Found usr Oct 28 04:31:57.943353 extend-filesystems[901]: Found vda4 Oct 28 04:31:57.943353 extend-filesystems[901]: Found vda6 Oct 28 04:31:57.943353 extend-filesystems[901]: Found vda7 Oct 28 04:31:57.943353 extend-filesystems[901]: Found vda9 Oct 28 04:31:57.943353 extend-filesystems[901]: Checking size of /dev/vda9 Oct 28 04:31:57.942603 systemd[1]: Starting User Login Management... Oct 28 04:31:57.947149 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 28 04:31:57.951157 systemd[1]: Starting Update Engine... Oct 28 04:31:57.952005 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 28 04:31:57.952043 systemd[1]: Reached target Load user-provided cloud configs. Oct 28 04:31:57.953850 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 28 04:31:57.954140 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 28 04:31:57.955765 systemd[1]: motdgen.service: Deactivated successfully. Oct 28 04:31:57.956056 systemd[1]: Finished Generate /run/flatcar/motd. Oct 28 04:31:57.974286 extend-filesystems[901]: Old size kept for /dev/vda9 Oct 28 04:31:57.967352 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 28 04:31:57.967680 systemd[1]: Finished Extend Filesystems. Oct 28 04:31:57.990692 update_engine[917]: I1028 04:31:57.990118 917 main.cc:89] Flatcar Update Engine starting Oct 28 04:31:57.990626 systemd-logind[914]: Watching system buttons on /dev/input/event0 (Power Button) Oct 28 04:31:57.991304 systemd-logind[914]: New seat seat0. Oct 28 04:31:57.994282 systemd[1]: Started Update Engine. Oct 28 04:31:57.994784 update_engine[917]: I1028 04:31:57.994621 917 update_check_scheduler.cc:74] Next update check in 2m50s Oct 28 04:31:58.008452 systemd[1]: Started Cluster reboot manager. Oct 28 04:31:58.010146 systemd[1]: Started User Login Management. Oct 28 04:31:58.036940 locksmithd[924]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 28 04:31:58.274269 systemd[1]: Created slice Slice /system/sshd. Oct 28 04:31:58.470455 sshd_keygen[919]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Oct 28 04:31:58.490248 systemd[1]: Finished Generate sshd host keys. Oct 28 04:31:58.507314 systemd[1]: Starting Generate /run/issue... Oct 28 04:31:58.509422 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54172). Oct 28 04:31:58.512216 systemd[1]: issuegen.service: Deactivated successfully. Oct 28 04:31:58.512477 systemd[1]: Finished Generate /run/issue. Oct 28 04:31:58.515059 systemd[1]: Starting Permit User Sessions... Oct 28 04:31:58.520369 systemd[1]: Finished Permit User Sessions. Oct 28 04:31:58.522892 systemd[1]: Started Getty on tty1. Oct 28 04:31:58.525541 systemd[1]: Started Serial Getty on ttyAMA0. Oct 28 04:31:58.526694 systemd[1]: Reached target Login Prompts. Oct 28 04:31:58.528704 systemd[1]: Reached target Multi-User System. Oct 28 04:31:58.531317 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 28 04:31:58.537618 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 28 04:31:58.537883 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 28 04:31:58.539087 systemd[1]: Startup finished in 721ms (kernel) + 2.418s (initrd) + 3.564s (userspace) = 6.704s. Oct 28 04:31:58.556475 sshd[940]: Accepted publickey for core from 10.0.0.1 port 54172 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:31:58.558408 sshd[940]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:31:58.573526 systemd[1]: Created slice User Slice of UID 500. Oct 28 04:31:58.574669 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 28 04:31:58.576134 systemd-logind[914]: New session 1 of user core. Oct 28 04:31:58.581409 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 28 04:31:58.582896 systemd[1]: Starting User Manager for UID 500... Oct 28 04:31:58.585443 systemd[949]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:31:58.638199 systemd[949]: Queued start job for default target Main User Target. Oct 28 04:31:58.638385 systemd[949]: Reached target Paths. Oct 28 04:31:58.638400 systemd[949]: Reached target Sockets. Oct 28 04:31:58.638411 systemd[949]: Reached target Timers. Oct 28 04:31:58.638420 systemd[949]: Reached target Basic System. Oct 28 04:31:58.638469 systemd[949]: Reached target Main User Target. Oct 28 04:31:58.638482 systemd[949]: Startup finished in 48ms. Oct 28 04:31:58.638584 systemd[1]: Started User Manager for UID 500. Oct 28 04:31:58.651109 systemd[1]: Started Session 1 of User core. Oct 28 04:31:58.712830 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54290). Oct 28 04:31:58.759742 sshd[958]: Accepted publickey for core from 10.0.0.1 port 54290 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:31:58.760891 sshd[958]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:31:58.763783 systemd-logind[914]: New session 2 of user core. Oct 28 04:31:58.776103 systemd[1]: Started Session 2 of User core. Oct 28 04:31:58.831843 sshd[958]: pam_unix(sshd:session): session closed for user core Oct 28 04:31:58.840731 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54296). Oct 28 04:31:58.841216 systemd[1]: sshd@1-10.0.0.5:22-10.0.0.1:54290.service: Deactivated successfully. Oct 28 04:31:58.842025 systemd[1]: session-2.scope: Deactivated successfully. Oct 28 04:31:58.842678 systemd-logind[914]: Session 2 logged out. Waiting for processes to exit. Oct 28 04:31:58.843366 systemd-logind[914]: Removed session 2. Oct 28 04:31:58.882953 sshd[963]: Accepted publickey for core from 10.0.0.1 port 54296 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:31:58.883994 sshd[963]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:31:58.886983 systemd-logind[914]: New session 3 of user core. Oct 28 04:31:58.898103 systemd[1]: Started Session 3 of User core. Oct 28 04:31:58.947518 sshd[963]: pam_unix(sshd:session): session closed for user core Oct 28 04:31:58.958145 systemd[1]: sshd@2-10.0.0.5:22-10.0.0.1:54296.service: Deactivated successfully. Oct 28 04:31:58.958769 systemd[1]: session-3.scope: Deactivated successfully. Oct 28 04:31:58.959415 systemd-logind[914]: Session 3 logged out. Waiting for processes to exit. Oct 28 04:31:58.960618 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54308). Oct 28 04:31:58.961149 systemd-logind[914]: Removed session 3. Oct 28 04:31:59.003864 sshd[970]: Accepted publickey for core from 10.0.0.1 port 54308 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:31:59.004943 sshd[970]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:31:59.007872 systemd-logind[914]: New session 4 of user core. Oct 28 04:31:59.014215 systemd[1]: Started Session 4 of User core. Oct 28 04:31:59.068330 sshd[970]: pam_unix(sshd:session): session closed for user core Oct 28 04:31:59.080106 systemd[1]: sshd@3-10.0.0.5:22-10.0.0.1:54308.service: Deactivated successfully. Oct 28 04:31:59.080718 systemd[1]: session-4.scope: Deactivated successfully. Oct 28 04:31:59.081393 systemd-logind[914]: Session 4 logged out. Waiting for processes to exit. Oct 28 04:31:59.082567 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58582). Oct 28 04:31:59.083333 systemd-logind[914]: Removed session 4. Oct 28 04:31:59.124850 sshd[976]: Accepted publickey for core from 10.0.0.1 port 58582 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:31:59.126307 sshd[976]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:31:59.129403 systemd-logind[914]: New session 5 of user core. Oct 28 04:31:59.142114 systemd[1]: Started Session 5 of User core. Oct 28 04:31:59.163053 systemd-networkd[835]: eth0: Gained IPv6LL Oct 28 04:31:59.200137 sudo[979]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 28 04:31:59.200366 sudo[979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:31:59.211569 sudo[979]: pam_unix(sudo:session): session closed for user root Oct 28 04:31:59.214091 sshd[976]: pam_unix(sshd:session): session closed for user core Oct 28 04:31:59.227098 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58598). Oct 28 04:31:59.228552 dbus-daemon[900]: [system] Reloaded configuration Oct 28 04:31:59.231206 systemd[1]: sshd@4-10.0.0.5:22-10.0.0.1:58582.service: Deactivated successfully. Oct 28 04:31:59.232075 systemd[1]: session-5.scope: Deactivated successfully. Oct 28 04:31:59.232858 systemd-logind[914]: Session 5 logged out. Waiting for processes to exit. Oct 28 04:31:59.233723 systemd-logind[914]: Removed session 5. Oct 28 04:31:59.270830 sshd[982]: Accepted publickey for core from 10.0.0.1 port 58598 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:31:59.272361 sshd[982]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:31:59.275395 systemd-logind[914]: New session 6 of user core. Oct 28 04:31:59.288138 systemd[1]: Started Session 6 of User core. Oct 28 04:31:59.340813 sudo[988]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 28 04:31:59.341062 sudo[988]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:31:59.343745 sudo[988]: pam_unix(sudo:session): session closed for user root Oct 28 04:31:59.347996 sudo[987]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 28 04:31:59.348218 sudo[987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:31:59.366050 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 04:31:59.365000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 28 04:31:59.367689 auditctl[991]: No rules Oct 28 04:31:59.368130 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 04:31:59.368384 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 04:31:59.369879 systemd[1]: Starting Load Security Auditing Rules... Oct 28 04:31:59.386525 augenrules[1008]: No rules Oct 28 04:31:59.387587 systemd[1]: Finished Load Security Auditing Rules. Oct 28 04:31:59.388751 sudo[987]: pam_unix(sudo:session): session closed for user root Oct 28 04:31:59.390074 sshd[982]: pam_unix(sshd:session): session closed for user core Oct 28 04:31:59.404020 systemd-logind[914]: Session 6 logged out. Waiting for processes to exit. Oct 28 04:31:59.404136 systemd[1]: sshd@5-10.0.0.5:22-10.0.0.1:58598.service: Deactivated successfully. Oct 28 04:31:59.404745 systemd[1]: session-6.scope: Deactivated successfully. Oct 28 04:31:59.406440 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58618). Oct 28 04:31:59.406831 systemd-logind[914]: Removed session 6. Oct 28 04:31:59.449047 sshd[1014]: Accepted publickey for core from 10.0.0.1 port 58618 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:31:59.450111 sshd[1014]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:31:59.453131 systemd-logind[914]: New session 7 of user core. Oct 28 04:31:59.473101 systemd[1]: Started Session 7 of User core. Oct 28 04:31:59.525421 sudo[1017]: 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 < audit_backlog_limit=64 Oct 28 04:32:02.082095 kernel: audit: type=1400 audit(1761625922.062:236): 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=0 Oct 28 04:32:02.062000 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=0 Oct 28 04:32:02.085421 kernel: audit: audit_lost=1 audit_rate_limit=0 audit_backlog_limit=64 Oct 28 04:32:02.062000 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=0 Oct 28 04:32:02.065000 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=0 Oct 28 04:32:02.065000 audit: BPF prog-id=56 op=LOAD Oct 28 04:32:02.065000 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=0 Oct 28 04:32:02.065000 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=0 Oct 28 04:32:02.065000 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=0 Oct 28 04:32:02.065000 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=0 Oct 28 04:32:02.065000 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=0 Oct 28 04:32:02.065000 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=0 Oct 28 04:32:02.065000 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=0 Oct 28 04:32:02.065000 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=0 Oct 28 04:32:02.065000 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=0 Oct 28 04:32:02.068000 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=0 Oct 28 04:32:02.068000 audit: BPF prog-id=57 op=LOAD Oct 28 04:32:02.068000 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=0 Oct 28 04:32:02.068000 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=0 Oct 28 04:32:02.068000 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=0 Oct 28 04:32:02.068000 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=0 Oct 28 04:32:02.068000 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=0 Oct 28 04:32:02.068000 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=0 Oct 28 04:32:02.068000 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=0 Oct 28 04:32:02.068000 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=0 Oct 28 04:32:02.068000 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=0 Oct 28 04:32:02.070000 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=0 Oct 28 04:32:02.070000 audit: BPF prog-id=58 op=LOAD Oct 28 04:32:02.070000 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=0 Oct 28 04:32:02.070000 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=0 Oct 28 04:32:02.070000 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=0 Oct 28 04:32:02.070000 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=0 Oct 28 04:32:02.070000 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=0 Oct 28 04:32:02.070000 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=0 Oct 28 04:32:02.070000 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=0 Oct 28 04:32:02.070000 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=0 Oct 28 04:32:02.073000 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=0 Oct 28 04:32:02.073000 audit: BPF prog-id=59 op=LOAD Oct 28 04:32:02.073000 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=0 Oct 28 04:32:02.073000 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=0 Oct 28 04:32:02.073000 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=0 Oct 28 04:32:02.073000 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=0 Oct 28 04:32:02.073000 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=0 Oct 28 04:32:02.073000 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=0 Oct 28 04:32:02.073000 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=0 Oct 28 04:32:02.073000 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=0 Oct 28 04:32:02.075000 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=0 Oct 28 04:32:02.075000 audit: BPF prog-id=60 op=LOAD Oct 28 04:32:02.075000 audit: BPF prog-id=47 op=UNLOAD Oct 28 04:32:02.075000 audit: BPF prog-id=48 op=UNLOAD Oct 28 04:32:02.075000 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=0 Oct 28 04:32:02.075000 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=0 Oct 28 04:32:02.075000 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=0 Oct 28 04:32:02.075000 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=0 Oct 28 04:32:02.075000 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=0 Oct 28 04:32:02.075000 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=0 Oct 28 04:32:02.075000 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=0 Oct 28 04:32:02.075000 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=0 Oct 28 04:32:02.075000 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=0 Oct 28 04:32:02.078000 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=0 Oct 28 04:32:02.078000 audit: BPF prog-id=61 op=LOAD Oct 28 04:32:02.078000 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=0 Oct 28 04:32:02.078000 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=0 Oct 28 04:32:02.078000 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=0 Oct 28 04:32:02.078000 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=0 Oct 28 04:32:02.078000 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=0 Oct 28 04:32:02.078000 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=0 Oct 28 04:32:02.084000 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=0 Oct 28 04:32:02.084000 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=0 Oct 28 04:32:02.084000 audit: BPF prog-id=62 op=LOAD Oct 28 04:32:02.084000 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=0 Oct 28 04:32:02.084000 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=0 Oct 28 04:32:02.084000 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=0 Oct 28 04:32:02.084000 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=0 Oct 28 04:32:02.084000 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=0 Oct 28 04:32:02.084000 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=0 Oct 28 04:32:02.084000 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=0 Oct 28 04:32:02.084000 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=0 Oct 28 04:32:02.084000 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=0 Oct 28 04:32:02.084000 audit: BPF prog-id=63 op=LOAD Oct 28 04:32:02.084000 audit: BPF prog-id=50 op=UNLOAD Oct 28 04:32:02.084000 audit: BPF prog-id=51 op=UNLOAD Oct 28 04:32:02.085000 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=0 Oct 28 04:32:02.085000 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=0 Oct 28 04:32:02.085000 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=0 Oct 28 04:32:02.085000 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=0 Oct 28 04:32:02.085000 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=0 Oct 28 04:32:02.085000 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=0 Oct 28 04:32:02.085000 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=0 Oct 28 04:32:02.085000 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=0 Oct 28 04:32:02.085000 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=0 Oct 28 04:32:02.085000 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=0 Oct 28 04:32:02.085000 audit: BPF prog-id=64 op=LOAD Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 audit: BPF prog-id=65 op=LOAD Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.088000 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=0 Oct 28 04:32:02.089000 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=0 Oct 28 04:32:02.089000 audit: BPF prog-id=66 op=LOAD Oct 28 04:32:02.089000 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=0 Oct 28 04:32:02.089000 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=0 Oct 28 04:32:02.089000 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=0 Oct 28 04:32:02.089000 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=0 Oct 28 04:32:02.089000 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=0 Oct 28 04:32:02.089000 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=0 Oct 28 04:32:02.089000 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=0 Oct 28 04:32:02.089000 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=0 Oct 28 04:32:02.089000 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=0 Oct 28 04:32:02.089000 audit: BPF prog-id=67 op=LOAD Oct 28 04:32:02.089000 audit: BPF prog-id=54 op=UNLOAD Oct 28 04:32:02.089000 audit: BPF prog-id=55 op=UNLOAD Oct 28 04:32:02.104382 sudo[1193]: pam_unix(sudo:session): session closed for user root Oct 28 04:32:02.105661 sshd[1190]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:02.116958 systemd[1]: sshd@20-10.0.0.5:22-10.0.0.1:58786.service: Deactivated successfully. Oct 28 04:32:02.117667 systemd[1]: session-21.scope: Deactivated successfully. Oct 28 04:32:02.118370 systemd-logind[914]: Session 21 logged out. Waiting for processes to exit. Oct 28 04:32:02.119593 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58798). Oct 28 04:32:02.120361 systemd-logind[914]: Removed session 21. Oct 28 04:32:02.162033 sshd[1253]: Accepted publickey for core from 10.0.0.1 port 58798 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:02.163145 sshd[1253]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:02.166100 systemd-logind[914]: New session 22 of user core. Oct 28 04:32:02.185128 systemd[1]: Started Session 22 of User core. Oct 28 04:32:02.237212 sudo[1256]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl reset-failed locksmithd.service Oct 28 04:32:02.237434 sudo[1256]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:32:02.243806 sudo[1256]: pam_unix(sudo:session): session closed for user root Oct 28 04:32:02.245061 sshd[1253]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:02.253297 systemd[1]: sshd@21-10.0.0.5:22-10.0.0.1:58798.service: Deactivated successfully. Oct 28 04:32:02.254110 systemd[1]: session-22.scope: Deactivated successfully. Oct 28 04:32:02.254801 systemd-logind[914]: Session 22 logged out. Waiting for processes to exit. Oct 28 04:32:02.256135 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58812). Oct 28 04:32:02.256825 systemd-logind[914]: Removed session 22. Oct 28 04:32:02.298187 sshd[1260]: Accepted publickey for core from 10.0.0.1 port 58812 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:02.300481 sshd[1260]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:02.303828 systemd-logind[914]: New session 23 of user core. Oct 28 04:32:02.312129 systemd[1]: Started Session 23 of User core. Oct 28 04:32:02.363959 sudo[1263]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart update-engine.service Oct 28 04:32:02.364175 sudo[1263]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:32:02.371158 systemd[1]: Stopping Update Engine... Oct 28 04:32:02.372533 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 28 04:32:02.372619 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 28 04:32:02.372937 systemd[1]: Stopped Update Engine. Oct 28 04:32:02.385282 systemd[1]: Starting Update Engine... Oct 28 04:32:02.392241 update_engine[1265]: I1028 04:32:02.392159 1265 main.cc:89] Flatcar Update Engine starting Oct 28 04:32:02.393345 systemd[1]: Started Update Engine. Oct 28 04:32:02.394067 update_engine[1265]: I1028 04:32:02.393352 1265 update_check_scheduler.cc:74] Next update check in 3m48s Oct 28 04:32:02.394229 sudo[1263]: pam_unix(sudo:session): session closed for user root Oct 28 04:32:02.395439 sshd[1260]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:02.399369 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58816). Oct 28 04:32:02.399868 systemd[1]: sshd@22-10.0.0.5:22-10.0.0.1:58812.service: Deactivated successfully. Oct 28 04:32:02.400569 systemd[1]: session-23.scope: Deactivated successfully. Oct 28 04:32:02.401293 systemd-logind[914]: Session 23 logged out. Waiting for processes to exit. Oct 28 04:32:02.402427 systemd-logind[914]: Removed session 23. Oct 28 04:32:02.441258 sshd[1267]: Accepted publickey for core from 10.0.0.1 port 58816 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:02.442790 sshd[1267]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:02.446226 systemd-logind[914]: New session 24 of user core. Oct 28 04:32:02.457158 systemd[1]: Started Session 24 of User core. Oct 28 04:32:02.512131 update_engine[1265]: I1028 04:32:02.512097 1265 dbus_service.cc:57] Attempting interactive update Oct 28 04:32:02.512131 update_engine[1265]: I1028 04:32:02.512120 1265 update_attempter.cc:275] New update check requested Oct 28 04:32:02.512481 update_engine[1265]: I1028 04:32:02.512465 1265 prefs.cc:51] aleph-version not present in /var/lib/update_engine/prefs Oct 28 04:32:02.513443 update_engine[1265]: I1028 04:32:02.513404 1265 omaha_request_params.cc:62] Current group set to developer Oct 28 04:32:02.513662 update_engine[1265]: I1028 04:32:02.513563 1265 update_attempter.cc:505] Updating boot flags... Oct 28 04:32:02.516326 sshd[1267]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:02.525728 systemd[1]: sshd@23-10.0.0.5:22-10.0.0.1:58816.service: Deactivated successfully. Oct 28 04:32:02.526353 systemd[1]: session-24.scope: Deactivated successfully. Oct 28 04:32:02.527006 systemd-logind[914]: Session 24 logged out. Waiting for processes to exit. Oct 28 04:32:02.528143 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58824). Oct 28 04:32:02.528880 systemd-logind[914]: Removed session 24. Oct 28 04:32:02.571209 sshd[1278]: Accepted publickey for core from 10.0.0.1 port 58824 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:02.572657 sshd[1278]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:02.578038 systemd-logind[914]: New session 25 of user core. Oct 28 04:32:02.583091 systemd[1]: Started Session 25 of User core. Oct 28 04:32:02.591487 update_engine[1265]: I1028 04:32:02.591444 1265 update_attempter.cc:638] Scheduling an action processor start. Oct 28 04:32:02.591487 update_engine[1265]: I1028 04:32:02.591483 1265 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 28 04:32:02.591599 update_engine[1265]: I1028 04:32:02.591537 1265 prefs.cc:51] previous-version not present in /var/lib/update_engine/prefs Oct 28 04:32:02.591621 update_engine[1265]: I1028 04:32:02.591615 1265 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.4:34567/v1/update Oct 28 04:32:02.591654 update_engine[1265]: I1028 04:32:02.591620 1265 omaha_request_action.cc:269] Request: Oct 28 04:32:02.591654 update_engine[1265]: Oct 28 04:32:02.591654 update_engine[1265]: Oct 28 04:32:02.591654 update_engine[1265]: Oct 28 04:32:02.591654 update_engine[1265]: Oct 28 04:32:02.591654 update_engine[1265]: Oct 28 04:32:02.591654 update_engine[1265]: Oct 28 04:32:02.591654 update_engine[1265]: Oct 28 04:32:02.591654 update_engine[1265]: Oct 28 04:32:02.591654 update_engine[1265]: I1028 04:32:02.591624 1265 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 28 04:32:02.593734 update_engine[1265]: I1028 04:32:02.593688 1265 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 28 04:32:02.593986 update_engine[1265]: I1028 04:32:02.593961 1265 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 28 04:32:02.595498 update_engine[1265]: I1028 04:32:02.595449 1265 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 28 04:32:02.595588 update_engine[1265]: I1028 04:32:02.595548 1265 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Oct 28 04:32:02.595588 update_engine[1265]: I1028 04:32:02.595556 1265 omaha_request_action.cc:619] Omaha request response: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.595588 update_engine[1265]: Oct 28 04:32:02.603196 update_engine[1265]: I1028 04:32:02.603163 1265 omaha_request_action.cc:447] Omaha Response manifest version = Oct 28 04:32:02.603289 update_engine[1265]: I1028 04:32:02.603202 1265 omaha_request_action.cc:470] Found 1 url(s) Oct 28 04:32:02.603289 update_engine[1265]: I1028 04:32:02.603217 1265 omaha_request_action.cc:506] Processing first of 1 package(s) Oct 28 04:32:02.603289 update_engine[1265]: I1028 04:32:02.603220 1265 omaha_request_action.cc:513] Omaha Response package name = update.gz Oct 28 04:32:02.603289 update_engine[1265]: I1028 04:32:02.603224 1265 omaha_request_action.cc:529] Url0: http://10.0.0.4:34567/packages/update.gz Oct 28 04:32:02.603289 update_engine[1265]: I1028 04:32:02.603233 1265 omaha_request_action.cc:541] Payload size = 439465725 bytes Oct 28 04:32:02.603289 update_engine[1265]: I1028 04:32:02.603243 1265 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Oct 28 04:32:02.603289 update_engine[1265]: I1028 04:32:02.603257 1265 payload_state.cc:51] Resetting all persisted state as this is a new response Oct 28 04:32:02.603289 update_engine[1265]: I1028 04:32:02.603260 1265 payload_state.cc:360] Current Response Signature = Oct 28 04:32:02.603289 update_engine[1265]: NumURLs = 1 Oct 28 04:32:02.603289 update_engine[1265]: Url0 = http://10.0.0.4:34567/packages/update.gz Oct 28 04:32:02.603289 update_engine[1265]: Payload Size = 439465725 Oct 28 04:32:02.603289 update_engine[1265]: Payload Sha256 Hash = dykyx/Y4jQdfCP1f9j5W1sV+S815EIPi4QJ65LWeHik= Oct 28 04:32:02.603289 update_engine[1265]: Is Delta Payload = 0 Oct 28 04:32:02.603289 update_engine[1265]: Max Failure Count Per Url = 10 Oct 28 04:32:02.603289 update_engine[1265]: Disable Payload Backoff = 1 Oct 28 04:32:02.603547 update_engine[1265]: I1028 04:32:02.603353 1265 payload_state.cc:381] Payload Attempt Number = 0 Oct 28 04:32:02.603547 update_engine[1265]: I1028 04:32:02.603387 1265 payload_state.cc:404] Current URL Index = 0 Oct 28 04:32:02.603547 update_engine[1265]: I1028 04:32:02.603416 1265 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Oct 28 04:32:02.603547 update_engine[1265]: I1028 04:32:02.603444 1265 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Oct 28 04:32:02.603547 update_engine[1265]: I1028 04:32:02.603449 1265 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 28 04:32:02.603547 update_engine[1265]: I1028 04:32:02.603483 1265 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Oct 28 04:32:02.603547 update_engine[1265]: I1028 04:32:02.603502 1265 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Oct 28 04:32:02.603547 update_engine[1265]: I1028 04:32:02.603507 1265 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Oct 28 04:32:02.603547 update_engine[1265]: I1028 04:32:02.603523 1265 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Oct 28 04:32:02.603547 update_engine[1265]: E1028 04:32:02.603528 1265 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Oct 28 04:32:02.604057 update_engine[1265]: I1028 04:32:02.604036 1265 omaha_response_handler_action.cc:85] Using this install plan: Oct 28 04:32:02.604057 update_engine[1265]: I1028 04:32:02.604048 1265 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.4:34567/packages/update.gz, payload size: 439465725, payload hash: dykyx/Y4jQdfCP1f9j5W1sV+S815EIPi4QJ65LWeHik=, partition_path: /dev/vda4, kernel_path: /boot/flatcar/vmlinuz-b, pcr_policy_path: /var/lib/update_engine/pcrs-b.zip, old_partition_path: /dev/vda3, old_kernel_path: /boot/flatcar/vmlinuz-a Oct 28 04:32:02.604147 update_engine[1265]: I1028 04:32:02.604130 1265 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Oct 28 04:32:02.605181 update_engine[1265]: I1028 04:32:02.605155 1265 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Oct 28 04:32:02.654118 sshd[1278]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:02.656841 systemd[1]: sshd@24-10.0.0.5:22-10.0.0.1:58824.service: Deactivated successfully. Oct 28 04:32:02.657490 systemd[1]: session-25.scope: Deactivated successfully. Oct 28 04:32:02.658880 systemd-logind[914]: Session 25 logged out. Waiting for processes to exit. Oct 28 04:32:02.660156 systemd-logind[914]: Removed session 25. Oct 28 04:32:04.401338 update_engine[1265]: I1028 04:32:04.401304 1265 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Oct 28 04:32:04.401731 update_engine[1265]: I1028 04:32:04.401715 1265 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Oct 28 04:32:04.460151 update_engine[1265]: E1028 04:32:04.460108 1265 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Oct 28 04:32:04.460289 update_engine[1265]: I1028 04:32:04.460279 1265 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Oct 28 04:32:04.460334 update_engine[1265]: I1028 04:32:04.460325 1265 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Oct 28 04:32:04.460382 update_engine[1265]: I1028 04:32:04.460371 1265 update_attempter.cc:302] Processing Done. Oct 28 04:32:04.460482 update_engine[1265]: E1028 04:32:04.460472 1265 update_attempter.cc:615] Update failed. Oct 28 04:32:04.460529 update_engine[1265]: I1028 04:32:04.460518 1265 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Oct 28 04:32:04.460589 update_engine[1265]: I1028 04:32:04.460578 1265 payload_state.cc:276] Incrementing the URL failure count Oct 28 04:32:04.460636 update_engine[1265]: I1028 04:32:04.460626 1265 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 28 04:32:04.460882 update_engine[1265]: I1028 04:32:04.460852 1265 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 28 04:32:04.460987 update_engine[1265]: I1028 04:32:04.460975 1265 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.4:34567/v1/update Oct 28 04:32:04.461035 update_engine[1265]: I1028 04:32:04.461024 1265 omaha_request_action.cc:269] Request: Oct 28 04:32:04.461035 update_engine[1265]: Oct 28 04:32:04.461035 update_engine[1265]: Oct 28 04:32:04.461035 update_engine[1265]: Oct 28 04:32:04.461035 update_engine[1265]: Oct 28 04:32:04.461035 update_engine[1265]: Oct 28 04:32:04.461035 update_engine[1265]: Oct 28 04:32:04.461185 update_engine[1265]: I1028 04:32:04.461174 1265 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 28 04:32:04.461287 update_engine[1265]: I1028 04:32:04.461275 1265 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 28 04:32:04.461463 update_engine[1265]: I1028 04:32:04.461447 1265 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 28 04:32:04.664736 update_engine[1265]: I1028 04:32:04.664577 1265 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 28 04:32:04.664736 update_engine[1265]: I1028 04:32:04.664666 1265 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Oct 28 04:32:04.664736 update_engine[1265]: I1028 04:32:04.664677 1265 omaha_request_action.cc:619] Omaha request response: Oct 28 04:32:04.664736 update_engine[1265]: Oct 28 04:32:04.664736 update_engine[1265]: Oct 28 04:32:04.664736 update_engine[1265]: Oct 28 04:32:04.664736 update_engine[1265]: Oct 28 04:32:04.664736 update_engine[1265]: Oct 28 04:32:04.664736 update_engine[1265]: Oct 28 04:32:04.664736 update_engine[1265]: E1028 04:32:04.664690 1265 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Oct 28 04:32:04.664736 update_engine[1265]: I1028 04:32:04.664695 1265 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 28 04:32:04.664736 update_engine[1265]: I1028 04:32:04.664698 1265 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 28 04:32:04.664736 update_engine[1265]: I1028 04:32:04.664701 1265 update_attempter.cc:302] Processing Done. Oct 28 04:32:04.664736 update_engine[1265]: I1028 04:32:04.664705 1265 update_attempter.cc:306] Error event sent. Oct 28 04:32:12.740771 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53538). Oct 28 04:32:12.787440 sshd[1299]: Accepted publickey for core from 10.0.0.1 port 53538 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:12.788734 sshd[1299]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:12.789160 kernel: kauditd_printk_skb: 128 callbacks suppressed Oct 28 04:32:12.789201 kernel: audit: type=1006 audit(1761625932.787:364): pid=1299 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=26 res=1 Oct 28 04:32:12.791695 systemd-logind[914]: New session 26 of user core. Oct 28 04:32:12.802106 systemd[1]: Started Session 26 of User core. Oct 28 04:32:12.860292 sshd[1299]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:12.873067 systemd[1]: sshd@25-10.0.0.5:22-10.0.0.1:53538.service: Deactivated successfully. Oct 28 04:32:12.874088 systemd[1]: session-26.scope: Deactivated successfully. Oct 28 04:32:12.874778 systemd-logind[914]: Session 26 logged out. Waiting for processes to exit. Oct 28 04:32:12.875847 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53550). Oct 28 04:32:12.876832 systemd-logind[914]: Removed session 26. Oct 28 04:32:12.917757 sshd[1306]: Accepted publickey for core from 10.0.0.1 port 53550 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:12.918737 sshd[1306]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:12.920922 kernel: audit: type=1006 audit(1761625932.916:365): pid=1306 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=27 res=1 Oct 28 04:32:12.921684 systemd-logind[914]: New session 27 of user core. Oct 28 04:32:12.933062 systemd[1]: Started Session 27 of User core. Oct 28 04:32:12.993969 sshd[1306]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:13.004191 systemd[1]: sshd@26-10.0.0.5:22-10.0.0.1:53550.service: Deactivated successfully. Oct 28 04:32:13.004939 systemd[1]: session-27.scope: Deactivated successfully. Oct 28 04:32:13.005716 systemd-logind[914]: Session 27 logged out. Waiting for processes to exit. Oct 28 04:32:13.007087 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53566). Oct 28 04:32:13.007860 systemd-logind[914]: Removed session 27. Oct 28 04:32:13.048441 sshd[1314]: Accepted publickey for core from 10.0.0.1 port 53566 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:13.051911 kernel: audit: type=1006 audit(1761625933.048:366): pid=1314 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=28 res=1 Oct 28 04:32:13.051920 sshd[1314]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:13.054779 systemd-logind[914]: New session 28 of user core. Oct 28 04:32:13.067078 systemd[1]: Started Session 28 of User core. Oct 28 04:32:13.116660 sshd[1314]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:13.128620 systemd[1]: sshd@27-10.0.0.5:22-10.0.0.1:53566.service: Deactivated successfully. Oct 28 04:32:13.129335 systemd[1]: session-28.scope: Deactivated successfully. Oct 28 04:32:13.130035 systemd-logind[914]: Session 28 logged out. Waiting for processes to exit. Oct 28 04:32:13.131314 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53582). Oct 28 04:32:13.132059 systemd-logind[914]: Removed session 28. Oct 28 04:32:13.174867 sshd[1320]: Accepted publickey for core from 10.0.0.1 port 53582 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:13.176673 sshd[1320]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:13.178586 kernel: audit: type=1006 audit(1761625933.174:367): pid=1320 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=29 res=1 Oct 28 04:32:13.181452 systemd-logind[914]: New session 29 of user core. Oct 28 04:32:13.191074 systemd[1]: Started Session 29 of User core. Oct 28 04:32:13.240935 sshd[1320]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:13.254652 systemd[1]: sshd@28-10.0.0.5:22-10.0.0.1:53582.service: Deactivated successfully. Oct 28 04:32:13.255233 systemd[1]: session-29.scope: Deactivated successfully. Oct 28 04:32:13.255937 systemd-logind[914]: Session 29 logged out. Waiting for processes to exit. Oct 28 04:32:13.258158 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53592). Oct 28 04:32:13.258759 systemd-logind[914]: Removed session 29. Oct 28 04:32:13.301612 sshd[1326]: Accepted publickey for core from 10.0.0.1 port 53592 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:13.302609 sshd[1326]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:13.304923 kernel: audit: type=1006 audit(1761625933.301:368): pid=1326 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=30 res=1 Oct 28 04:32:13.306389 systemd-logind[914]: New session 30 of user core. Oct 28 04:32:13.319077 systemd[1]: Started Session 30 of User core. Oct 28 04:32:13.370226 sudo[1330]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Oct 28 04:32:13.370439 sudo[1330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:32:13.376553 systemd[1]: sshd.socket: Deactivated successfully. Oct 28 04:32:13.376983 systemd[1]: Closed OpenSSH Server Socket. Oct 28 04:32:13.378073 sudo[1330]: pam_unix(sudo:session): session closed for user root Oct 28 04:32:13.381800 sudo[1329]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Oct 28 04:32:13.382027 sudo[1329]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:32:13.396676 systemd[1]: Stopping Session 1 of User core... Oct 28 04:32:13.397077 sshd[940]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:13.397947 systemd[1]: Stopping Session 30 of User core... Oct 28 04:32:13.398499 sudo[1329]: pam_unix(sudo:session): session closed for user root Oct 28 04:32:13.398962 sshd[1326]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:13.399171 systemd[1]: Removed slice Slice /system/addon-config. Oct 28 04:32:13.400605 systemd[1]: Removed slice Slice /system/addon-run. Oct 28 04:32:13.401943 systemd[1]: Removed slice Slice /system/modprobe. Oct 28 04:32:13.403193 systemd[1]: Removed slice Slice /system/system-cloudinit. Oct 28 04:32:13.404335 systemd[1]: Stopped target Multi-User System. Oct 28 04:32:13.405281 systemd[1]: Stopped target Login Prompts. Oct 28 04:32:13.406165 systemd[1]: Stopped target Containers. Oct 28 04:32:13.407004 systemd[1]: Stopped target Host and Network Name Lookups. Oct 28 04:32:13.408153 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 04:32:13.409298 systemd[1]: Stopped target Timer Units. Oct 28 04:32:13.410106 systemd[1]: logrotate.timer: Deactivated successfully. Oct 28 04:32:13.410152 systemd[1]: Stopped Daily Log Rotation. Oct 28 04:32:13.410967 systemd[1]: mdadm.timer: Deactivated successfully. Oct 28 04:32:13.411007 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Oct 28 04:32:13.412155 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Oct 28 04:32:13.412199 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Oct 28 04:32:13.413277 systemd[1]: Stopped target System Time Set. Oct 28 04:32:13.414336 systemd[1]: Stopped target Load user-provided cloud configs. Oct 28 04:32:13.415442 systemd[1]: Stopped target Load system-provided cloud configs. Oct 28 04:32:13.416557 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 28 04:32:13.416662 systemd[1]: Closed Process Core Dump Socket. Oct 28 04:32:13.418387 systemd[1]: Unmounting Boot partition... Oct 28 04:32:13.419465 systemd[1]: Stopping Getty on tty1... Oct 28 04:32:13.420415 systemd[1]: Stopping Serial Getty on ttyAMA0... Oct 28 04:32:13.422207 systemd[1]: Stopping OpenSSH per-connection server daemon... Oct 28 04:32:13.423325 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:53592)... Oct 28 04:32:13.423449 sshd[1326]: pam_systemd(sshd:session): Failed to release session: Interrupted system call Oct 28 04:32:13.424497 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Oct 28 04:32:13.424651 systemd[1]: Stopped Commit a transient machine-id on disk. Oct 28 04:32:13.425879 systemd[1]: Stopped target First Boot Complete. Oct 28 04:32:13.427964 systemd[1]: Stopping Load/Save Random Seed... Oct 28 04:32:13.428922 systemd[1]: Stopping Update Engine... Oct 28 04:32:13.432173 systemd[1]: sshd@0-10.0.0.5:22-10.0.0.1:54172.service: Deactivated successfully. Oct 28 04:32:13.432409 systemd[1]: Stopped OpenSSH per-connection server daemon. Oct 28 04:32:13.434247 systemd[1]: getty@tty1.service: Deactivated successfully. Oct 28 04:32:13.434458 systemd[1]: Stopped Getty on tty1. Oct 28 04:32:13.435703 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Oct 28 04:32:13.435901 systemd[1]: Stopped Serial Getty on ttyAMA0. Oct 28 04:32:13.437223 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 28 04:32:13.437298 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 28 04:32:13.437576 systemd[1]: Stopped Update Engine. Oct 28 04:32:13.438437 systemd[1]: update-engine.service: Consumed 2.423s CPU time. Oct 28 04:32:13.438717 systemd[1]: sshd@29-10.0.0.5:22-10.0.0.1:53592.service: Deactivated successfully. Oct 28 04:32:13.438927 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:53592). Oct 28 04:32:13.453522 systemd[1]: boot.mount: Deactivated successfully. Oct 28 04:32:13.453808 systemd[1]: Unmounted Boot partition. Oct 28 04:32:13.455177 systemd[1]: systemd-random-seed.service: Deactivated successfully. Oct 28 04:32:13.455411 systemd[1]: Stopped Load/Save Random Seed. Oct 28 04:32:13.456527 systemd[1]: session-30.scope: Deactivated successfully. Oct 28 04:32:13.456759 systemd[1]: Stopped Session 30 of User core. Oct 28 04:32:13.457862 systemd[1]: session-1.scope: Deactivated successfully. Oct 28 04:32:13.458120 systemd[1]: Stopped Session 1 of User core. Oct 28 04:32:13.459339 systemd-logind[914]: Session 1 logged out. Waiting for processes to exit. Oct 28 04:32:13.460656 systemd-logind[914]: Session 30 logged out. Waiting for processes to exit. Oct 28 04:32:13.461228 systemd[1]: Removed slice Slice /system/getty. Oct 28 04:32:13.462727 systemd[1]: Removed slice Slice /system/serial-getty. Oct 28 04:32:13.464204 systemd[1]: Removed slice Slice /system/sshd. Oct 28 04:32:13.465227 systemd[1]: sshd-keygen.service: Deactivated successfully. Oct 28 04:32:13.465438 systemd[1]: Stopped Generate sshd host keys. Oct 28 04:32:13.466868 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Oct 28 04:32:13.467083 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Oct 28 04:32:13.468707 systemd[1]: Stopping User Login Management... Oct 28 04:32:13.469692 systemd[1]: Stopping User Manager for UID 500... Oct 28 04:32:13.470577 systemd[949]: Stopped target Main User Target. Oct 28 04:32:13.470597 systemd[949]: Stopped target Basic System. Oct 28 04:32:13.470608 systemd[949]: Stopped target Paths. Oct 28 04:32:13.470615 systemd[949]: Stopped target Sockets. Oct 28 04:32:13.470633 systemd[949]: Reached target Shutdown. Oct 28 04:32:13.470640 systemd[949]: Stopped target Timers. Oct 28 04:32:13.470752 systemd[949]: Finished Exit the Session. Oct 28 04:32:13.470776 systemd[949]: Reached target Exit the Session. Oct 28 04:32:13.471905 systemd-logind[914]: Removed session 30. Oct 28 04:32:13.473026 systemd[1]: user@500.service: Deactivated successfully. Oct 28 04:32:13.473212 systemd[1]: Stopped User Manager for UID 500. Oct 28 04:32:13.475514 systemd[1]: Stopping User Runtime Directory /run/user/500... Oct 28 04:32:13.481221 systemd[1]: run-user-500.mount: Deactivated successfully. Oct 28 04:32:13.481297 systemd[1]: Unmounted /run/user/500. Oct 28 04:32:13.482632 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Oct 28 04:32:13.482882 systemd[1]: Stopped User Runtime Directory /run/user/500. Oct 28 04:32:13.484708 systemd[1]: Removed slice User Slice of UID 500. Oct 28 04:32:13.487003 systemd[1]: Stopping D-Bus System Message Bus... Oct 28 04:32:13.488917 systemd[1]: Stopping Permit User Sessions... Oct 28 04:32:13.490267 systemd[1]: systemd-logind.service: Deactivated successfully. Oct 28 04:32:13.490574 systemd[1]: Stopped User Login Management. Oct 28 04:32:13.492105 systemd[1]: dbus.service: Deactivated successfully. Oct 28 04:32:13.492356 systemd[1]: Stopped D-Bus System Message Bus. Oct 28 04:32:13.493798 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Oct 28 04:32:13.494055 systemd[1]: Stopped Permit User Sessions. Oct 28 04:32:13.494970 systemd[1]: Stopped target Basic System. Oct 28 04:32:13.495820 systemd[1]: Stopped target Network. Oct 28 04:32:13.496709 systemd[1]: Stopped target Path Units. Oct 28 04:32:13.497558 systemd[1]: motdgen.path: Deactivated successfully. Oct 28 04:32:13.499007 systemd[1]: Stopped Watch for update engine configuration changes. Oct 28 04:32:13.500082 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Oct 28 04:32:13.503953 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 04:32:13.505192 systemd[1]: Stopped target Remote File Systems. Oct 28 04:32:13.506021 systemd[1]: Stopped target Slice Units. Oct 28 04:32:13.508000 audit: BPF prog-id=58 op=UNLOAD Oct 28 04:32:13.510206 systemd[1]: Removed slice User and Session Slice. Oct 28 04:32:13.511919 kernel: audit: type=1334 audit(1761625933.508:369): prog-id=58 op=UNLOAD Oct 28 04:32:13.511970 systemd[1]: Stopped target Socket Units. Oct 28 04:32:13.512866 systemd[1]: dbus.socket: Deactivated successfully. Oct 28 04:32:13.512974 systemd[1]: Closed D-Bus System Message Bus Socket. Oct 28 04:32:13.514087 systemd[1]: docker.socket: Deactivated successfully. Oct 28 04:32:13.514353 systemd[1]: Closed Docker Socket for the API. Oct 28 04:32:13.515293 systemd[1]: Stopped target System Initialization. Oct 28 04:32:13.516302 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Oct 28 04:32:13.516438 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Oct 28 04:32:13.518498 systemd[1]: Stopped target Local Verity Protected Volumes. Oct 28 04:32:13.520593 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 04:32:13.522842 systemd[1]: Stopping Network Name Resolution... Oct 28 04:32:13.522957 auditctl[1346]: No rules Oct 28 04:32:13.523796 systemd[1]: Stopping Network Time Synchronization... Oct 28 04:32:13.524628 systemd[1]: systemd-update-done.service: Deactivated successfully. Oct 28 04:32:13.524711 systemd[1]: Stopped Update is Completed. Oct 28 04:32:13.525591 systemd[1]: ldconfig.service: Deactivated successfully. Oct 28 04:32:13.525664 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Oct 28 04:32:13.526647 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Oct 28 04:32:13.526708 systemd[1]: Stopped Rebuild Hardware Database. Oct 28 04:32:13.527635 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Oct 28 04:32:13.527700 systemd[1]: Stopped Rebuild Journal Catalog. Oct 28 04:32:13.529544 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Oct 28 04:32:13.532366 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 28 04:32:13.532636 systemd[1]: Stopped Network Name Resolution. Oct 28 04:32:13.533812 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Oct 28 04:32:13.534083 systemd[1]: Stopped Network Time Synchronization. Oct 28 04:32:13.535378 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 04:32:13.535601 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 04:32:13.538023 systemd[1]: Stopping Network Configuration... Oct 28 04:32:13.539073 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Oct 28 04:32:13.539303 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Oct 28 04:32:13.539000 audit: BPF prog-id=56 op=UNLOAD Oct 28 04:32:13.541911 kernel: audit: type=1334 audit(1761625933.539:370): prog-id=56 op=UNLOAD Oct 28 04:32:13.542094 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 28 04:32:13.542198 systemd[1]: Stopped Create Volatile Files and Directories. Oct 28 04:32:13.542000 audit: BPF prog-id=64 op=UNLOAD Oct 28 04:32:13.544191 systemd[1]: Stopped target Local File Systems. Oct 28 04:32:13.544916 kernel: audit: type=1334 audit(1761625933.542:371): prog-id=64 op=UNLOAD Oct 28 04:32:13.545968 systemd-networkd[835]: eth0: DHCPv6 lease lost Oct 28 04:32:13.546279 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Oct 28 04:32:13.548066 systemd[1]: Unmounting External Media Directory... Oct 28 04:32:13.550135 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Oct 28 04:32:13.552182 systemd[1]: Unmounting /run/torcx/unpack... Oct 28 04:32:13.553498 systemd[1]: Unmounting Temporary Directory /tmp... Oct 28 04:32:13.554973 systemd[1]: Unmounting /usr/share/oem... Oct 28 04:32:13.556615 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Oct 28 04:32:13.559721 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 28 04:32:13.560020 systemd[1]: Stopped Network Configuration. Oct 28 04:32:13.561149 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 28 04:32:13.561405 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Oct 28 04:32:13.562810 systemd[1]: media.mount: Deactivated successfully. Oct 28 04:32:13.563091 systemd[1]: Unmounted External Media Directory. Oct 28 04:32:13.574121 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Oct 28 04:32:13.574408 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Oct 28 04:32:13.575948 systemd[1]: tmp.mount: Deactivated successfully. Oct 28 04:32:13.576215 systemd[1]: Unmounted Temporary Directory /tmp. Oct 28 04:32:13.577335 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Oct 28 04:32:13.577580 systemd[1]: Unmounted /run/torcx/unpack. Oct 28 04:32:13.578721 systemd[1]: usr-share-oem.mount: Deactivated successfully. Oct 28 04:32:13.579018 systemd[1]: Unmounted /usr/share/oem. Oct 28 04:32:13.579944 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 28 04:32:13.580187 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Oct 28 04:32:13.580000 audit: BPF prog-id=57 op=UNLOAD Oct 28 04:32:13.581735 systemd[1]: Stopped target Swaps. Oct 28 04:32:13.583330 kernel: audit: type=1334 audit(1761625933.580:372): prog-id=57 op=UNLOAD Oct 28 04:32:13.583499 systemd[1]: Reached target Unmount All Filesystems. Oct 28 04:32:13.584584 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 28 04:32:13.584724 systemd[1]: Closed Network Service Netlink Socket. Oct 28 04:32:13.585763 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Oct 28 04:32:13.585944 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Oct 28 04:32:13.587422 systemd[1]: Removed slice Slice /system/systemd-fsck. Oct 28 04:32:13.588542 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 04:32:13.589801 systemd[1]: lvm2-activation.service: Deactivated successfully. Oct 28 04:32:13.589986 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 28 04:32:13.591327 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 04:32:13.592421 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 04:32:13.592601 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 04:32:13.593935 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Oct 28 04:32:13.596948 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Oct 28 04:32:13.598368 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Oct 28 04:32:13.598523 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 28 04:32:13.599680 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 04:32:13.599817 systemd[1]: Stopped Apply Kernel Variables. Oct 28 04:32:13.600819 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 04:32:13.600986 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 04:32:13.602102 systemd[1]: systemd-sysusers.service: Deactivated successfully. Oct 28 04:32:13.602234 systemd[1]: Stopped Create System Users. Oct 28 04:32:13.603216 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Oct 28 04:32:13.603351 systemd[1]: Stopped Remount Root and Kernel File Systems. Oct 28 04:32:13.604514 systemd[1]: Reached target System Shutdown. Oct 28 04:32:13.605510 systemd[1]: Reached target Late Shutdown Services. Oct 28 04:32:13.606779 systemd[1]: systemd-reboot.service: Deactivated successfully. Oct 28 04:32:13.606941 systemd[1]: Finished System Reboot. Oct 28 04:32:13.607764 systemd[1]: Reached target System Reboot. Oct 28 04:32:13.608753 systemd[1]: Shutting down. Oct 28 04:32:13.611000 audit: BPF prog-id=60 op=UNLOAD Oct 28 04:32:13.611000 audit: BPF prog-id=59 op=UNLOAD Oct 28 04:32:13.611000 audit: BPF prog-id=63 op=UNLOAD Oct 28 04:32:13.611000 audit: BPF prog-id=62 op=UNLOAD Oct 28 04:32:13.611000 audit: BPF prog-id=61 op=UNLOAD Oct 28 04:32:13.613921 kernel: audit: type=1334 audit(1761625933.611:373): prog-id=60 op=UNLOAD Oct 28 04:32:13.615000 audit: BPF prog-id=67 op=UNLOAD Oct 28 04:32:13.615000 audit: BPF prog-id=66 op=UNLOAD Oct 28 04:32:13.615000 audit: BPF prog-id=65 op=UNLOAD Oct 28 04:32:13.639904 systemd-shutdown[1]: Syncing filesystems and block devices. Oct 28 04:32:13.646787 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Oct 28 04:32:13.646854 systemd-journald[798]: Journal stopped -- Reboot -- Oct 28 04:32:21.677380 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 28 04:32:21.677397 kernel: Linux version 5.10.107-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo 9.3.0-r1 p3) 9.3.0, GNU ld (Gentoo 2.36.1 p5) 2.36.1) #1 SMP PREEMPT Tue Mar 22 19:39:09 -00 2022 Oct 28 04:32:21.677405 kernel: efi: EFI v2.70 by EDK II Oct 28 04:32:21.677410 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 28 04:32:21.677415 kernel: efi: seeding entropy pool Oct 28 04:32:21.677420 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 28 04:32:21.677426 kernel: ACPI: Early table checksum verification disabled Oct 28 04:32:21.677431 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 28 04:32:21.677436 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 28 04:32:21.677441 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:32:21.677447 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:32:21.677452 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:32:21.677458 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:32:21.677463 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:32:21.677469 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:32:21.677474 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:32:21.677481 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:32:21.677486 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:32:21.677491 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 28 04:32:21.677496 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 28 04:32:21.677502 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:32:21.677507 kernel: NUMA: NODE_DATA [mem 0xdc959900-0xdc95efff] Oct 28 04:32:21.677512 kernel: Zone ranges: Oct 28 04:32:21.677517 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:32:21.677522 kernel: DMA32 empty Oct 28 04:32:21.677527 kernel: Normal empty Oct 28 04:32:21.677532 kernel: Movable zone start for each node Oct 28 04:32:21.677539 kernel: Early memory node ranges Oct 28 04:32:21.677545 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 28 04:32:21.677550 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 28 04:32:21.677555 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 28 04:32:21.677560 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 28 04:32:21.677566 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 28 04:32:21.677571 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 28 04:32:21.677576 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 28 04:32:21.677581 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 28 04:32:21.677586 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 28 04:32:21.677591 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 28 04:32:21.677596 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 28 04:32:21.677602 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:32:21.677610 kernel: On node 0 totalpages: 643072 Oct 28 04:32:21.677616 kernel: DMA zone: 10048 pages used for memmap Oct 28 04:32:21.677621 kernel: DMA zone: 0 pages reserved Oct 28 04:32:21.677627 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 28 04:32:21.677632 kernel: psci: probing for conduit method from ACPI. Oct 28 04:32:21.677637 kernel: psci: PSCIv1.1 detected in firmware. Oct 28 04:32:21.677643 kernel: psci: Using standard PSCI v0.2 function IDs Oct 28 04:32:21.677648 kernel: psci: Trusted OS migration not required Oct 28 04:32:21.677655 kernel: psci: SMC Calling Convention v1.1 Oct 28 04:32:21.677660 kernel: ACPI: SRAT not present Oct 28 04:32:21.677666 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 28 04:32:21.677671 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 28 04:32:21.677677 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 28 04:32:21.677682 kernel: Detected PIPT I-cache on CPU0 Oct 28 04:32:21.677688 kernel: CPU features: detected: GIC system register CPU interface Oct 28 04:32:21.677693 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 28 04:32:21.677699 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 28 04:32:21.677704 kernel: CPU features: detected: Hardware dirty bit management Oct 28 04:32:21.677709 kernel: CPU features: detected: Spectre-v4 Oct 28 04:32:21.677716 kernel: CPU features: detected: ARM erratum 1418040 Oct 28 04:32:21.677721 kernel: CPU features: detected: Spectre-BHB Oct 28 04:32:21.677727 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 28 04:32:21.677732 kernel: Policy zone: DMA Oct 28 04:32:21.677739 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 28 04:32:21.677744 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 28 04:32:21.677750 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 28 04:32:21.677755 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 28 04:32:21.677761 kernel: Memory: 2452096K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120192K reserved, 0K cma-reserved) Oct 28 04:32:21.677767 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 28 04:32:21.677786 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 28 04:32:21.677794 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 28 04:32:21.677807 kernel: rcu: RCU event tracing is enabled. Oct 28 04:32:21.677813 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 28 04:32:21.677819 kernel: Trampoline variant of Tasks RCU enabled. Oct 28 04:32:21.677824 kernel: Tracing variant of Tasks RCU enabled. Oct 28 04:32:21.677830 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 28 04:32:21.677836 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 28 04:32:21.677841 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 28 04:32:21.677847 kernel: GICv3: 256 SPIs implemented Oct 28 04:32:21.677852 kernel: GICv3: 0 Extended SPIs implemented Oct 28 04:32:21.677858 kernel: GICv3: Distributor has no Range Selector support Oct 28 04:32:21.677863 kernel: GICv3: 16 PPIs implemented Oct 28 04:32:21.677872 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 28 04:32:21.677878 kernel: ACPI: SRAT not present Oct 28 04:32:21.677883 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 28 04:32:21.677889 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 28 04:32:21.677894 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 28 04:32:21.677900 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 28 04:32:21.677906 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 28 04:32:21.677912 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:32:21.677918 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 28 04:32:21.677924 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 28 04:32:21.677930 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 28 04:32:21.677936 kernel: arm-pv: using stolen time PV Oct 28 04:32:21.677943 kernel: Console: colour dummy device 80x25 Oct 28 04:32:21.677948 kernel: ACPI: Core revision 20200925 Oct 28 04:32:21.677954 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 28 04:32:21.677960 kernel: pid_max: default: 32768 minimum: 301 Oct 28 04:32:21.677966 kernel: LSM: Security Framework initializing Oct 28 04:32:21.677971 kernel: SELinux: Initializing. Oct 28 04:32:21.677977 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:32:21.677983 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:32:21.677989 kernel: rcu: Hierarchical SRCU implementation. Oct 28 04:32:21.677996 kernel: Platform MSI: ITS@0x8080000 domain created Oct 28 04:32:21.678002 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 28 04:32:21.678007 kernel: Remapping and enabling EFI services. Oct 28 04:32:21.678013 kernel: smp: Bringing up secondary CPUs ... Oct 28 04:32:21.678019 kernel: Detected PIPT I-cache on CPU1 Oct 28 04:32:21.678024 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 28 04:32:21.678030 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 28 04:32:21.678036 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:32:21.678042 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 28 04:32:21.678047 kernel: Detected PIPT I-cache on CPU2 Oct 28 04:32:21.678055 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 28 04:32:21.678061 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 28 04:32:21.678066 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:32:21.678072 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 28 04:32:21.678078 kernel: Detected PIPT I-cache on CPU3 Oct 28 04:32:21.678088 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 28 04:32:21.678094 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 28 04:32:21.678102 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:32:21.678108 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 28 04:32:21.678114 kernel: smp: Brought up 1 node, 4 CPUs Oct 28 04:32:21.678120 kernel: SMP: Total of 4 processors activated. Oct 28 04:32:21.678126 kernel: CPU features: detected: Privileged Access Never Oct 28 04:32:21.678132 kernel: CPU features: detected: LSE atomic instructions Oct 28 04:32:21.678138 kernel: CPU features: detected: User Access Override Oct 28 04:32:21.678146 kernel: CPU features: detected: 32-bit EL0 Support Oct 28 04:32:21.678188 kernel: CPU features: detected: Common not Private translations Oct 28 04:32:21.678195 kernel: CPU features: detected: RAS Extension Support Oct 28 04:32:21.678204 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 28 04:32:21.678210 kernel: CPU features: detected: CRC32 instructions Oct 28 04:32:21.678216 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 28 04:32:21.678222 kernel: CPU: All CPU(s) started at EL1 Oct 28 04:32:21.678228 kernel: alternatives: patching kernel code Oct 28 04:32:21.678253 kernel: devtmpfs: initialized Oct 28 04:32:21.678259 kernel: KASLR enabled Oct 28 04:32:21.678265 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 28 04:32:21.678272 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 28 04:32:21.678281 kernel: pinctrl core: initialized pinctrl subsystem Oct 28 04:32:21.678287 kernel: SMBIOS 3.0.0 present. Oct 28 04:32:21.678294 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 28 04:32:21.678300 kernel: NET: Registered protocol family 16 Oct 28 04:32:21.678306 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 28 04:32:21.678312 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 28 04:32:21.678320 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 28 04:32:21.678326 kernel: audit: initializing netlink subsys (disabled) Oct 28 04:32:21.678346 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Oct 28 04:32:21.678353 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 28 04:32:21.678359 kernel: cpuidle: using governor menu Oct 28 04:32:21.678365 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 28 04:32:21.678372 kernel: ASID allocator initialised with 32768 entries Oct 28 04:32:21.678385 kernel: ACPI: bus type PCI registered Oct 28 04:32:21.678393 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 28 04:32:21.678400 kernel: Serial: AMBA PL011 UART driver Oct 28 04:32:21.678406 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 28 04:32:21.678412 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 28 04:32:21.678418 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 28 04:32:21.678424 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 28 04:32:21.678430 kernel: cryptd: max_cpu_qlen set to 1000 Oct 28 04:32:21.678436 kernel: ACPI: Added _OSI(Module Device) Oct 28 04:32:21.678442 kernel: ACPI: Added _OSI(Processor Device) Oct 28 04:32:21.678448 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 28 04:32:21.678455 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 28 04:32:21.678461 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 28 04:32:21.678467 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 28 04:32:21.678474 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 28 04:32:21.678480 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 28 04:32:21.678486 kernel: ACPI: Interpreter enabled Oct 28 04:32:21.678491 kernel: ACPI: Using GIC for interrupt routing Oct 28 04:32:21.678498 kernel: ACPI: MCFG table detected, 1 entries Oct 28 04:32:21.678504 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 28 04:32:21.678510 kernel: printk: console [ttyAMA0] enabled Oct 28 04:32:21.678517 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 28 04:32:21.678629 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 28 04:32:21.678689 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 28 04:32:21.678743 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 28 04:32:21.678825 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 28 04:32:21.678881 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 28 04:32:21.678889 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 28 04:32:21.678897 kernel: PCI host bridge to bus 0000:00 Oct 28 04:32:21.678960 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 28 04:32:21.679013 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 28 04:32:21.679063 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 28 04:32:21.679113 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 28 04:32:21.679183 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 28 04:32:21.679247 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 28 04:32:21.679310 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 28 04:32:21.679368 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 28 04:32:21.679430 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 04:32:21.679490 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 04:32:21.679550 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 28 04:32:21.679606 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 28 04:32:21.679656 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 28 04:32:21.679706 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 28 04:32:21.679754 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 28 04:32:21.679762 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 28 04:32:21.679816 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 28 04:32:21.679825 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 28 04:32:21.679831 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 28 04:32:21.679837 kernel: vgaarb: loaded Oct 28 04:32:21.679843 kernel: Registered efivars operations Oct 28 04:32:21.679849 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 28 04:32:21.679857 kernel: VFS: Disk quotas dquot_6.6.0 Oct 28 04:32:21.679864 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 28 04:32:21.679870 kernel: pnp: PnP ACPI init Oct 28 04:32:21.679941 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 28 04:32:21.679991 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 28 04:32:21.680000 kernel: pnp: PnP ACPI: found 1 devices Oct 28 04:32:21.680006 kernel: NET: Registered protocol family 2 Oct 28 04:32:21.680013 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 28 04:32:21.680021 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 28 04:32:21.680028 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 28 04:32:21.680034 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 28 04:32:21.680040 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 28 04:32:21.680046 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:32:21.680052 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:32:21.680059 kernel: NET: Registered protocol family 1 Oct 28 04:32:21.680065 kernel: PCI: CLS 0 bytes, default 64 Oct 28 04:32:21.680071 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 28 04:32:21.680078 kernel: kvm [1]: HYP mode not available Oct 28 04:32:21.680084 kernel: Initialise system trusted keyrings Oct 28 04:32:21.680091 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 28 04:32:21.680097 kernel: Key type asymmetric registered Oct 28 04:32:21.680103 kernel: Asymmetric key parser 'x509' registered Oct 28 04:32:21.680109 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 28 04:32:21.680121 kernel: io scheduler mq-deadline registered Oct 28 04:32:21.680127 kernel: io scheduler kyber registered Oct 28 04:32:21.680136 kernel: io scheduler bfq registered Oct 28 04:32:21.680143 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 28 04:32:21.680150 kernel: ACPI: Power Button [PWRB] Oct 28 04:32:21.680156 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 28 04:32:21.680212 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 28 04:32:21.680220 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 28 04:32:21.680226 kernel: msm_serial: driver initialized Oct 28 04:32:21.680232 kernel: random: fast init done Oct 28 04:32:21.680238 kernel: random: crng init done Oct 28 04:32:21.680244 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 28 04:32:21.680251 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 28 04:32:21.680259 kernel: thunder_xcv, ver 1.0 Oct 28 04:32:21.680265 kernel: thunder_bgx, ver 1.0 Oct 28 04:32:21.680271 kernel: nicpf, ver 1.0 Oct 28 04:32:21.680277 kernel: nicvf, ver 1.0 Oct 28 04:32:21.680338 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 28 04:32:21.680389 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-28T04:32:21 UTC (1761625941) Oct 28 04:32:21.680397 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 28 04:32:21.680403 kernel: NET: Registered protocol family 10 Oct 28 04:32:21.680411 kernel: Segment Routing with IPv6 Oct 28 04:32:21.680417 kernel: NET: Registered protocol family 17 Oct 28 04:32:21.680423 kernel: Key type dns_resolver registered Oct 28 04:32:21.680429 kernel: registered taskstats version 1 Oct 28 04:32:21.680435 kernel: Loading compiled-in X.509 certificates Oct 28 04:32:21.680441 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 28 04:32:21.680447 kernel: Key type ._fscrypt registered Oct 28 04:32:21.680453 kernel: Key type .fscrypt registered Oct 28 04:32:21.680459 kernel: Key type fscrypt-provisioning registered Oct 28 04:32:21.680466 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 28 04:32:21.680472 kernel: ima: Allocated hash algorithm: sha1 Oct 28 04:32:21.680478 kernel: ima: No architecture policies found Oct 28 04:32:21.680485 kernel: Freeing unused kernel memory: 34240K Oct 28 04:32:21.680491 kernel: Run /init as init process Oct 28 04:32:21.680497 kernel: with arguments: Oct 28 04:32:21.680503 kernel: /init Oct 28 04:32:21.680508 kernel: with environment: Oct 28 04:32:21.680514 kernel: HOME=/ Oct 28 04:32:21.680520 kernel: TERM=linux Oct 28 04:32:21.680527 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 28 04:32:21.680535 systemd[1]: systemd 249 running in system mode (+PAM -AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Oct 28 04:32:21.680543 systemd[1]: Detected virtualization kvm. Oct 28 04:32:21.680550 systemd[1]: Detected architecture arm64. Oct 28 04:32:21.680557 systemd[1]: Running in initial RAM disk. Oct 28 04:32:21.680563 systemd[1]: No hostname configured, using default hostname. Oct 28 04:32:21.680570 systemd[1]: Hostname set to . Oct 28 04:32:21.680578 systemd[1]: Initializing machine ID from VM UUID. Oct 28 04:32:21.680584 systemd[1]: Queued start job for default target Initrd Default Target. Oct 28 04:32:21.680591 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 04:32:21.680597 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 04:32:21.680604 systemd[1]: Reached target Path Units. Oct 28 04:32:21.680610 systemd[1]: Reached target Slice Units. Oct 28 04:32:21.680617 systemd[1]: Reached target Swaps. Oct 28 04:32:21.680623 systemd[1]: Reached target Timer Units. Oct 28 04:32:21.680631 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 28 04:32:21.680638 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 28 04:32:21.680645 systemd[1]: Listening on Journal Audit Socket. Oct 28 04:32:21.680651 systemd[1]: Listening on Journal Socket (/dev/log). Oct 28 04:32:21.680658 systemd[1]: Listening on Journal Socket. Oct 28 04:32:21.680664 systemd[1]: Listening on udev Control Socket. Oct 28 04:32:21.680671 systemd[1]: Listening on udev Kernel Socket. Oct 28 04:32:21.680680 systemd[1]: Reached target Socket Units. Oct 28 04:32:21.680687 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 28 04:32:21.680695 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 04:32:21.680701 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 28 04:32:21.680708 systemd[1]: Starting Journal Service... Oct 28 04:32:21.680714 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 04:32:21.680721 systemd[1]: Starting Apply Kernel Variables... Oct 28 04:32:21.680728 systemd[1]: Starting Setup Virtual Console... Oct 28 04:32:21.680734 kernel: SCSI subsystem initialized Oct 28 04:32:21.680741 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 28 04:32:21.680747 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 04:32:21.680754 kernel: Loading iSCSI transport class v2.0-870. Oct 28 04:32:21.680761 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 04:32:21.680783 systemd-journald[270]: Journal started Oct 28 04:32:21.680828 systemd-journald[270]: Runtime Journal (/run/log/journal/f584566887b64c39b8181653a7f79892) is 6.0M, max 48.5M, 42.4M free. Oct 28 04:32:21.682239 systemd[1]: Started Journal Service. Oct 28 04:32:21.682680 systemd[1]: Finished Apply Kernel Variables. Oct 28 04:32:21.683745 systemd[1]: Finished Setup Virtual Console. Oct 28 04:32:21.685194 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 04:32:21.687279 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 28 04:32:21.702107 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 28 04:32:21.703880 systemd[1]: Starting dracut cmdline hook... Oct 28 04:32:21.713021 dracut-cmdline[290]: dracut-dracut-053 Oct 28 04:32:21.715176 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 28 04:32:21.772803 kernel: iscsi: registered transport (tcp) Oct 28 04:32:21.783793 kernel: iscsi: registered transport (qla4xxx) Oct 28 04:32:21.783812 kernel: QLogic iSCSI HBA Driver Oct 28 04:32:21.793878 systemd[1]: Finished dracut cmdline hook. Oct 28 04:32:21.795483 systemd[1]: Starting dracut pre-udev hook... Oct 28 04:32:21.796787 systemd[1]: Starting Open-iSCSI... Oct 28 04:32:21.799168 iscsid[376]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 28 04:32:21.799168 iscsid[376]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Oct 28 04:32:21.799168 iscsid[376]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 28 04:32:21.799168 iscsid[376]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 28 04:32:21.799168 iscsid[376]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 28 04:32:21.811898 kernel: device-mapper: uevent: version 1.0.3 Oct 28 04:32:21.811925 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 28 04:32:21.811934 iscsid[376]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 28 04:32:21.802824 systemd[1]: Started Open-iSCSI. Oct 28 04:32:21.845802 kernel: raid6: neonx8 gen() 13785 MB/s Oct 28 04:32:21.862788 kernel: raid6: neonx8 xor() 10757 MB/s Oct 28 04:32:21.879793 kernel: raid6: neonx4 gen() 13618 MB/s Oct 28 04:32:21.896792 kernel: raid6: neonx4 xor() 11580 MB/s Oct 28 04:32:21.913791 kernel: raid6: neonx2 gen() 13034 MB/s Oct 28 04:32:21.930787 kernel: raid6: neonx2 xor() 9899 MB/s Oct 28 04:32:21.947787 kernel: raid6: neonx1 gen() 11000 MB/s Oct 28 04:32:21.964806 kernel: raid6: neonx1 xor() 8822 MB/s Oct 28 04:32:21.981802 kernel: raid6: int64x8 gen() 6827 MB/s Oct 28 04:32:21.998810 kernel: raid6: int64x8 xor() 3796 MB/s Oct 28 04:32:22.015813 kernel: raid6: int64x4 gen() 6916 MB/s Oct 28 04:32:22.032803 kernel: raid6: int64x4 xor() 3833 MB/s Oct 28 04:32:22.049802 kernel: raid6: int64x2 gen() 6191 MB/s Oct 28 04:32:22.066798 kernel: raid6: int64x2 xor() 3315 MB/s Oct 28 04:32:22.083823 kernel: raid6: int64x1 gen() 5017 MB/s Oct 28 04:32:22.101145 kernel: raid6: int64x1 xor() 2586 MB/s Oct 28 04:32:22.101161 kernel: raid6: using algorithm neonx8 gen() 13785 MB/s Oct 28 04:32:22.101170 kernel: raid6: .... xor() 10757 MB/s, rmw enabled Oct 28 04:32:22.102370 kernel: raid6: using neon recovery algorithm Oct 28 04:32:22.112801 kernel: xor: measuring software checksum speed Oct 28 04:32:22.113800 kernel: 8regs : 17141 MB/sec Oct 28 04:32:22.114802 kernel: 32regs : 20760 MB/sec Oct 28 04:32:22.116255 kernel: arm64_neon : 28885 MB/sec Oct 28 04:32:22.116267 kernel: xor: using function: arm64_neon (28885 MB/sec) Oct 28 04:32:22.161876 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 28 04:32:22.171534 systemd[1]: Finished dracut pre-udev hook. Oct 28 04:32:22.172000 audit: BPF prog-id=6 op=LOAD Oct 28 04:32:22.173000 audit: BPF prog-id=7 op=LOAD Oct 28 04:32:22.174850 kernel: audit: type=1334 audit(1761625942.172:2): prog-id=6 op=LOAD Oct 28 04:32:22.174874 kernel: audit: type=1334 audit(1761625942.173:3): prog-id=7 op=LOAD Oct 28 04:32:22.174883 kernel: audit: type=1334 audit(1761625942.174:4): prog-id=8 op=LOAD Oct 28 04:32:22.174000 audit: BPF prog-id=8 op=LOAD Oct 28 04:32:22.175220 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 04:32:22.186483 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 04:32:22.188199 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 04:32:22.190051 systemd[1]: Starting dracut pre-trigger hook... Oct 28 04:32:22.201824 dracut-pre-trigger[416]: rd.md=0: removing MD RAID activation Oct 28 04:32:22.224209 systemd[1]: Finished dracut pre-trigger hook. Oct 28 04:32:22.225708 systemd[1]: Starting Coldplug All udev Devices... Oct 28 04:32:22.235246 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 04:32:22.254013 systemd[1]: Finished Coldplug All udev Devices. Oct 28 04:32:22.255630 systemd[1]: Starting dracut initqueue hook... Oct 28 04:32:22.273824 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 28 04:32:22.273997 kernel: vda: detected capacity change from 0 to 4756340736 Oct 28 04:32:22.285477 systemd-udevd[465]: Using default interface naming scheme 'v249'. Oct 28 04:32:22.287780 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 04:32:22.310798 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (463) Oct 28 04:32:22.312558 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 28 04:32:22.313600 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 28 04:32:22.317668 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 28 04:32:22.323648 systemd[1]: Finished dracut initqueue hook. Oct 28 04:32:22.326598 systemd[1]: Reached target Initrd Root Device. Oct 28 04:32:22.327505 systemd[1]: Reached target Preparation for Remote File Systems. Oct 28 04:32:22.329188 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 04:32:22.330918 systemd[1]: Reached target Remote File Systems. Oct 28 04:32:22.333188 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 28 04:32:22.334904 systemd[1]: Starting dracut pre-mount hook... Oct 28 04:32:22.336218 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 28 04:32:22.336334 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 28 04:32:22.337856 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 04:32:22.340170 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 28 04:32:22.343963 systemd[1]: Finished dracut pre-mount hook. Oct 28 04:32:22.345857 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 28 04:32:22.358790 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 28 04:32:22.359468 systemd-fsck[501]: ROOT: clean, 640/553792 files, 39961/553472 blocks Oct 28 04:32:22.361036 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 28 04:32:22.364124 systemd[1]: Mounting /sysroot... Oct 28 04:32:22.381109 systemd[1]: Found device /dev/mapper/usr. Oct 28 04:32:22.382570 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 28 04:32:22.386744 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 28 04:32:22.393125 systemd-fsck[514]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 28 04:32:22.394547 systemd-fsck[514]: You must have r/w access to the filesystem or be root Oct 28 04:32:22.394825 systemd-fsck[510]: fsck failed with exit status 8. Oct 28 04:32:22.394829 systemd-fsck[510]: Ignoring error. Oct 28 04:32:22.395400 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 28 04:32:22.397191 systemd[1]: Mounting /sysusr/usr... Oct 28 04:32:22.408782 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 28 04:32:22.408851 systemd[1]: Mounted /sysusr/usr. Oct 28 04:32:22.412229 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 28 04:32:22.412246 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 28 04:32:22.411723 systemd[1]: Reached target Local File Systems. Oct 28 04:32:22.412978 systemd[1]: Reached target System Initialization. Oct 28 04:32:22.414427 systemd[1]: Reached target Basic System. Oct 28 04:32:22.416391 systemd[1]: Mounted /sysroot. Oct 28 04:32:22.417090 systemd[1]: Reached target Initrd Root File System. Oct 28 04:32:22.419268 systemd[1]: Mounting /sysroot/usr... Oct 28 04:32:22.420419 systemd[1]: Starting Reload Configuration from the Real Root... Oct 28 04:32:22.421988 systemd[1]: Mounted /sysroot/usr. Oct 28 04:32:22.424814 systemd[1]: Reloading. Oct 28 04:32:22.425000 audit: BPF prog-id=6 op=UNLOAD Oct 28 04:32:22.427802 kernel: audit: type=1334 audit(1761625942.425:5): prog-id=6 op=UNLOAD Oct 28 04:32:22.428000 audit: BPF prog-id=3 op=UNLOAD Oct 28 04:32:22.430807 kernel: audit: type=1334 audit(1761625942.428:6): prog-id=3 op=UNLOAD Oct 28 04:32:22.511000 audit: BPF prog-id=9 op=LOAD Oct 28 04:32:22.513000 audit: BPF prog-id=10 op=LOAD Oct 28 04:32:22.514564 kernel: audit: type=1334 audit(1761625942.511:7): prog-id=9 op=LOAD Oct 28 04:32:22.514587 kernel: audit: type=1334 audit(1761625942.513:8): prog-id=10 op=LOAD Oct 28 04:32:22.514000 audit: BPF prog-id=11 op=LOAD Oct 28 04:32:22.515560 kernel: audit: type=1334 audit(1761625942.514:9): prog-id=11 op=LOAD Oct 28 04:32:22.515000 audit: BPF prog-id=7 op=UNLOAD Oct 28 04:32:22.516484 kernel: audit: type=1334 audit(1761625942.515:10): prog-id=7 op=UNLOAD Oct 28 04:32:22.516000 audit: BPF prog-id=8 op=UNLOAD Oct 28 04:32:22.516000 audit: BPF prog-id=12 op=LOAD Oct 28 04:32:22.516000 audit: BPF prog-id=13 op=LOAD Oct 28 04:32:22.516000 audit: BPF prog-id=14 op=LOAD Oct 28 04:32:22.516000 audit: BPF prog-id=4 op=UNLOAD Oct 28 04:32:22.516000 audit: BPF prog-id=5 op=UNLOAD Oct 28 04:32:22.532055 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 28 04:32:22.532186 systemd[1]: Finished Reload Configuration from the Real Root. Oct 28 04:32:22.534154 systemd[1]: Reached target Initrd File Systems. Oct 28 04:32:22.535661 systemd[1]: Reached target Initrd Default Target. Oct 28 04:32:22.537231 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 28 04:32:22.537908 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 28 04:32:22.547755 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 28 04:32:22.549358 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 28 04:32:22.555239 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 04:32:22.556243 systemd[1]: Stopped target Timer Units. Oct 28 04:32:22.557700 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 28 04:32:22.557877 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 28 04:32:22.559269 systemd[1]: Stopped target Initrd Default Target. Oct 28 04:32:22.560898 systemd[1]: Stopped target Basic System. Oct 28 04:32:22.562507 systemd[1]: Stopped target Initrd Root Device. Oct 28 04:32:22.564478 systemd[1]: Stopped target Path Units. Oct 28 04:32:22.565847 systemd[1]: Stopped target Remote File Systems. Oct 28 04:32:22.567401 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 28 04:32:22.568902 systemd[1]: Stopped target Slice Units. Oct 28 04:32:22.570380 systemd[1]: Stopped target Socket Units. Oct 28 04:32:22.571947 systemd[1]: Stopped target System Initialization. Oct 28 04:32:22.573351 systemd[1]: Stopped target Local File Systems. Oct 28 04:32:22.574716 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 04:32:22.576406 systemd[1]: Stopped target Swaps. Oct 28 04:32:22.577704 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 28 04:32:22.577850 systemd[1]: Stopped dracut pre-mount hook. Oct 28 04:32:22.579469 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 04:32:22.580749 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 04:32:22.584819 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 04:32:22.586065 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 28 04:32:22.586172 systemd[1]: Stopped dracut initqueue hook. Oct 28 04:32:22.591526 iscsid[376]: iscsid shutting down. Oct 28 04:32:22.587977 systemd[1]: Stopping Open-iSCSI... Oct 28 04:32:22.590809 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 04:32:22.590926 systemd[1]: Stopped Apply Kernel Variables. Oct 28 04:32:22.592347 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 28 04:32:22.592435 systemd[1]: Stopped Coldplug All udev Devices. Oct 28 04:32:22.593704 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 28 04:32:22.593813 systemd[1]: Stopped dracut pre-trigger hook. Oct 28 04:32:22.595103 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 28 04:32:22.600991 systemd[1]: iscsid.service: Deactivated successfully. Oct 28 04:32:22.601093 systemd[1]: Stopped Open-iSCSI. Oct 28 04:32:22.604067 systemd[1]: iscsid.socket: Deactivated successfully. Oct 28 04:32:22.604118 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 28 04:32:22.605060 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 28 04:32:22.607763 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 28 04:32:22.607920 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 28 04:32:22.609344 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 28 04:32:22.609455 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 28 04:32:22.610863 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 28 04:32:22.610994 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 28 04:32:22.621000 audit: BPF prog-id=9 op=UNLOAD Oct 28 04:32:22.612573 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 28 04:32:22.612602 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 28 04:32:22.614050 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 28 04:32:22.614093 systemd[1]: Closed udev Control Socket. Oct 28 04:32:22.615568 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 28 04:32:22.615600 systemd[1]: Closed udev Kernel Socket. Oct 28 04:32:22.617170 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 28 04:32:22.617215 systemd[1]: Stopped dracut pre-udev hook. Oct 28 04:32:22.618647 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 28 04:32:22.618688 systemd[1]: Stopped dracut cmdline hook. Oct 28 04:32:22.620082 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 28 04:32:22.620123 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 28 04:32:22.622637 systemd[1]: Starting Cleanup udev Database... Oct 28 04:32:22.623631 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 28 04:32:22.625288 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 04:32:22.625357 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 04:32:22.626974 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 28 04:32:22.643000 audit: BPF prog-id=12 op=UNLOAD Oct 28 04:32:22.627015 systemd[1]: Stopped Create List of Static Device Nodes. Oct 28 04:32:22.628698 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 04:32:22.628739 systemd[1]: Stopped Setup Virtual Console. Oct 28 04:32:22.630305 systemd[1]: rngd.service: Deactivated successfully. Oct 28 04:32:22.630424 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 28 04:32:22.632028 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 28 04:32:22.632136 systemd[1]: Finished Cleanup udev Database. Oct 28 04:32:22.633321 systemd[1]: Reached target Switch Root. Oct 28 04:32:22.635401 systemd[1]: Starting Switch Root... Oct 28 04:32:22.641755 systemd[1]: Switching root. Oct 28 04:32:22.657133 systemd-journald[270]: Journal stopped Oct 28 04:32:24.751578 systemd-journald[270]: Received SIGTERM from PID 1 (systemd). Oct 28 04:32:24.751624 kernel: SELinux: policy capability network_peer_controls=1 Oct 28 04:32:24.751635 kernel: SELinux: policy capability open_perms=1 Oct 28 04:32:24.751647 kernel: SELinux: policy capability extended_socket_class=1 Oct 28 04:32:24.751659 kernel: SELinux: policy capability always_check_network=0 Oct 28 04:32:24.751668 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 28 04:32:24.751679 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 28 04:32:24.751689 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 28 04:32:24.751699 systemd[1]: Successfully loaded SELinux policy in 33.925ms. Oct 28 04:32:24.751712 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.355ms. Oct 28 04:32:24.751725 systemd[1]: systemd 249 running in system mode (+PAM -AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Oct 28 04:32:24.751735 systemd[1]: Detected virtualization kvm. Oct 28 04:32:24.751744 systemd[1]: Detected architecture arm64. Oct 28 04:32:24.751755 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Oct 28 04:32:24.751766 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 28 04:32:24.751799 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 28 04:32:24.751810 systemd[1]: Stopped Switch Root. Oct 28 04:32:24.751821 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 28 04:32:24.751839 systemd[1]: Created slice Slice /system/addon-config. Oct 28 04:32:24.751849 systemd[1]: Created slice Slice /system/addon-run. Oct 28 04:32:24.751858 systemd[1]: Created slice Slice /system/getty. Oct 28 04:32:24.751868 systemd[1]: Created slice Slice /system/modprobe. Oct 28 04:32:24.751878 systemd[1]: Created slice Slice /system/serial-getty. Oct 28 04:32:24.751887 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 28 04:32:24.751897 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 28 04:32:24.751906 systemd[1]: Created slice User and Session Slice. Oct 28 04:32:24.751916 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 04:32:24.751928 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 28 04:32:24.751938 systemd[1]: Set up automount Boot partition Automount Point. Oct 28 04:32:24.751948 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 28 04:32:24.751957 systemd[1]: Stopped target Switch Root. Oct 28 04:32:24.751967 systemd[1]: Stopped target Initrd File Systems. Oct 28 04:32:24.751976 systemd[1]: Stopped target Initrd Root File System. Oct 28 04:32:24.752023 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 04:32:24.752038 systemd[1]: Reached target Remote File Systems. Oct 28 04:32:24.752047 systemd[1]: Reached target Slice Units. Oct 28 04:32:24.752058 systemd[1]: Reached target Swaps. Oct 28 04:32:24.752070 systemd[1]: Reached target Verify torcx succeeded. Oct 28 04:32:24.752080 systemd[1]: Reached target Local Verity Protected Volumes. Oct 28 04:32:24.752090 systemd[1]: Listening on Process Core Dump Socket. Oct 28 04:32:24.752099 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 28 04:32:24.752109 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 04:32:24.752118 systemd[1]: Listening on udev Control Socket. Oct 28 04:32:24.752128 systemd[1]: Listening on udev Kernel Socket. Oct 28 04:32:24.752137 systemd[1]: Mounting Huge Pages File System... Oct 28 04:32:24.752147 systemd[1]: Mounting POSIX Message Queue File System... Oct 28 04:32:24.752157 systemd[1]: Mounting External Media Directory... Oct 28 04:32:24.752167 systemd[1]: Mounting Kernel Debug File System... Oct 28 04:32:24.752178 systemd[1]: Mounting Kernel Trace File System... Oct 28 04:32:24.752188 systemd[1]: Mounting Temporary Directory /tmp... Oct 28 04:32:24.752197 systemd[1]: Starting Create missing system files... Oct 28 04:32:24.752207 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 04:32:24.752217 systemd[1]: Starting Load Kernel Module configfs... Oct 28 04:32:24.752226 systemd[1]: Starting Load Kernel Module drm... Oct 28 04:32:24.752236 systemd[1]: Starting Load Kernel Module fuse... Oct 28 04:32:24.752246 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 28 04:32:24.752258 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 28 04:32:24.752268 systemd[1]: Stopped File System Check on Root Device. Oct 28 04:32:24.752279 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 28 04:32:24.752289 systemd[1]: Stopped systemd-fsck-usr.service. Oct 28 04:32:24.752299 kernel: fuse: init (API version 7.32) Oct 28 04:32:24.752308 systemd[1]: Stopped Journal Service. Oct 28 04:32:24.752318 systemd[1]: Starting Journal Service... Oct 28 04:32:24.752327 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 04:32:24.752337 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 28 04:32:24.752347 systemd[1]: Starting Apply Kernel Variables... Oct 28 04:32:24.752357 systemd[1]: Starting Coldplug All udev Devices... Oct 28 04:32:24.752368 systemd[1]: verity-setup.service: Deactivated successfully. Oct 28 04:32:24.752377 systemd[1]: Stopped verity-setup.service. Oct 28 04:32:24.752390 systemd-journald[693]: Journal started Oct 28 04:32:24.752430 systemd-journald[693]: Runtime Journal (/run/log/journal/f584566887b64c39b8181653a7f79892) is 6.0M, max 48.5M, 42.4M free. Oct 28 04:32:22.733000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 28 04:32:22.761000 audit[1]: AVC avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Oct 28 04:32:22.761000 audit[1]: AVC avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Oct 28 04:32:22.761000 audit: BPF prog-id=15 op=LOAD Oct 28 04:32:22.761000 audit: BPF prog-id=15 op=UNLOAD Oct 28 04:32:22.761000 audit: BPF prog-id=16 op=LOAD Oct 28 04:32:22.761000 audit: BPF prog-id=16 op=UNLOAD Oct 28 04:32:22.799000 audit[645]: AVC avc: denied { associate } for pid=645 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Oct 28 04:32:24.614000 audit: BPF prog-id=17 op=LOAD Oct 28 04:32:24.614000 audit: BPF prog-id=18 op=LOAD Oct 28 04:32:24.614000 audit: BPF prog-id=19 op=LOAD Oct 28 04:32:24.614000 audit: BPF prog-id=13 op=UNLOAD Oct 28 04:32:24.614000 audit: BPF prog-id=14 op=UNLOAD Oct 28 04:32:24.629000 audit: BPF prog-id=17 op=UNLOAD Oct 28 04:32:24.736000 audit: BPF prog-id=20 op=LOAD Oct 28 04:32:24.736000 audit: BPF prog-id=21 op=LOAD Oct 28 04:32:24.736000 audit: BPF prog-id=22 op=LOAD Oct 28 04:32:24.736000 audit: BPF prog-id=18 op=UNLOAD Oct 28 04:32:24.736000 audit: BPF prog-id=19 op=UNLOAD Oct 28 04:32:24.749000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 28 04:32:24.604551 systemd[1]: Queued start job for default target Multi-User System. Oct 28 04:32:22.797430 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3033.2.4 /usr/share/oem/torcx/store /var/lib/torcx/store/3033.2.4 /var/lib/torcx/store]" Oct 28 04:32:24.615874 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 28 04:32:22.797819 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 04:32:22.797843 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 04:32:22.798262 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 28 04:32:22.798276 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 28 04:32:22.798312 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 28 04:32:22.798326 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 28 04:32:22.798698 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 28 04:32:22.798738 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 04:32:22.798754 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 04:32:22.799176 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Oct 28 04:32:22.799209 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Oct 28 04:32:22.799230 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3033.2.4: no such file or directory" path=/usr/share/oem/torcx/store/3033.2.4 Oct 28 04:32:22.799246 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 28 04:32:22.799372 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3033.2.4: no such file or directory" path=/var/lib/torcx/store/3033.2.4 Oct 28 04:32:22.799390 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:22Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 28 04:32:24.510903 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:24Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:32:24.511179 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:24Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:32:24.511288 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:24Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:32:24.511414 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:24Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:32:24.511509 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:24Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 28 04:32:24.511582 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:32:24Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Oct 28 04:32:24.756178 systemd[1]: Started Journal Service. Oct 28 04:32:24.756674 systemd[1]: Mounted Huge Pages File System. Oct 28 04:32:24.757725 systemd[1]: Mounted POSIX Message Queue File System. Oct 28 04:32:24.759473 systemd[1]: Mounted External Media Directory. Oct 28 04:32:24.762071 systemd[1]: Mounted Kernel Debug File System. Oct 28 04:32:24.763041 systemd[1]: Mounted Kernel Trace File System. Oct 28 04:32:24.764050 systemd[1]: Mounted Temporary Directory /tmp. Oct 28 04:32:24.765319 systemd[1]: Finished Create missing system files. Oct 28 04:32:24.766639 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 04:32:24.767966 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 28 04:32:24.768154 systemd[1]: Finished Load Kernel Module configfs. Oct 28 04:32:24.769333 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 04:32:24.769538 systemd[1]: Finished Load Kernel Module drm. Oct 28 04:32:24.770661 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 28 04:32:24.770878 systemd[1]: Finished Load Kernel Module fuse. Oct 28 04:32:24.772117 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 28 04:32:24.773524 systemd[1]: Finished Apply Kernel Variables. Oct 28 04:32:24.785098 systemd[1]: Mounting FUSE Control File System... Oct 28 04:32:24.786888 systemd[1]: Mounting Kernel Configuration File System... Oct 28 04:32:24.787818 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 28 04:32:24.788886 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 28 04:32:24.789884 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 28 04:32:24.790866 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 28 04:32:24.791832 systemd[1]: Starting Load/Save Random Seed... Oct 28 04:32:24.792683 systemd[1]: Condition check resulted in Create System Users being skipped. Oct 28 04:32:24.794904 systemd-journald[693]: Time spent on flushing to /var/log/journal/f584566887b64c39b8181653a7f79892 is 11.758ms for 655 entries. Oct 28 04:32:24.794904 systemd-journald[693]: System Journal (/var/log/journal/f584566887b64c39b8181653a7f79892) is 8.0M, max 203.0M, 195.0M free. Oct 28 04:32:24.817000 audit: BPF prog-id=23 op=LOAD Oct 28 04:32:24.817000 audit: BPF prog-id=24 op=LOAD Oct 28 04:32:24.817000 audit: BPF prog-id=25 op=LOAD Oct 28 04:32:24.817000 audit: BPF prog-id=10 op=UNLOAD Oct 28 04:32:24.817000 audit: BPF prog-id=11 op=UNLOAD Oct 28 04:32:24.793754 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 04:32:24.795523 systemd[1]: Mounted FUSE Control File System. Oct 28 04:32:24.797415 systemd[1]: Mounted Kernel Configuration File System. Oct 28 04:32:24.802227 systemd[1]: Finished Load/Save Random Seed. Oct 28 04:32:24.803692 systemd[1]: Condition check resulted in First Boot Complete being skipped. Oct 28 04:32:24.809648 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 04:32:24.819234 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 04:32:24.820864 systemd[1]: Finished Coldplug All udev Devices. Oct 28 04:32:24.823011 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 28 04:32:24.824552 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 28 04:32:24.845321 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 04:32:24.854074 systemd[1]: Starting Network Configuration... Oct 28 04:32:24.852000 audit: BPF prog-id=26 op=LOAD Oct 28 04:32:24.883411 systemd-networkd[726]: lo: Link UP Oct 28 04:32:24.883421 systemd-networkd[726]: lo: Gained carrier Oct 28 04:32:24.883753 systemd-networkd[726]: Enumeration completed Oct 28 04:32:24.883911 systemd[1]: Started Network Configuration. Oct 28 04:32:24.903184 systemd-udevd[712]: Using default interface naming scheme 'v249'. Oct 28 04:32:24.933932 udevadm[707]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 28 04:32:24.937459 systemd-networkd[726]: eth0: Link UP Oct 28 04:32:24.940830 systemd-networkd[726]: eth0: Gained carrier Oct 28 04:32:24.948903 systemd-networkd[726]: eth0: DHCPv4 address 10.0.0.5/16 via 10.0.0.1 Oct 28 04:32:24.952061 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 28 04:32:24.959862 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 04:32:24.967894 lvm[734]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 04:32:24.997063 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 04:32:24.998248 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 04:32:25.016825 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 04:32:25.020247 lvm[735]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 04:32:25.049956 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 04:32:25.051057 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 04:32:25.052105 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 28 04:32:25.052131 systemd[1]: Reached target Containers. Oct 28 04:32:25.067083 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 28 04:32:25.079747 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 28 04:32:25.082088 systemd[1]: Mounting /usr/share/oem... Oct 28 04:32:25.088483 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 04:32:25.088551 kernel: BTRFS info (device vda6): has skinny extents Oct 28 04:32:25.091304 systemd[1]: Mounted /usr/share/oem. Oct 28 04:32:25.092168 systemd[1]: Reached target Local File Systems. Oct 28 04:32:25.093131 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Oct 28 04:32:25.093505 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 28 04:32:25.093544 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 28 04:32:25.093574 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 28 04:32:25.105815 systemd[1]: Starting Create Volatile Files and Directories... Oct 28 04:32:25.111939 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 28 04:32:25.113083 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 28 04:32:25.145131 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 04:32:25.145145 systemd-tmpfiles[758]: Skipping /boot Oct 28 04:32:25.150899 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 04:32:25.150912 systemd-tmpfiles[758]: Skipping /boot Oct 28 04:32:25.187397 systemd[1]: Finished Create Volatile Files and Directories. Oct 28 04:32:25.198887 systemd[1]: Starting Load Security Auditing Rules... Oct 28 04:32:25.200914 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 28 04:32:25.202006 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Oct 28 04:32:25.201000 audit: BPF prog-id=27 op=LOAD Oct 28 04:32:25.203500 systemd[1]: Starting Network Name Resolution... Oct 28 04:32:25.204000 audit: BPF prog-id=28 op=LOAD Oct 28 04:32:25.206055 systemd[1]: Starting Network Time Synchronization... Oct 28 04:32:25.207091 systemd[1]: Condition check resulted in Update is Completed being skipped. Oct 28 04:32:25.208088 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 28 04:32:25.209710 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 28 04:32:25.211180 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 28 04:32:25.218319 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 28 04:32:25.232000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 28 04:32:25.233242 augenrules[779]: No rules Oct 28 04:32:25.234237 systemd[1]: Finished Load Security Auditing Rules. Oct 28 04:32:24.842674 systemd-resolved[762]: Positive Trust Anchors: Oct 28 04:32:24.842686 systemd-resolved[762]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 04:32:24.842686 systemd-timesyncd[768]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 28 04:32:24.842714 systemd-resolved[762]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Oct 28 04:32:24.843495 systemd-resolved[762]: Defaulting to hostname 'linux'. Oct 28 04:32:24.844695 systemd[1]: Started Network Time Synchronization. Oct 28 04:32:24.845931 systemd[1]: Reached target System Initialization. Oct 28 04:32:24.846945 systemd[1]: Started Watch for update engine configuration changes. Oct 28 04:32:24.848299 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 04:32:24.849686 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 28 04:32:24.852703 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 28 04:32:24.852739 systemd[1]: Reached target Path Units. Oct 28 04:32:24.853519 systemd[1]: Reached target System Time Set. Oct 28 04:32:24.855258 systemd[1]: Started Daily Log Rotation. Oct 28 04:32:24.856723 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 28 04:32:24.857846 systemd[1]: Reached target Timer Units. Oct 28 04:32:24.859030 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 28 04:32:24.873235 systemd[1]: Starting Docker Socket for the API... Oct 28 04:32:24.876606 systemd[1]: Listening on OpenSSH Server Socket. Oct 28 04:32:24.877919 systemd[1]: Started Network Name Resolution. Oct 28 04:32:24.878939 systemd[1]: Listening on Docker Socket for the API. Oct 28 04:32:24.880030 systemd[1]: Reached target Network. Oct 28 04:32:24.880842 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 04:32:24.881910 systemd[1]: Reached target Socket Units. Oct 28 04:32:24.882759 systemd[1]: Reached target Basic System. Oct 28 04:32:24.883653 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 28 04:32:24.883686 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 28 04:32:24.884821 systemd[1]: Started D-Bus System Message Bus. Oct 28 04:32:24.888102 systemd[1]: Starting Extend Filesystems... Oct 28 04:32:24.890124 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 28 04:32:24.891185 systemd[1]: Starting Generate /run/flatcar/motd... Oct 28 04:32:24.894140 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 28 04:32:24.896982 systemd[1]: Starting Generate sshd host keys... Oct 28 04:32:24.898201 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 28 04:32:24.898254 systemd[1]: Reached target Load system-provided cloud configs. Oct 28 04:32:24.898590 extend-filesystems[789]: Found vda Oct 28 04:32:24.901031 extend-filesystems[789]: Found vda1 Oct 28 04:32:24.901031 extend-filesystems[789]: Found vda2 Oct 28 04:32:24.901031 extend-filesystems[789]: Found vda3 Oct 28 04:32:24.901031 extend-filesystems[789]: Found usr Oct 28 04:32:24.901031 extend-filesystems[789]: Found vda4 Oct 28 04:32:24.901031 extend-filesystems[789]: Found vda6 Oct 28 04:32:24.901031 extend-filesystems[789]: Found vda7 Oct 28 04:32:24.901031 extend-filesystems[789]: Found vda9 Oct 28 04:32:24.901031 extend-filesystems[789]: Checking size of /dev/vda9 Oct 28 04:32:24.901813 systemd[1]: Starting User Login Management... Oct 28 04:32:24.904155 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 28 04:32:24.904822 systemd[1]: Starting Update Engine... Oct 28 04:32:24.905831 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 28 04:32:24.905871 systemd[1]: Reached target Load user-provided cloud configs. Oct 28 04:32:24.908064 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 28 04:32:24.908296 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 28 04:32:24.920870 systemd[1]: motdgen.service: Deactivated successfully. Oct 28 04:32:24.921105 systemd[1]: Finished Generate /run/flatcar/motd. Oct 28 04:32:24.942260 extend-filesystems[789]: Old size kept for /dev/vda9 Oct 28 04:32:24.943904 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 28 04:32:24.944144 systemd[1]: Finished Extend Filesystems. Oct 28 04:32:24.956184 systemd-logind[801]: Watching system buttons on /dev/input/event0 (Power Button) Oct 28 04:32:24.956947 systemd-logind[801]: New seat seat0. Oct 28 04:32:24.960103 systemd[1]: Started User Login Management. Oct 28 04:32:24.968677 update_engine[805]: I1028 04:32:24.968367 805 main.cc:89] Flatcar Update Engine starting Oct 28 04:32:24.969344 update_engine[805]: I1028 04:32:24.969324 805 payload_state.cc:360] Current Response Signature = Oct 28 04:32:24.969344 update_engine[805]: NumURLs = 1 Oct 28 04:32:24.969344 update_engine[805]: Url0 = http://10.0.0.4:34567/packages/update.gz Oct 28 04:32:24.969344 update_engine[805]: Payload Size = 439465725 Oct 28 04:32:24.969344 update_engine[805]: Payload Sha256 Hash = dykyx/Y4jQdfCP1f9j5W1sV+S815EIPi4QJ65LWeHik= Oct 28 04:32:24.969344 update_engine[805]: Is Delta Payload = 0 Oct 28 04:32:24.969344 update_engine[805]: Max Failure Count Per Url = 10 Oct 28 04:32:24.969344 update_engine[805]: Disable Payload Backoff = 1 Oct 28 04:32:24.969641 update_engine[805]: I1028 04:32:24.969621 805 payload_state.cc:381] Payload Attempt Number = 0 Oct 28 04:32:24.969855 update_engine[805]: I1028 04:32:24.969841 805 payload_state.cc:404] Current URL Index = 0 Oct 28 04:32:24.970051 update_engine[805]: I1028 04:32:24.970037 805 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 28 04:32:24.970254 update_engine[805]: I1028 04:32:24.970224 805 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 28 04:32:24.972111 systemd[1]: Started Update Engine. Oct 28 04:32:24.972666 update_engine[805]: I1028 04:32:24.972237 805 update_check_scheduler.cc:74] Next update check in 8m32s Oct 28 04:32:24.974219 systemd[1]: Finished Generate sshd host keys. Oct 28 04:32:24.986706 systemd[1]: Starting Generate /run/issue... Oct 28 04:32:24.991590 systemd[1]: issuegen.service: Deactivated successfully. Oct 28 04:32:24.991862 systemd[1]: Finished Generate /run/issue. Oct 28 04:32:24.994293 systemd[1]: Starting Permit User Sessions... Oct 28 04:32:24.999259 systemd[1]: Finished Permit User Sessions. Oct 28 04:32:25.001880 systemd[1]: Started Getty on tty1. Oct 28 04:32:25.004074 systemd[1]: Started Serial Getty on ttyAMA0. Oct 28 04:32:25.005236 systemd[1]: Reached target Login Prompts. Oct 28 04:32:25.006316 systemd[1]: Reached target Multi-User System. Oct 28 04:32:25.008710 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 28 04:32:25.014395 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 28 04:32:25.014685 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 28 04:32:25.015880 systemd[1]: Startup finished in 708ms (kernel) + 1.141s (initrd) + 2.719s (userspace) = 4.570s. Oct 28 04:32:25.531637 systemd[1]: Created slice Slice /system/sshd. Oct 28 04:32:25.533236 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36748). Oct 28 04:32:25.578980 sshd[829]: Accepted publickey for core from 10.0.0.1 port 36748 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:25.580862 sshd[829]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:25.597132 systemd[1]: Created slice User Slice of UID 500. Oct 28 04:32:25.598409 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 28 04:32:25.600316 systemd-logind[801]: New session 1 of user core. Oct 28 04:32:25.605966 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 28 04:32:25.607437 systemd[1]: Starting User Manager for UID 500... Oct 28 04:32:25.611364 systemd[832]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:25.667223 systemd[832]: Queued start job for default target Main User Target. Oct 28 04:32:25.667404 systemd[832]: Reached target Paths. Oct 28 04:32:25.667419 systemd[832]: Reached target Sockets. Oct 28 04:32:25.667430 systemd[832]: Reached target Timers. Oct 28 04:32:25.667440 systemd[832]: Reached target Basic System. Oct 28 04:32:25.667574 systemd[1]: Started User Manager for UID 500. Oct 28 04:32:25.668234 systemd[832]: Reached target Main User Target. Oct 28 04:32:25.668270 systemd[832]: Startup finished in 50ms. Oct 28 04:32:25.678753 systemd[1]: Started Session 1 of User core. Oct 28 04:32:25.742225 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36764). Oct 28 04:32:25.783962 sshd[841]: Accepted publickey for core from 10.0.0.1 port 36764 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:25.785363 sshd[841]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:25.788220 systemd-logind[801]: New session 2 of user core. Oct 28 04:32:25.801721 systemd[1]: Started Session 2 of User core. Oct 28 04:32:25.855067 sshd[841]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:25.863615 systemd[1]: sshd@1-10.0.0.5:22-10.0.0.1:36764.service: Deactivated successfully. Oct 28 04:32:25.864308 systemd[1]: session-2.scope: Deactivated successfully. Oct 28 04:32:25.864973 systemd-logind[801]: Session 2 logged out. Waiting for processes to exit. Oct 28 04:32:25.866046 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36778). Oct 28 04:32:25.866739 systemd-logind[801]: Removed session 2. Oct 28 04:32:25.908029 sshd[847]: Accepted publickey for core from 10.0.0.1 port 36778 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:25.909098 sshd[847]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:25.912137 systemd-logind[801]: New session 3 of user core. Oct 28 04:32:25.924706 systemd[1]: Started Session 3 of User core. Oct 28 04:32:25.973710 sshd[847]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:25.984774 systemd[1]: sshd@2-10.0.0.5:22-10.0.0.1:36778.service: Deactivated successfully. Oct 28 04:32:25.985443 systemd[1]: session-3.scope: Deactivated successfully. Oct 28 04:32:25.986113 systemd-logind[801]: Session 3 logged out. Waiting for processes to exit. Oct 28 04:32:25.987168 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36794). Oct 28 04:32:25.988044 systemd-logind[801]: Removed session 3. Oct 28 04:32:26.028953 sshd[854]: Accepted publickey for core from 10.0.0.1 port 36794 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:26.030062 sshd[854]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:26.032877 systemd-logind[801]: New session 4 of user core. Oct 28 04:32:26.044731 systemd[1]: Started Session 4 of User core. Oct 28 04:32:26.097118 sshd[854]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:26.108236 systemd[1]: sshd@3-10.0.0.5:22-10.0.0.1:36794.service: Deactivated successfully. Oct 28 04:32:26.108814 systemd[1]: session-4.scope: Deactivated successfully. Oct 28 04:32:26.109422 systemd-logind[801]: Session 4 logged out. Waiting for processes to exit. Oct 28 04:32:26.110466 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36798). Oct 28 04:32:26.111110 systemd-logind[801]: Removed session 4. Oct 28 04:32:26.154063 sshd[860]: Accepted publickey for core from 10.0.0.1 port 36798 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:26.155091 sshd[860]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:26.157946 systemd-logind[801]: New session 5 of user core. Oct 28 04:32:26.168700 systemd[1]: Started Session 5 of User core. Oct 28 04:32:26.225085 sudo[864]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 28 04:32:26.225309 sudo[864]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:32:26.237035 sudo[864]: pam_unix(sudo:session): session closed for user root Oct 28 04:32:26.239657 sshd[860]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:26.252385 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36800). Oct 28 04:32:26.254570 dbus-daemon[788]: [system] Reloaded configuration Oct 28 04:32:26.257038 systemd[1]: sshd@4-10.0.0.5:22-10.0.0.1:36798.service: Deactivated successfully. Oct 28 04:32:26.257784 systemd[1]: session-5.scope: Deactivated successfully. Oct 28 04:32:26.258375 systemd-logind[801]: Session 5 logged out. Waiting for processes to exit. Oct 28 04:32:26.259037 systemd-logind[801]: Removed session 5. Oct 28 04:32:26.294156 sshd[867]: Accepted publickey for core from 10.0.0.1 port 36800 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:26.295505 sshd[867]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:26.299088 systemd-logind[801]: New session 6 of user core. Oct 28 04:32:26.309986 systemd[1]: Started Session 6 of User core. Oct 28 04:32:26.362374 sudo[872]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 28 04:32:26.362629 sudo[872]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:32:26.365164 sudo[872]: pam_unix(sudo:session): session closed for user root Oct 28 04:32:26.369234 sudo[871]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 28 04:32:26.369726 sudo[871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:32:26.385647 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 04:32:26.385000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 28 04:32:26.386923 auditctl[875]: No rules Oct 28 04:32:26.387230 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 04:32:26.387473 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 04:32:26.388897 systemd[1]: Starting Load Security Auditing Rules... Oct 28 04:32:26.389521 kernel: kauditd_printk_skb: 37 callbacks suppressed Oct 28 04:32:26.389578 kernel: audit: type=1305 audit(1761625946.385:48): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 28 04:32:26.404651 augenrules[892]: No rules Oct 28 04:32:26.405406 systemd[1]: Finished Load Security Auditing Rules. Oct 28 04:32:26.406663 sudo[871]: pam_unix(sudo:session): session closed for user root Oct 28 04:32:26.407975 sshd[867]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:26.422300 systemd[1]: sshd@5-10.0.0.5:22-10.0.0.1:36800.service: Deactivated successfully. Oct 28 04:32:26.422873 systemd[1]: session-6.scope: Deactivated successfully. Oct 28 04:32:26.423509 systemd-logind[801]: Session 6 logged out. Waiting for processes to exit. Oct 28 04:32:26.424515 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36816). Oct 28 04:32:26.425341 systemd-logind[801]: Removed session 6. Oct 28 04:32:26.429764 systemd-networkd[726]: eth0: Gained IPv6LL Oct 28 04:32:26.467126 sshd[898]: Accepted publickey for core from 10.0.0.1 port 36816 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:26.471226 sshd[898]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:26.471556 kernel: audit: type=1006 audit(1761625946.468:49): pid=898 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Oct 28 04:32:26.473910 systemd-logind[801]: New session 7 of user core. Oct 28 04:32:26.482754 systemd[1]: Started Session 7 of User core. Oct 28 04:32:26.532407 sshd[898]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:26.545290 systemd[1]: sshd@6-10.0.0.5:22-10.0.0.1:36816.service: Deactivated successfully. Oct 28 04:32:26.545934 systemd[1]: session-7.scope: Deactivated successfully. Oct 28 04:32:26.546949 systemd-logind[801]: Session 7 logged out. Waiting for processes to exit. Oct 28 04:32:26.548075 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36822). Oct 28 04:32:26.548682 systemd-logind[801]: Removed session 7. Oct 28 04:32:26.589917 sshd[904]: Accepted publickey for core from 10.0.0.1 port 36822 ssh2: RSA SHA256:bOc8xVH1MkVC5wseAgNLwD0Qx60lWF3ui6q8Qvy+lQQ Oct 28 04:32:26.591077 sshd[904]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:32:26.593551 kernel: audit: type=1006 audit(1761625946.589:50): pid=904 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Oct 28 04:32:26.595134 systemd-logind[801]: New session 8 of user core. Oct 28 04:32:26.613736 systemd[1]: Started Session 8 of User core. Oct 28 04:32:26.662163 sshd[904]: pam_unix(sshd:session): session closed for user core Oct 28 04:32:26.664284 systemd[1]: sshd@7-10.0.0.5:22-10.0.0.1:36822.service: Deactivated successfully. Oct 28 04:32:26.664979 systemd[1]: session-8.scope: Deactivated successfully. Oct 28 04:32:26.665599 systemd-logind[801]: Session 8 logged out. Waiting for processes to exit. Oct 28 04:32:26.666273 systemd-logind[801]: Removed session 8.