Oct 28 04:46:05.689839 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 28 04:46:05.689860 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:46:05.689869 kernel: efi: EFI v2.70 by EDK II Oct 28 04:46:05.689876 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 28 04:46:05.689880 kernel: efi: seeding entropy pool Oct 28 04:46:05.689885 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 28 04:46:05.689892 kernel: ACPI: Early table checksum verification disabled Oct 28 04:46:05.689897 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 28 04:46:05.689902 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 28 04:46:05.689907 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:05.689914 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:05.689919 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:05.689925 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:05.689930 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:05.689937 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:05.689943 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:05.689950 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:05.689956 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:05.689962 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 28 04:46:05.689967 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 28 04:46:05.689973 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:46:05.689979 kernel: NUMA: NODE_DATA [mem 0xdc959900-0xdc95efff] Oct 28 04:46:05.689984 kernel: Zone ranges: Oct 28 04:46:05.689990 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:46:05.689996 kernel: DMA32 empty Oct 28 04:46:05.690001 kernel: Normal empty Oct 28 04:46:05.690006 kernel: Movable zone start for each node Oct 28 04:46:05.690012 kernel: Early memory node ranges Oct 28 04:46:05.690018 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 28 04:46:05.690023 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 28 04:46:05.690029 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 28 04:46:05.690035 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 28 04:46:05.690040 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 28 04:46:05.690045 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 28 04:46:05.690051 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 28 04:46:05.690057 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 28 04:46:05.690062 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 28 04:46:05.690067 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 28 04:46:05.690072 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 28 04:46:05.690078 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:46:05.690087 kernel: On node 0 totalpages: 643072 Oct 28 04:46:05.690093 kernel: DMA zone: 10048 pages used for memmap Oct 28 04:46:05.690099 kernel: DMA zone: 0 pages reserved Oct 28 04:46:05.690105 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 28 04:46:05.690110 kernel: psci: probing for conduit method from ACPI. Oct 28 04:46:05.690116 kernel: psci: PSCIv1.1 detected in firmware. Oct 28 04:46:05.690122 kernel: psci: Using standard PSCI v0.2 function IDs Oct 28 04:46:05.690128 kernel: psci: Trusted OS migration not required Oct 28 04:46:05.690136 kernel: psci: SMC Calling Convention v1.1 Oct 28 04:46:05.690142 kernel: ACPI: SRAT not present Oct 28 04:46:05.690148 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 28 04:46:05.690155 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 28 04:46:05.690172 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 28 04:46:05.690202 kernel: Detected PIPT I-cache on CPU0 Oct 28 04:46:05.690210 kernel: CPU features: detected: GIC system register CPU interface Oct 28 04:46:05.690216 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 28 04:46:05.690222 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 28 04:46:05.690228 kernel: CPU features: detected: Hardware dirty bit management Oct 28 04:46:05.690233 kernel: CPU features: detected: Spectre-v4 Oct 28 04:46:05.690242 kernel: CPU features: detected: ARM erratum 1418040 Oct 28 04:46:05.690248 kernel: CPU features: detected: Spectre-BHB Oct 28 04:46:05.690254 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 28 04:46:05.690260 kernel: Policy zone: DMA Oct 28 04:46:05.690267 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:46:05.690273 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 28 04:46:05.690279 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 28 04:46:05.690285 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 28 04:46:05.690291 kernel: Memory: 2452096K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120192K reserved, 0K cma-reserved) Oct 28 04:46:05.690297 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 28 04:46:05.690303 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 28 04:46:05.690310 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 28 04:46:05.690317 kernel: rcu: RCU event tracing is enabled. Oct 28 04:46:05.690323 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 28 04:46:05.690330 kernel: Trampoline variant of Tasks RCU enabled. Oct 28 04:46:05.690336 kernel: Tracing variant of Tasks RCU enabled. Oct 28 04:46:05.690342 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 28 04:46:05.690348 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 28 04:46:05.690354 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 28 04:46:05.690360 kernel: GICv3: 256 SPIs implemented Oct 28 04:46:05.690366 kernel: GICv3: 0 Extended SPIs implemented Oct 28 04:46:05.690371 kernel: GICv3: Distributor has no Range Selector support Oct 28 04:46:05.690377 kernel: GICv3: 16 PPIs implemented Oct 28 04:46:05.690385 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 28 04:46:05.690390 kernel: ACPI: SRAT not present Oct 28 04:46:05.690396 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 28 04:46:05.690402 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 28 04:46:05.690408 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 28 04:46:05.690414 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 28 04:46:05.690420 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 28 04:46:05.690426 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:46:05.690432 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 28 04:46:05.690438 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 28 04:46:05.690444 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 28 04:46:05.690450 kernel: arm-pv: using stolen time PV Oct 28 04:46:05.690458 kernel: Console: colour dummy device 80x25 Oct 28 04:46:05.690464 kernel: ACPI: Core revision 20200925 Oct 28 04:46:05.690470 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 28 04:46:05.690477 kernel: pid_max: default: 32768 minimum: 301 Oct 28 04:46:05.690483 kernel: LSM: Security Framework initializing Oct 28 04:46:05.690489 kernel: SELinux: Initializing. Oct 28 04:46:05.690496 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:46:05.690502 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:46:05.690508 kernel: rcu: Hierarchical SRCU implementation. Oct 28 04:46:05.690515 kernel: Platform MSI: ITS@0x8080000 domain created Oct 28 04:46:05.690521 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 28 04:46:05.690528 kernel: Remapping and enabling EFI services. Oct 28 04:46:05.690534 kernel: smp: Bringing up secondary CPUs ... Oct 28 04:46:05.690540 kernel: Detected PIPT I-cache on CPU1 Oct 28 04:46:05.690547 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 28 04:46:05.690553 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 28 04:46:05.690559 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:46:05.690566 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 28 04:46:05.690572 kernel: Detected PIPT I-cache on CPU2 Oct 28 04:46:05.690579 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 28 04:46:05.690586 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 28 04:46:05.690592 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:46:05.690598 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 28 04:46:05.690604 kernel: Detected PIPT I-cache on CPU3 Oct 28 04:46:05.690616 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 28 04:46:05.690623 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 28 04:46:05.690631 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:46:05.690637 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 28 04:46:05.690643 kernel: smp: Brought up 1 node, 4 CPUs Oct 28 04:46:05.690650 kernel: SMP: Total of 4 processors activated. Oct 28 04:46:05.690656 kernel: CPU features: detected: Privileged Access Never Oct 28 04:46:05.690663 kernel: CPU features: detected: LSE atomic instructions Oct 28 04:46:05.690669 kernel: CPU features: detected: User Access Override Oct 28 04:46:05.690676 kernel: CPU features: detected: 32-bit EL0 Support Oct 28 04:46:05.690683 kernel: CPU features: detected: Common not Private translations Oct 28 04:46:05.690689 kernel: CPU features: detected: RAS Extension Support Oct 28 04:46:05.690697 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 28 04:46:05.690704 kernel: CPU features: detected: CRC32 instructions Oct 28 04:46:05.690711 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 28 04:46:05.690718 kernel: CPU: All CPU(s) started at EL1 Oct 28 04:46:05.690724 kernel: alternatives: patching kernel code Oct 28 04:46:05.690731 kernel: devtmpfs: initialized Oct 28 04:46:05.690738 kernel: KASLR enabled Oct 28 04:46:05.690744 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 28 04:46:05.690750 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 28 04:46:05.690756 kernel: pinctrl core: initialized pinctrl subsystem Oct 28 04:46:05.690763 kernel: SMBIOS 3.0.0 present. Oct 28 04:46:05.690769 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 28 04:46:05.690775 kernel: NET: Registered protocol family 16 Oct 28 04:46:05.690782 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 28 04:46:05.690788 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 28 04:46:05.690796 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 28 04:46:05.690803 kernel: audit: initializing netlink subsys (disabled) Oct 28 04:46:05.690809 kernel: audit: type=2000 audit(0.031:1): state=initialized audit_enabled=0 res=1 Oct 28 04:46:05.690815 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 28 04:46:05.690821 kernel: cpuidle: using governor menu Oct 28 04:46:05.690828 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 28 04:46:05.690835 kernel: ASID allocator initialised with 32768 entries Oct 28 04:46:05.690841 kernel: ACPI: bus type PCI registered Oct 28 04:46:05.690847 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 28 04:46:05.690854 kernel: Serial: AMBA PL011 UART driver Oct 28 04:46:05.690860 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 28 04:46:05.690867 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 28 04:46:05.690873 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 28 04:46:05.690879 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 28 04:46:05.690885 kernel: cryptd: max_cpu_qlen set to 1000 Oct 28 04:46:05.690891 kernel: ACPI: Added _OSI(Module Device) Oct 28 04:46:05.690898 kernel: ACPI: Added _OSI(Processor Device) Oct 28 04:46:05.690904 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 28 04:46:05.690912 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 28 04:46:05.690919 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 28 04:46:05.690926 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 28 04:46:05.690932 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 28 04:46:05.690938 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 28 04:46:05.690945 kernel: ACPI: Interpreter enabled Oct 28 04:46:05.690951 kernel: ACPI: Using GIC for interrupt routing Oct 28 04:46:05.690957 kernel: ACPI: MCFG table detected, 1 entries Oct 28 04:46:05.690964 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 28 04:46:05.690970 kernel: printk: console [ttyAMA0] enabled Oct 28 04:46:05.690977 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 28 04:46:05.691104 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 28 04:46:05.691186 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 28 04:46:05.691250 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 28 04:46:05.691306 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 28 04:46:05.691365 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 28 04:46:05.691374 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 28 04:46:05.691383 kernel: PCI host bridge to bus 0000:00 Oct 28 04:46:05.691445 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 28 04:46:05.691496 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 28 04:46:05.691547 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 28 04:46:05.691595 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 28 04:46:05.691665 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 28 04:46:05.691733 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 28 04:46:05.691797 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 28 04:46:05.691865 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 28 04:46:05.691921 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 04:46:05.691978 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 04:46:05.692034 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 28 04:46:05.692094 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 28 04:46:05.692147 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 28 04:46:05.692221 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 28 04:46:05.692275 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 28 04:46:05.692283 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 28 04:46:05.692289 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 28 04:46:05.692296 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 28 04:46:05.692302 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 28 04:46:05.692308 kernel: vgaarb: loaded Oct 28 04:46:05.692314 kernel: Registered efivars operations Oct 28 04:46:05.692320 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 28 04:46:05.692329 kernel: VFS: Disk quotas dquot_6.6.0 Oct 28 04:46:05.692335 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 28 04:46:05.692342 kernel: pnp: PnP ACPI init Oct 28 04:46:05.692409 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 28 04:46:05.692464 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 28 04:46:05.692472 kernel: pnp: PnP ACPI: found 1 devices Oct 28 04:46:05.692478 kernel: NET: Registered protocol family 2 Oct 28 04:46:05.692485 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 28 04:46:05.692493 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 28 04:46:05.692500 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 28 04:46:05.692506 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 28 04:46:05.692512 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 28 04:46:05.692518 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:46:05.692525 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:46:05.692531 kernel: NET: Registered protocol family 1 Oct 28 04:46:05.692538 kernel: PCI: CLS 0 bytes, default 64 Oct 28 04:46:05.692544 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 28 04:46:05.692552 kernel: kvm [1]: HYP mode not available Oct 28 04:46:05.692558 kernel: Initialise system trusted keyrings Oct 28 04:46:05.692564 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 28 04:46:05.692571 kernel: Key type asymmetric registered Oct 28 04:46:05.692577 kernel: Asymmetric key parser 'x509' registered Oct 28 04:46:05.692583 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 28 04:46:05.692589 kernel: io scheduler mq-deadline registered Oct 28 04:46:05.692596 kernel: io scheduler kyber registered Oct 28 04:46:05.692602 kernel: io scheduler bfq registered Oct 28 04:46:05.692609 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 28 04:46:05.692616 kernel: ACPI: Power Button [PWRB] Oct 28 04:46:05.692622 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 28 04:46:05.692677 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 28 04:46:05.692685 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 28 04:46:05.692691 kernel: msm_serial: driver initialized Oct 28 04:46:05.692697 kernel: random: fast init done Oct 28 04:46:05.692703 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 28 04:46:05.692710 kernel: random: crng init done Oct 28 04:46:05.692716 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 28 04:46:05.692724 kernel: thunder_xcv, ver 1.0 Oct 28 04:46:05.692730 kernel: thunder_bgx, ver 1.0 Oct 28 04:46:05.692737 kernel: nicpf, ver 1.0 Oct 28 04:46:05.692743 kernel: nicvf, ver 1.0 Oct 28 04:46:05.692806 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 28 04:46:05.692859 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-28T04:46:05 UTC (1761626765) Oct 28 04:46:05.692868 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 28 04:46:05.692874 kernel: NET: Registered protocol family 10 Oct 28 04:46:05.692881 kernel: Segment Routing with IPv6 Oct 28 04:46:05.692888 kernel: NET: Registered protocol family 17 Oct 28 04:46:05.692894 kernel: Key type dns_resolver registered Oct 28 04:46:05.692900 kernel: registered taskstats version 1 Oct 28 04:46:05.692907 kernel: Loading compiled-in X.509 certificates Oct 28 04:46:05.692913 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 28 04:46:05.692919 kernel: Key type ._fscrypt registered Oct 28 04:46:05.692926 kernel: Key type .fscrypt registered Oct 28 04:46:05.692932 kernel: Key type fscrypt-provisioning registered Oct 28 04:46:05.692939 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 28 04:46:05.692945 kernel: ima: Allocated hash algorithm: sha1 Oct 28 04:46:05.692952 kernel: ima: No architecture policies found Oct 28 04:46:05.692958 kernel: Freeing unused kernel memory: 34240K Oct 28 04:46:05.692964 kernel: Run /init as init process Oct 28 04:46:05.692970 kernel: with arguments: Oct 28 04:46:05.692976 kernel: /init Oct 28 04:46:05.692982 kernel: with environment: Oct 28 04:46:05.692987 kernel: HOME=/ Oct 28 04:46:05.692993 kernel: TERM=linux Oct 28 04:46:05.693001 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 28 04:46:05.693009 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:46:05.693017 systemd[1]: Detected virtualization kvm. Oct 28 04:46:05.693024 systemd[1]: Detected architecture arm64. Oct 28 04:46:05.693031 systemd[1]: Running in initial RAM disk. Oct 28 04:46:05.693038 systemd[1]: No hostname configured, using default hostname. Oct 28 04:46:05.693044 systemd[1]: Hostname set to . Oct 28 04:46:05.693053 systemd[1]: Initializing machine ID from VM UUID. Oct 28 04:46:05.693060 systemd[1]: Queued start job for default target Initrd Default Target. Oct 28 04:46:05.693067 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 04:46:05.693073 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 04:46:05.693080 systemd[1]: Reached target Path Units. Oct 28 04:46:05.693087 systemd[1]: Reached target Slice Units. Oct 28 04:46:05.693094 systemd[1]: Reached target Swaps. Oct 28 04:46:05.693101 systemd[1]: Reached target Timer Units. Oct 28 04:46:05.693109 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 28 04:46:05.693116 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 28 04:46:05.693123 systemd[1]: Listening on Journal Audit Socket. Oct 28 04:46:05.693130 systemd[1]: Listening on Journal Socket (/dev/log). Oct 28 04:46:05.693137 systemd[1]: Listening on Journal Socket. Oct 28 04:46:05.693158 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 04:46:05.693222 systemd[1]: Listening on udev Control Socket. Oct 28 04:46:05.693229 systemd[1]: Listening on udev Kernel Socket. Oct 28 04:46:05.693236 systemd[1]: Reached target Socket Units. Oct 28 04:46:05.693245 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 04:46:05.693252 systemd[1]: Finished Network Cleanup. Oct 28 04:46:05.693259 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 28 04:46:05.693266 systemd[1]: Starting Journal Service... Oct 28 04:46:05.693273 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 04:46:05.693280 systemd[1]: Starting Apply Kernel Variables... Oct 28 04:46:05.693287 systemd[1]: Starting Setup Virtual Console... Oct 28 04:46:05.693294 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 04:46:05.693301 systemd[1]: Finished Apply Kernel Variables. Oct 28 04:46:05.693308 systemd[1]: Finished Setup Virtual Console. Oct 28 04:46:05.693316 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 28 04:46:05.693326 systemd-journald[279]: Journal started Oct 28 04:46:05.693366 systemd-journald[279]: Runtime Journal (/run/log/journal/419b7e9678d1437eaeffbe6d8914f0ff) is 6.0M, max 48.5M, 42.4M free. Oct 28 04:46:05.696449 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 04:46:05.698191 systemd[1]: Started Journal Service. Oct 28 04:46:05.698527 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 04:46:05.709000 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 28 04:46:05.710850 systemd[1]: Starting dracut cmdline hook... Oct 28 04:46:05.719856 dracut-cmdline[295]: dracut-dracut-053 Oct 28 04:46:05.722054 dracut-cmdline[295]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 28 04:46:05.780195 kernel: SCSI subsystem initialized Oct 28 04:46:05.784182 kernel: Loading iSCSI transport class v2.0-870. Oct 28 04:46:05.790186 kernel: iscsi: registered transport (tcp) Oct 28 04:46:05.801443 kernel: iscsi: registered transport (qla4xxx) Oct 28 04:46:05.801460 kernel: QLogic iSCSI HBA Driver Oct 28 04:46:05.811762 systemd[1]: Finished dracut cmdline hook. Oct 28 04:46:05.813452 systemd[1]: Starting dracut pre-udev hook... Oct 28 04:46:05.827471 kernel: device-mapper: uevent: version 1.0.3 Oct 28 04:46:05.827521 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 28 04:46:05.863207 kernel: raid6: neonx8 gen() 13788 MB/s Oct 28 04:46:05.880191 kernel: raid6: neonx8 xor() 10741 MB/s Oct 28 04:46:05.897191 kernel: raid6: neonx4 gen() 13671 MB/s Oct 28 04:46:05.914204 kernel: raid6: neonx4 xor() 11478 MB/s Oct 28 04:46:05.931184 kernel: raid6: neonx2 gen() 13019 MB/s Oct 28 04:46:05.948195 kernel: raid6: neonx2 xor() 9842 MB/s Oct 28 04:46:05.965193 kernel: raid6: neonx1 gen() 10781 MB/s Oct 28 04:46:05.982197 kernel: raid6: neonx1 xor() 8823 MB/s Oct 28 04:46:05.999189 kernel: raid6: int64x8 gen() 6826 MB/s Oct 28 04:46:06.016193 kernel: raid6: int64x8 xor() 3796 MB/s Oct 28 04:46:06.033191 kernel: raid6: int64x4 gen() 6914 MB/s Oct 28 04:46:06.050190 kernel: raid6: int64x4 xor() 3835 MB/s Oct 28 04:46:06.067196 kernel: raid6: int64x2 gen() 6187 MB/s Oct 28 04:46:06.084186 kernel: raid6: int64x2 xor() 3318 MB/s Oct 28 04:46:06.101188 kernel: raid6: int64x1 gen() 5011 MB/s Oct 28 04:46:06.118354 kernel: raid6: int64x1 xor() 2597 MB/s Oct 28 04:46:06.118369 kernel: raid6: using algorithm neonx8 gen() 13788 MB/s Oct 28 04:46:06.118377 kernel: raid6: .... xor() 10741 MB/s, rmw enabled Oct 28 04:46:06.119545 kernel: raid6: using neon recovery algorithm Oct 28 04:46:06.129194 kernel: xor: measuring software checksum speed Oct 28 04:46:06.130189 kernel: 8regs : 17159 MB/sec Oct 28 04:46:06.131195 kernel: 32regs : 20749 MB/sec Oct 28 04:46:06.132434 kernel: arm64_neon : 29184 MB/sec Oct 28 04:46:06.132444 kernel: xor: using function: arm64_neon (29184 MB/sec) Oct 28 04:46:06.178191 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 28 04:46:06.188542 systemd[1]: Finished dracut pre-udev hook. Oct 28 04:46:06.189000 audit: BPF prog-id=6 op=LOAD Oct 28 04:46:06.190000 audit: BPF prog-id=7 op=LOAD Oct 28 04:46:06.191794 kernel: audit: type=1334 audit(1761626766.189:2): prog-id=6 op=LOAD Oct 28 04:46:06.191816 kernel: audit: type=1334 audit(1761626766.190:3): prog-id=7 op=LOAD Oct 28 04:46:06.191825 kernel: audit: type=1334 audit(1761626766.191:4): prog-id=8 op=LOAD Oct 28 04:46:06.191000 audit: BPF prog-id=8 op=LOAD Oct 28 04:46:06.192194 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 04:46:06.204077 systemd-udevd[413]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 04:46:06.205823 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 04:46:06.208061 systemd[1]: Starting dracut pre-trigger hook... Oct 28 04:46:06.212819 kernel: audit: type=1334 audit(1761626766.209:5): prog-id=9 op=LOAD Oct 28 04:46:06.209000 audit: BPF prog-id=9 op=LOAD Oct 28 04:46:06.210350 systemd[1]: Starting Network Configuration... Oct 28 04:46:06.221274 dracut-pre-trigger[420]: rd.md=0: removing MD RAID activation Oct 28 04:46:06.227099 systemd-networkd[426]: lo: Link UP Oct 28 04:46:06.227106 systemd-networkd[426]: lo: Gained carrier Oct 28 04:46:06.227420 systemd-networkd[426]: Enumeration completed Oct 28 04:46:06.227496 systemd[1]: Started Network Configuration. Oct 28 04:46:06.229000 audit: BPF prog-id=10 op=LOAD Oct 28 04:46:06.229803 systemd[1]: Starting Network Name Resolution... Oct 28 04:46:06.233335 kernel: audit: type=1334 audit(1761626766.229:6): prog-id=10 op=LOAD Oct 28 04:46:06.250492 systemd[1]: Finished dracut pre-trigger hook. Oct 28 04:46:06.252278 systemd[1]: Starting Coldplug All udev Devices... Oct 28 04:46:06.261544 systemd-resolved[441]: Positive Trust Anchors: Oct 28 04:46:06.261560 systemd-resolved[441]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 04:46:06.261589 systemd-resolved[441]: 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:46:06.261868 systemd-resolved[441]: Defaulting to hostname 'linux'. Oct 28 04:46:06.262641 systemd-udevd[413]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 04:46:06.263340 systemd[1]: Started Network Name Resolution. Oct 28 04:46:06.265491 systemd[1]: Reached target Network. Oct 28 04:46:06.273900 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 04:46:06.276290 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 28 04:46:06.283088 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 28 04:46:06.284738 systemd[1]: Starting Open-iSCSI... Oct 28 04:46:06.286555 systemd[1]: Finished Coldplug All udev Devices. Oct 28 04:46:06.288248 iscsid[482]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 28 04:46:06.288248 iscsid[482]: 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:46:06.288248 iscsid[482]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 28 04:46:06.288248 iscsid[482]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 28 04:46:06.288248 iscsid[482]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 28 04:46:06.288248 iscsid[482]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 28 04:46:06.291088 systemd[1]: Started Open-iSCSI. Oct 28 04:46:06.296907 systemd[1]: Starting dracut initqueue hook... Oct 28 04:46:06.318814 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 28 04:46:06.318932 kernel: vda: detected capacity change from 0 to 4756340736 Oct 28 04:46:06.336190 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 04:46:06.338038 systemd-udevd[462]: Using default interface naming scheme 'v249'. Oct 28 04:46:06.343363 systemd-networkd[426]: eth0: Link UP Oct 28 04:46:06.360187 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (472) Oct 28 04:46:06.364532 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 28 04:46:06.365732 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 28 04:46:06.371314 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Oct 28 04:46:06.374215 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 28 04:46:06.377335 systemd[1]: Found device /dev/disk/by-label/OEM. Oct 28 04:46:06.378439 systemd[1]: Finished dracut initqueue hook. Oct 28 04:46:06.379763 systemd[1]: Reached target Initrd Root Device. Oct 28 04:46:06.381030 systemd[1]: Reached target Preparation for Remote File Systems. Oct 28 04:46:06.382757 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 04:46:06.384433 systemd[1]: Reached target Remote File Systems. Oct 28 04:46:06.386702 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 28 04:46:06.388358 systemd[1]: Starting dracut pre-mount hook... Oct 28 04:46:06.395194 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 04:46:06.396580 systemd[1]: Finished dracut pre-mount hook. Oct 28 04:46:07.364225 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 28 04:46:07.364110 systemd-networkd[426]: eth0: Gained carrier Oct 28 04:46:07.370229 systemd-networkd[426]: eth0: DHCPv4 address 10.0.0.8/16 via 10.0.0.1 Oct 28 04:46:07.404632 disk-uuid[503]: The operation has completed successfully. Oct 28 04:46:07.406271 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 04:46:07.424419 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 28 04:46:07.424539 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 28 04:46:07.426299 systemd[1]: Starting Ignition (setup)... Oct 28 04:46:07.434185 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 04:46:07.434237 kernel: BTRFS info (device vda6): has skinny extents Oct 28 04:46:07.439958 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 28 04:46:07.445762 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 28 04:46:07.445875 systemd[1]: Finished Ignition (setup). Oct 28 04:46:07.448236 systemd[1]: Starting Ignition (disks)... Oct 28 04:46:07.458315 ignition[540]: Ignition v0.36.1-15-gde4e6cc9 Oct 28 04:46:07.458333 ignition[540]: Stage: disks Oct 28 04:46:07.458343 ignition[540]: reading system config file "/usr/lib/ignition/base.ign" Oct 28 04:46:07.458353 ignition[540]: no config at "/usr/lib/ignition/base.ign" Oct 28 04:46:07.458400 ignition[540]: parsed url from cmdline: "" Oct 28 04:46:07.458404 ignition[540]: no config URL provided Oct 28 04:46:07.458409 ignition[540]: reading system config file "/usr/lib/ignition/user.ign" Oct 28 04:46:07.458417 ignition[540]: no config at "/usr/lib/ignition/user.ign" Oct 28 04:46:07.458437 ignition[540]: op(1): [started] loading QEMU firmware config module Oct 28 04:46:07.458441 ignition[540]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 28 04:46:07.459629 ignition[540]: op(1): [finished] loading QEMU firmware config module Oct 28 04:46:07.473444 ignition[540]: parsing config with SHA512: 412ba49697055948f56d18de7b77b9004a97f33fb7389491521d6181193492f56a8b32495052fd18a80803047112e13108724101ee8b772e26de068ddcd24548 Oct 28 04:46:07.475363 ignition[540]: disks: disks passed Oct 28 04:46:07.475373 ignition[540]: Ignition finished successfully Oct 28 04:46:07.476034 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 28 04:46:07.476153 systemd[1]: Finished Ignition (disks). Oct 28 04:46:07.477684 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 04:46:07.479975 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 28 04:46:07.483834 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 28 04:46:07.489730 systemd-fsck[552]: ROOT: clean, 528/553792 files, 37752/553472 blocks Oct 28 04:46:07.497934 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 28 04:46:07.497135 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 28 04:46:07.499031 systemd[1]: Mounting /sysroot... Oct 28 04:46:07.513866 systemd[1]: Found device /dev/mapper/usr. Oct 28 04:46:07.515888 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 28 04:46:07.518390 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 28 04:46:07.525577 systemd-fsck[568]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 28 04:46:07.525577 systemd-fsck[568]: You must have r/w access to the filesystem or be root Oct 28 04:46:07.529309 systemd-fsck[565]: fsck failed with exit status 8. Oct 28 04:46:07.529323 systemd-fsck[565]: Ignoring error. Oct 28 04:46:07.529995 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 28 04:46:07.532009 systemd[1]: Mounting /sysusr/usr... Oct 28 04:46:07.543024 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 28 04:46:07.543062 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 28 04:46:07.543551 systemd[1]: Mounted /sysroot. Oct 28 04:46:07.544332 systemd[1]: Reached target Initrd Root File System. Oct 28 04:46:07.556192 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 28 04:46:07.556621 systemd[1]: Mounted /sysusr/usr. Oct 28 04:46:07.557422 systemd[1]: Reached target Local File Systems. Oct 28 04:46:07.558766 systemd[1]: Reached target System Initialization. Oct 28 04:46:07.560291 systemd[1]: Reached target Basic System. Oct 28 04:46:07.562827 systemd[1]: Mounting /sysroot/usr... Oct 28 04:46:07.565130 systemd[1]: Mounted /sysroot/usr. Oct 28 04:46:07.567151 systemd[1]: Starting Root filesystem setup... Oct 28 04:46:07.611859 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 28 04:46:07.611984 systemd[1]: Finished Root filesystem setup. Oct 28 04:46:07.614666 systemd[1]: Starting Ignition (files)... Oct 28 04:46:07.615902 systemd[1]: Starting /sysroot/boot... Oct 28 04:46:07.618613 ignition[585]: Ignition v0.36.1-15-gde4e6cc9 Oct 28 04:46:07.618627 ignition[585]: Stage: files Oct 28 04:46:07.618653 ignition[585]: reading system config file "/usr/lib/ignition/base.ign" Oct 28 04:46:07.618669 ignition[585]: no config at "/usr/lib/ignition/base.ign" Oct 28 04:46:07.619361 ignition[585]: files: compiled without relabeling support, skipping Oct 28 04:46:07.635279 systemd[1]: Finished /sysroot/boot. Oct 28 04:46:07.639310 ignition[585]: files: createUsers: op(1): [started] creating or modifying user "core" Oct 28 04:46:07.639323 ignition[585]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Oct 28 04:46:07.641184 ignition[585]: files: createUsers: op(1): [finished] creating or modifying user "core" Oct 28 04:46:07.641196 ignition[585]: files: createUsers: op(2): [started] adding ssh keys to user "core" Oct 28 04:46:07.642245 ignition[585]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Oct 28 04:46:07.643602 systemd[1]: ignition-files.service: Deactivated successfully. Oct 28 04:46:07.642274 ignition[585]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Oct 28 04:46:07.643708 systemd[1]: Finished Ignition (files). Oct 28 04:46:07.642522 ignition[585]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Oct 28 04:46:07.644673 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Oct 28 04:46:07.642530 ignition[585]: files: op(4): [started] processing unit "coreos-metadata.service" Oct 28 04:46:07.645336 systemd[1]: Starting Ignition (record completion)... Oct 28 04:46:07.642635 ignition[585]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 28 04:46:07.647028 systemd[1]: Starting Reload Configuration from the Real Root... Oct 28 04:46:07.642984 ignition[585]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 28 04:46:07.648530 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 28 04:46:07.661000 audit: BPF prog-id=9 op=UNLOAD Oct 28 04:46:07.661000 audit: BPF prog-id=6 op=UNLOAD Oct 28 04:46:07.662000 audit: BPF prog-id=3 op=UNLOAD Oct 28 04:46:07.642989 ignition[585]: files: op(4): [finished] processing unit "coreos-metadata.service" Oct 28 04:46:07.668594 kernel: audit: type=1334 audit(1761626767.661:7): prog-id=9 op=UNLOAD Oct 28 04:46:07.668614 kernel: audit: type=1334 audit(1761626767.661:8): prog-id=6 op=UNLOAD Oct 28 04:46:07.668623 kernel: audit: type=1334 audit(1761626767.662:9): prog-id=3 op=UNLOAD Oct 28 04:46:07.668631 kernel: audit: type=1334 audit(1761626767.662:10): prog-id=10 op=UNLOAD Oct 28 04:46:07.662000 audit: BPF prog-id=10 op=UNLOAD Oct 28 04:46:07.648640 systemd[1]: Finished Ignition (record completion). Oct 28 04:46:07.642994 ignition[585]: files: files passed Oct 28 04:46:07.652311 systemd[1]: Reloading. Oct 28 04:46:07.642998 ignition[585]: Ignition finished successfully Oct 28 04:46:07.748000 audit: BPF prog-id=11 op=LOAD Oct 28 04:46:07.748000 audit: BPF prog-id=12 op=LOAD Oct 28 04:46:07.749000 audit: BPF prog-id=13 op=LOAD Oct 28 04:46:07.749000 audit: BPF prog-id=14 op=LOAD Oct 28 04:46:07.749000 audit: BPF prog-id=7 op=UNLOAD Oct 28 04:46:07.749000 audit: BPF prog-id=8 op=UNLOAD Oct 28 04:46:07.749000 audit: BPF prog-id=15 op=LOAD Oct 28 04:46:07.749000 audit: BPF prog-id=16 op=LOAD Oct 28 04:46:07.749000 audit: BPF prog-id=17 op=LOAD Oct 28 04:46:07.749000 audit: BPF prog-id=4 op=UNLOAD Oct 28 04:46:07.749000 audit: BPF prog-id=5 op=UNLOAD Oct 28 04:46:07.750000 audit: BPF prog-id=18 op=LOAD Oct 28 04:46:07.765505 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 28 04:46:07.765630 systemd[1]: Finished Reload Configuration from the Real Root. Oct 28 04:46:07.767801 systemd[1]: Reached target Initrd File Systems. Oct 28 04:46:07.769455 systemd[1]: Reached target Initrd Default Target. Oct 28 04:46:07.771121 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 28 04:46:07.771853 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 28 04:46:07.782559 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 28 04:46:07.784236 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 28 04:46:07.790448 systemd[1]: Stopped target Host and Network Name Lookups. Oct 28 04:46:07.792313 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 04:46:07.793295 systemd[1]: Stopped target Timer Units. Oct 28 04:46:07.794792 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 28 04:46:07.794915 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 28 04:46:07.796279 systemd[1]: Stopped target Initrd Default Target. Oct 28 04:46:07.797956 systemd[1]: Stopped target Basic System. Oct 28 04:46:07.799409 systemd[1]: Stopped target Initrd Root Device. Oct 28 04:46:07.800854 systemd[1]: Stopped target Path Units. Oct 28 04:46:07.802121 systemd[1]: Stopped target Remote File Systems. Oct 28 04:46:07.803608 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 28 04:46:07.805134 systemd[1]: Stopped target Slice Units. Oct 28 04:46:07.806530 systemd[1]: Stopped target Socket Units. Oct 28 04:46:07.808010 systemd[1]: Stopped target System Initialization. Oct 28 04:46:07.809444 systemd[1]: Stopped target Local File Systems. Oct 28 04:46:07.810798 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 04:46:07.812470 systemd[1]: Stopped target Swaps. Oct 28 04:46:07.813756 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 28 04:46:07.813862 systemd[1]: Stopped dracut pre-mount hook. Oct 28 04:46:07.815354 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 04:46:07.816589 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 04:46:07.821214 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 04:46:07.822502 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 28 04:46:07.822611 systemd[1]: Stopped dracut initqueue hook. Oct 28 04:46:07.826460 iscsid[482]: iscsid shutting down. Oct 28 04:46:07.824404 systemd[1]: Stopping Open-iSCSI... Oct 28 04:46:07.826375 systemd[1]: Stopping /sysroot/boot... Oct 28 04:46:07.826991 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 28 04:46:07.827120 systemd[1]: Stopped Coldplug All udev Devices. Oct 28 04:46:07.828396 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 28 04:46:07.828478 systemd[1]: Stopped dracut pre-trigger hook. Oct 28 04:46:07.830584 systemd[1]: iscsid.service: Deactivated successfully. Oct 28 04:46:07.830728 systemd[1]: Stopped Open-iSCSI. Oct 28 04:46:07.832460 systemd[1]: iscsid.socket: Deactivated successfully. Oct 28 04:46:07.832522 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 28 04:46:07.834248 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 28 04:46:07.837090 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 28 04:46:07.837284 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 28 04:46:07.838577 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 28 04:46:07.838687 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 28 04:46:07.840256 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 28 04:46:07.840366 systemd[1]: Stopped /sysroot/boot. Oct 28 04:46:07.841924 systemd[1]: Stopped target Network. Oct 28 04:46:07.842721 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 28 04:46:07.842779 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 28 04:46:07.844196 systemd[1]: Stopping Network Name Resolution... Oct 28 04:46:07.850271 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 28 04:46:07.850392 systemd[1]: Stopped Network Name Resolution. Oct 28 04:46:07.852078 systemd[1]: Stopping Network Configuration... Oct 28 04:46:07.858000 audit: BPF prog-id=18 op=UNLOAD Oct 28 04:46:07.856283 systemd-networkd[426]: eth0: DHCP lease lost Oct 28 04:46:07.862207 systemd-networkd[426]: eth0: DHCPv6 lease lost Oct 28 04:46:07.863248 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 28 04:46:07.863375 systemd[1]: Stopped Network Configuration. Oct 28 04:46:07.865110 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 28 04:46:07.865139 systemd[1]: Closed Network Service Netlink Socket. Oct 28 04:46:07.867039 systemd[1]: Stopping Network Cleanup... Oct 28 04:46:07.871000 audit: BPF prog-id=11 op=UNLOAD Oct 28 04:46:07.867846 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 04:46:07.867914 systemd[1]: Stopped Apply Kernel Variables. Oct 28 04:46:07.869452 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 28 04:46:07.875115 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 28 04:46:07.875247 systemd[1]: Stopped Network Cleanup. Oct 28 04:46:07.877979 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 28 04:46:07.878100 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 28 04:46:07.879612 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 28 04:46:07.879646 systemd[1]: Closed udev Control Socket. Oct 28 04:46:07.880997 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 28 04:46:07.885000 audit: BPF prog-id=12 op=UNLOAD Oct 28 04:46:07.881031 systemd[1]: Closed udev Kernel Socket. Oct 28 04:46:07.882608 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 28 04:46:07.882653 systemd[1]: Stopped dracut pre-udev hook. Oct 28 04:46:07.884193 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 28 04:46:07.884238 systemd[1]: Stopped dracut cmdline hook. Oct 28 04:46:07.885588 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 28 04:46:07.885627 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 28 04:46:07.888035 systemd[1]: Starting Cleanup udev Database... Oct 28 04:46:07.888969 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 28 04:46:07.890519 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 04:46:07.890574 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 04:46:07.892178 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 28 04:46:07.892224 systemd[1]: Stopped Create List of Static Device Nodes. Oct 28 04:46:07.894058 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 04:46:07.894099 systemd[1]: Stopped Setup Virtual Console. Oct 28 04:46:07.895689 systemd[1]: rngd.service: Deactivated successfully. Oct 28 04:46:07.895796 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 28 04:46:07.897338 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 28 04:46:07.908000 audit: BPF prog-id=15 op=UNLOAD Oct 28 04:46:07.897435 systemd[1]: Finished Cleanup udev Database. Oct 28 04:46:07.898916 systemd[1]: Reached target Switch Root. Oct 28 04:46:07.900731 systemd[1]: Starting Switch Root... Oct 28 04:46:07.905856 systemd[1]: Switching root. Oct 28 04:46:07.923444 systemd-journald[279]: Journal stopped Oct 28 04:46:10.098592 systemd-journald[279]: Received SIGTERM from PID 1 (systemd). Oct 28 04:46:10.098650 kernel: SELinux: policy capability network_peer_controls=1 Oct 28 04:46:10.098662 kernel: SELinux: policy capability open_perms=1 Oct 28 04:46:10.098672 kernel: SELinux: policy capability extended_socket_class=1 Oct 28 04:46:10.098683 kernel: SELinux: policy capability always_check_network=0 Oct 28 04:46:10.098693 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 28 04:46:10.098709 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 28 04:46:10.098718 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 28 04:46:10.098730 systemd[1]: Successfully loaded SELinux policy in 33.455ms. Oct 28 04:46:10.098742 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.598ms. Oct 28 04:46:10.098753 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:46:10.098764 systemd[1]: Detected virtualization kvm. Oct 28 04:46:10.098774 systemd[1]: Detected architecture arm64. Oct 28 04:46:10.098784 systemd[1]: Detected first boot. Oct 28 04:46:10.098794 systemd[1]: Initializing machine ID from VM UUID. Oct 28 04:46:10.098805 systemd[1]: Populated /etc with preset unit settings. Oct 28 04:46:10.098818 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:46:10.098830 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:46:10.098840 kernel: kauditd_printk_skb: 24 callbacks suppressed Oct 28 04:46:10.098850 kernel: audit: type=1334 audit(1761626769.959:35): prog-id=21 op=LOAD Oct 28 04:46:10.098860 kernel: audit: type=1334 audit(1761626769.960:36): prog-id=22 op=LOAD Oct 28 04:46:10.098870 kernel: audit: type=1334 audit(1761626769.960:37): prog-id=23 op=LOAD Oct 28 04:46:10.098880 kernel: audit: type=1334 audit(1761626769.960:38): prog-id=16 op=UNLOAD Oct 28 04:46:10.098890 kernel: audit: type=1334 audit(1761626769.960:39): prog-id=17 op=UNLOAD Oct 28 04:46:10.098899 kernel: audit: type=1334 audit(1761626769.961:40): prog-id=24 op=LOAD Oct 28 04:46:10.098909 kernel: audit: type=1334 audit(1761626769.962:41): prog-id=21 op=UNLOAD Oct 28 04:46:10.098918 kernel: audit: type=1334 audit(1761626769.963:42): prog-id=25 op=LOAD Oct 28 04:46:10.098928 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 28 04:46:10.098938 systemd[1]: Stopped Switch Root. Oct 28 04:46:10.098954 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 28 04:46:10.098964 systemd[1]: Created slice Slice /system/addon-config. Oct 28 04:46:10.098974 kernel: audit: type=1334 audit(1761626769.963:43): prog-id=26 op=LOAD Oct 28 04:46:10.098983 kernel: audit: type=1334 audit(1761626769.963:44): prog-id=22 op=UNLOAD Oct 28 04:46:10.098994 systemd[1]: Created slice Slice /system/addon-run. Oct 28 04:46:10.099005 systemd[1]: Created slice Slice /system/getty. Oct 28 04:46:10.099015 systemd[1]: Created slice Slice /system/modprobe. Oct 28 04:46:10.099025 systemd[1]: Created slice Slice /system/serial-getty. Oct 28 04:46:10.099036 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 28 04:46:10.099046 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 28 04:46:10.099057 systemd[1]: Created slice User and Session Slice. Oct 28 04:46:10.099068 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 04:46:10.099078 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 28 04:46:10.099091 systemd[1]: Set up automount Boot partition Automount Point. Oct 28 04:46:10.099102 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 28 04:46:10.099112 systemd[1]: Stopped target Switch Root. Oct 28 04:46:10.099123 systemd[1]: Stopped target Initrd File Systems. Oct 28 04:46:10.099133 systemd[1]: Stopped target Initrd Root File System. Oct 28 04:46:10.099143 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 04:46:10.099153 systemd[1]: Reached target Remote File Systems. Oct 28 04:46:10.099198 systemd[1]: Reached target Slice Units. Oct 28 04:46:10.099211 systemd[1]: Reached target Swaps. Oct 28 04:46:10.099222 systemd[1]: Reached target Verify torcx succeeded. Oct 28 04:46:10.099234 systemd[1]: Reached target Local Verity Protected Volumes. Oct 28 04:46:10.099246 systemd[1]: Listening on Process Core Dump Socket. Oct 28 04:46:10.099265 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 28 04:46:10.099279 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 04:46:10.099294 systemd[1]: Listening on udev Control Socket. Oct 28 04:46:10.099312 systemd[1]: Listening on udev Kernel Socket. Oct 28 04:46:10.099326 systemd[1]: Mounting Huge Pages File System... Oct 28 04:46:10.099336 systemd[1]: Mounting POSIX Message Queue File System... Oct 28 04:46:10.099346 systemd[1]: Mounting External Media Directory... Oct 28 04:46:10.099358 systemd[1]: Mounting Kernel Debug File System... Oct 28 04:46:10.099368 systemd[1]: Mounting Kernel Trace File System... Oct 28 04:46:10.099379 systemd[1]: Mounting Temporary Directory /tmp... Oct 28 04:46:10.099390 systemd[1]: Starting Create missing system files... Oct 28 04:46:10.099400 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 04:46:10.099411 systemd[1]: Starting Load Kernel Module configfs... Oct 28 04:46:10.099421 systemd[1]: Starting Load Kernel Module drm... Oct 28 04:46:10.099431 systemd[1]: Starting Load Kernel Module fuse... Oct 28 04:46:10.099442 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 28 04:46:10.099453 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 28 04:46:10.099465 systemd[1]: Stopped File System Check on Root Device. Oct 28 04:46:10.099475 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 28 04:46:10.099486 systemd[1]: Stopped systemd-fsck-usr.service. Oct 28 04:46:10.099496 kernel: fuse: init (API version 7.32) Oct 28 04:46:10.099506 systemd[1]: Stopped Journal Service. Oct 28 04:46:10.099517 systemd[1]: Starting Journal Service... Oct 28 04:46:10.099528 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 04:46:10.099539 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 28 04:46:10.099550 systemd[1]: Starting Apply Kernel Variables... Oct 28 04:46:10.099562 systemd[1]: Starting Coldplug All udev Devices... Oct 28 04:46:10.099572 systemd[1]: verity-setup.service: Deactivated successfully. Oct 28 04:46:10.099584 systemd-journald[800]: Journal started Oct 28 04:46:10.099621 systemd-journald[800]: Runtime Journal (/run/log/journal/419b7e9678d1437eaeffbe6d8914f0ff) is 6.0M, max 48.5M, 42.4M free. Oct 28 04:46:07.989000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 28 04:46:08.020000 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:46:08.020000 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:46:08.020000 audit: BPF prog-id=19 op=LOAD Oct 28 04:46:08.020000 audit: BPF prog-id=19 op=UNLOAD Oct 28 04:46:08.020000 audit: BPF prog-id=20 op=LOAD Oct 28 04:46:08.020000 audit: BPF prog-id=20 op=UNLOAD Oct 28 04:46:08.052000 audit[750]: AVC avc: denied { associate } for pid=750 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Oct 28 04:46:09.959000 audit: BPF prog-id=21 op=LOAD Oct 28 04:46:09.960000 audit: BPF prog-id=22 op=LOAD Oct 28 04:46:09.960000 audit: BPF prog-id=23 op=LOAD Oct 28 04:46:09.960000 audit: BPF prog-id=16 op=UNLOAD Oct 28 04:46:09.960000 audit: BPF prog-id=17 op=UNLOAD Oct 28 04:46:09.961000 audit: BPF prog-id=24 op=LOAD Oct 28 04:46:09.962000 audit: BPF prog-id=21 op=UNLOAD Oct 28 04:46:09.963000 audit: BPF prog-id=25 op=LOAD Oct 28 04:46:09.963000 audit: BPF prog-id=26 op=LOAD Oct 28 04:46:09.963000 audit: BPF prog-id=22 op=UNLOAD Oct 28 04:46:09.963000 audit: BPF prog-id=23 op=UNLOAD Oct 28 04:46:09.964000 audit: BPF prog-id=27 op=LOAD Oct 28 04:46:09.964000 audit: BPF prog-id=24 op=UNLOAD Oct 28 04:46:09.965000 audit: BPF prog-id=28 op=LOAD Oct 28 04:46:09.966000 audit: BPF prog-id=29 op=LOAD Oct 28 04:46:09.966000 audit: BPF prog-id=25 op=UNLOAD Oct 28 04:46:09.966000 audit: BPF prog-id=26 op=UNLOAD Oct 28 04:46:09.973000 audit: BPF prog-id=27 op=UNLOAD Oct 28 04:46:10.085000 audit: BPF prog-id=30 op=LOAD Oct 28 04:46:10.085000 audit: BPF prog-id=31 op=LOAD Oct 28 04:46:10.085000 audit: BPF prog-id=32 op=LOAD Oct 28 04:46:10.085000 audit: BPF prog-id=28 op=UNLOAD Oct 28 04:46:10.085000 audit: BPF prog-id=29 op=UNLOAD Oct 28 04:46:10.097000 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:46:09.949244 systemd[1]: Queued start job for default target Multi-User System. Oct 28 04:46:08.050906 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" 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:46:09.967326 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 28 04:46:08.051194 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 04:46:08.051216 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 04:46:08.051342 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 28 04:46:08.051353 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 28 04:46:08.051383 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 28 04:46:08.051395 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 28 04:46:08.051608 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 28 04:46:08.051643 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 04:46:08.051665 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 04:46:08.052040 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" 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:46:08.052072 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" 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:46:08.052093 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" 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:46:08.052109 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" 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:46:08.052128 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" 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:46:08.052143 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:08Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 28 04:46:09.770338 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:09Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:46:09.770626 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:09Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:46:09.770734 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:09Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:46:09.770858 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:09Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:46:09.770912 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:09Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 28 04:46:09.770970 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-28T04:46:09Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Oct 28 04:46:10.102054 systemd[1]: Stopped verity-setup.service. Oct 28 04:46:10.105191 systemd[1]: Started Journal Service. Oct 28 04:46:10.105573 systemd[1]: Mounted Huge Pages File System. Oct 28 04:46:10.106623 systemd[1]: Mounted POSIX Message Queue File System. Oct 28 04:46:10.107718 systemd[1]: Mounted External Media Directory. Oct 28 04:46:10.108745 systemd[1]: Mounted Kernel Debug File System. Oct 28 04:46:10.109761 systemd[1]: Mounted Kernel Trace File System. Oct 28 04:46:10.110801 systemd[1]: Mounted Temporary Directory /tmp. Oct 28 04:46:10.112106 systemd[1]: Finished Create missing system files. Oct 28 04:46:10.113487 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 04:46:10.114734 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 28 04:46:10.114950 systemd[1]: Finished Load Kernel Module configfs. Oct 28 04:46:10.116282 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 04:46:10.116500 systemd[1]: Finished Load Kernel Module drm. Oct 28 04:46:10.117658 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 28 04:46:10.117863 systemd[1]: Finished Load Kernel Module fuse. Oct 28 04:46:10.119197 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 28 04:46:10.120635 systemd[1]: Finished Apply Kernel Variables. Oct 28 04:46:10.131795 systemd[1]: Mounting FUSE Control File System... Oct 28 04:46:10.133780 systemd[1]: Mounting Kernel Configuration File System... Oct 28 04:46:10.134820 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 28 04:46:10.136518 systemd[1]: Starting Rebuild Hardware Database... Oct 28 04:46:10.138697 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 28 04:46:10.139967 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 28 04:46:10.142628 systemd-journald[800]: Time spent on flushing to /var/log/journal/419b7e9678d1437eaeffbe6d8914f0ff is 11.132ms for 782 entries. Oct 28 04:46:10.142628 systemd-journald[800]: System Journal (/var/log/journal/419b7e9678d1437eaeffbe6d8914f0ff) is 8.0M, max 203.0M, 195.0M free. Oct 28 04:46:10.141075 systemd[1]: Starting Load/Save Random Seed... Oct 28 04:46:10.143350 systemd[1]: Starting Create System Users... Oct 28 04:46:10.148246 systemd[1]: Mounted FUSE Control File System. Oct 28 04:46:10.149274 systemd[1]: Mounted Kernel Configuration File System. Oct 28 04:46:10.150906 systemd[1]: Finished Load/Save Random Seed. Oct 28 04:46:10.152035 systemd[1]: Reached target First Boot Complete. Oct 28 04:46:10.153755 systemd[1]: Finished Coldplug All udev Devices. Oct 28 04:46:10.154901 systemd-sysusers[812]: Creating group sgx with gid 999. Oct 28 04:46:10.164238 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 28 04:46:10.166298 systemd-sysusers[812]: Creating group systemd-oom with gid 998. Oct 28 04:46:10.166828 systemd-sysusers[812]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Oct 28 04:46:10.168189 systemd-sysusers[812]: Creating group systemd-timesync with gid 997. Oct 28 04:46:10.168446 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 28 04:46:10.170343 systemd-sysusers[812]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Oct 28 04:46:10.171013 systemd-sysusers[812]: Creating group systemd-coredump with gid 996. Oct 28 04:46:10.171614 systemd-sysusers[812]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Oct 28 04:46:10.180584 systemd[1]: Finished Create System Users. Oct 28 04:46:10.182743 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 04:46:10.195538 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 04:46:10.437246 systemd[1]: Finished Rebuild Hardware Database. Oct 28 04:46:10.446000 audit: BPF prog-id=33 op=LOAD Oct 28 04:46:10.446000 audit: BPF prog-id=34 op=LOAD Oct 28 04:46:10.446000 audit: BPF prog-id=35 op=LOAD Oct 28 04:46:10.446000 audit: BPF prog-id=13 op=UNLOAD Oct 28 04:46:10.446000 audit: BPF prog-id=14 op=UNLOAD Oct 28 04:46:10.447638 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 04:46:10.471572 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 04:46:10.477000 audit: BPF prog-id=36 op=LOAD Oct 28 04:46:10.478559 systemd[1]: Starting Network Configuration... Oct 28 04:46:10.507329 systemd-udevd[830]: Using default interface naming scheme 'v249'. Oct 28 04:46:10.507819 systemd-networkd[833]: lo: Link UP Oct 28 04:46:10.508023 systemd-networkd[833]: lo: Gained carrier Oct 28 04:46:10.510401 systemd-networkd[833]: Enumeration completed Oct 28 04:46:10.510613 systemd[1]: Started Network Configuration. Oct 28 04:46:10.512618 systemd-networkd[833]: eth0: Link UP Oct 28 04:46:10.519267 systemd-networkd[833]: eth0: Gained carrier Oct 28 04:46:10.527371 systemd-networkd[833]: eth0: DHCPv4 address 10.0.0.8/16 via 10.0.0.1 Oct 28 04:46:10.534375 udevadm[815]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 28 04:46:10.562410 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 28 04:46:10.575293 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 04:46:10.584328 lvm[845]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 04:46:10.619314 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 04:46:10.620457 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 04:46:10.630320 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 04:46:10.633540 lvm[847]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 04:46:10.664209 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 04:46:10.665344 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 04:46:10.666414 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 28 04:46:10.666444 systemd[1]: Reached target Containers. Oct 28 04:46:10.682454 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 28 04:46:10.695990 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 28 04:46:10.708220 systemd[1]: Mounting /usr/share/oem... Oct 28 04:46:10.714509 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 04:46:10.714653 kernel: BTRFS info (device vda6): has skinny extents Oct 28 04:46:10.716903 systemd[1]: Mounted /usr/share/oem. Oct 28 04:46:10.717835 systemd[1]: Reached target Local File Systems. Oct 28 04:46:10.720024 systemd[1]: Starting Rebuild Dynamic Linker Cache... Oct 28 04:46:10.721397 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 28 04:46:10.721445 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 28 04:46:10.722841 systemd[1]: Starting Commit a transient machine-id on disk... Oct 28 04:46:10.725111 systemd[1]: Starting Create Volatile Files and Directories... Oct 28 04:46:10.731334 systemd-tmpfiles[872]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 28 04:46:10.732395 systemd-tmpfiles[872]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 28 04:46:10.741053 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 28 04:46:10.741949 systemd[1]: Finished Commit a transient machine-id on disk. Oct 28 04:46:10.761887 systemd-tmpfiles[872]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 04:46:10.761901 systemd-tmpfiles[872]: Skipping /boot Oct 28 04:46:10.766785 systemd-tmpfiles[872]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 04:46:10.766802 systemd-tmpfiles[872]: Skipping /boot Oct 28 04:46:10.799373 systemd[1]: Finished Rebuild Dynamic Linker Cache. Oct 28 04:46:10.801115 systemd[1]: Finished Create Volatile Files and Directories. Oct 28 04:46:10.811410 systemd[1]: Starting Load Security Auditing Rules... Oct 28 04:46:10.813528 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 28 04:46:10.816008 systemd[1]: Starting Rebuild Journal Catalog... Oct 28 04:46:10.817000 audit: BPF prog-id=37 op=LOAD Oct 28 04:46:10.818632 systemd[1]: Starting Network Name Resolution... Oct 28 04:46:10.820000 audit: BPF prog-id=38 op=LOAD Oct 28 04:46:10.822120 systemd[1]: Starting Network Time Synchronization... Oct 28 04:46:10.824610 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 28 04:46:10.826413 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 28 04:46:10.827947 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 28 04:46:10.830380 systemd[1]: Finished Rebuild Journal Catalog. Oct 28 04:46:10.833062 systemd[1]: Starting Update is Completed... Oct 28 04:46:10.835334 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 28 04:46:10.838956 systemd[1]: Finished Update is Completed. Oct 28 04:46:10.854000 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:46:10.855446 augenrules[894]: No rules Oct 28 04:46:10.856572 systemd[1]: Finished Load Security Auditing Rules. Oct 28 04:46:10.861525 systemd[1]: Started Network Time Synchronization. Oct 28 04:46:10.862679 systemd-resolved[879]: Positive Trust Anchors: Oct 28 04:46:10.862692 systemd-resolved[879]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 04:46:10.862720 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:46:10.862884 systemd[1]: Reached target System Initialization. Oct 28 04:46:10.864031 systemd[1]: Started Watch for update engine configuration changes. Oct 28 04:46:10.409738 systemd-timesyncd[883]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 28 04:46:10.409884 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 04:46:10.409992 systemd-resolved[879]: Defaulting to hostname 'linux'. Oct 28 04:46:10.411076 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 28 04:46:10.412214 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 28 04:46:10.412240 systemd[1]: Reached target Path Units. Oct 28 04:46:10.413061 systemd[1]: Reached target System Time Set. Oct 28 04:46:10.414200 systemd[1]: Started Daily Log Rotation. Oct 28 04:46:10.415300 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 28 04:46:10.416654 systemd[1]: Reached target Timer Units. Oct 28 04:46:10.417927 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 28 04:46:10.420128 systemd[1]: Starting Docker Socket for the API... Oct 28 04:46:10.423609 systemd[1]: Listening on OpenSSH Server Socket. Oct 28 04:46:10.425151 systemd[1]: Started Network Name Resolution. Oct 28 04:46:10.426254 systemd[1]: Listening on Docker Socket for the API. Oct 28 04:46:10.427397 systemd[1]: Reached target Network. Oct 28 04:46:10.428186 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 04:46:10.429222 systemd[1]: Reached target Socket Units. Oct 28 04:46:10.430058 systemd[1]: Reached target Basic System. Oct 28 04:46:10.430917 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 28 04:46:10.430953 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 28 04:46:10.432135 systemd[1]: Started D-Bus System Message Bus. Oct 28 04:46:10.435897 systemd[1]: Starting Extend Filesystems... Oct 28 04:46:10.436796 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 28 04:46:10.438048 systemd[1]: Starting Generate /run/flatcar/motd... Oct 28 04:46:10.440131 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 28 04:46:10.442361 systemd[1]: Starting Generate sshd host keys... Oct 28 04:46:10.443943 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 28 04:46:10.444025 systemd[1]: Reached target Load system-provided cloud configs. Oct 28 04:46:10.447593 systemd[1]: Starting User Login Management... Oct 28 04:46:10.447907 extend-filesystems[904]: Found vda Oct 28 04:46:10.448754 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 28 04:46:10.449101 extend-filesystems[904]: Found vda1 Oct 28 04:46:10.449725 systemd[1]: Starting Update Engine... Oct 28 04:46:10.450064 extend-filesystems[904]: Found vda2 Oct 28 04:46:10.450657 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 28 04:46:10.450694 systemd[1]: Reached target Load user-provided cloud configs. Oct 28 04:46:10.451360 extend-filesystems[904]: Found vda3 Oct 28 04:46:10.453195 extend-filesystems[904]: Found usr Oct 28 04:46:10.453195 extend-filesystems[904]: Found vda4 Oct 28 04:46:10.453195 extend-filesystems[904]: Found vda6 Oct 28 04:46:10.453195 extend-filesystems[904]: Found vda7 Oct 28 04:46:10.453195 extend-filesystems[904]: Found vda9 Oct 28 04:46:10.453195 extend-filesystems[904]: Checking size of /dev/vda9 Oct 28 04:46:10.453005 systemd[1]: motdgen.service: Deactivated successfully. Oct 28 04:46:10.453308 systemd[1]: Finished Generate /run/flatcar/motd. Oct 28 04:46:10.455091 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 28 04:46:10.455396 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 28 04:46:10.474166 extend-filesystems[904]: Old size kept for /dev/vda9 Oct 28 04:46:10.474763 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 28 04:46:10.475010 systemd[1]: Finished Extend Filesystems. Oct 28 04:46:10.493277 update_engine[919]: I1028 04:46:10.492851 919 main.cc:89] Flatcar Update Engine starting Oct 28 04:46:10.495346 systemd[1]: Started Update Engine. Oct 28 04:46:10.496947 update_engine[919]: I1028 04:46:10.496897 919 update_check_scheduler.cc:74] Next update check in 8m7s Oct 28 04:46:10.503941 systemd-logind[917]: Watching system buttons on /dev/input/event0 (Power Button) Oct 28 04:46:10.504091 systemd[1]: Started Cluster reboot manager. Oct 28 04:46:10.505189 systemd-logind[917]: New seat seat0. Oct 28 04:46:10.511777 systemd[1]: Started User Login Management. Oct 28 04:46:10.533225 locksmithd[928]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 28 04:46:10.689833 sshd_keygen[920]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Oct 28 04:46:10.709243 systemd[1]: Finished Generate sshd host keys. Oct 28 04:46:10.722776 systemd[1]: Starting Generate /run/issue... Oct 28 04:46:10.727269 systemd[1]: issuegen.service: Deactivated successfully. Oct 28 04:46:10.727535 systemd[1]: Finished Generate /run/issue. Oct 28 04:46:10.729960 systemd[1]: Starting Permit User Sessions... Oct 28 04:46:10.735270 systemd[1]: Finished Permit User Sessions. Oct 28 04:46:10.737801 systemd[1]: Started Getty on tty1. Oct 28 04:46:10.739957 systemd[1]: Started Serial Getty on ttyAMA0. Oct 28 04:46:10.741053 systemd[1]: Reached target Login Prompts. Oct 28 04:46:10.742071 systemd[1]: Reached target Multi-User System. Oct 28 04:46:10.744539 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 28 04:46:10.750029 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 28 04:46:10.750287 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 28 04:46:10.751467 systemd[1]: Startup finished in 721ms (kernel) + 2.396s (initrd) + 3.253s (userspace) = 6.370s. Oct 28 04:46:10.938739 systemd[1]: Created slice Slice /system/sshd. Oct 28 04:46:10.940257 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45998). Oct 28 04:46:10.982437 sshd[949]: Accepted publickey for core from 10.0.0.1 port 45998 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:10.984401 sshd[949]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:11.001151 systemd[1]: Created slice User Slice of UID 500. Oct 28 04:46:11.002682 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 28 04:46:11.006937 systemd-logind[917]: New session 1 of user core. Oct 28 04:46:11.013343 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 28 04:46:11.015121 systemd[1]: Starting User Manager for UID 500... Oct 28 04:46:11.018810 systemd[952]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:11.080318 systemd[952]: Queued start job for default target Main User Target. Oct 28 04:46:11.081131 systemd[952]: Reached target Paths. Oct 28 04:46:11.081154 systemd[952]: Reached target Sockets. Oct 28 04:46:11.081166 systemd[952]: Reached target Timers. Oct 28 04:46:11.081176 systemd[952]: Reached target Basic System. Oct 28 04:46:11.081228 systemd[952]: Reached target Main User Target. Oct 28 04:46:11.081242 systemd[952]: Startup finished in 57ms. Oct 28 04:46:11.081374 systemd[1]: Started User Manager for UID 500. Oct 28 04:46:11.093804 systemd[1]: Started Session 1 of User core. Oct 28 04:46:11.162910 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56368). Oct 28 04:46:11.211057 sshd[961]: Accepted publickey for core from 10.0.0.1 port 56368 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:11.212054 sshd[961]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:11.214818 systemd-logind[917]: New session 2 of user core. Oct 28 04:46:11.222794 systemd[1]: Started Session 2 of User core. Oct 28 04:46:11.260228 systemd-networkd[833]: eth0: Gained IPv6LL Oct 28 04:46:11.278956 sshd[961]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:11.288001 systemd[1]: sshd@1-10.0.0.8:22-10.0.0.1:56368.service: Deactivated successfully. Oct 28 04:46:11.288696 systemd[1]: session-2.scope: Deactivated successfully. Oct 28 04:46:11.289377 systemd-logind[917]: Session 2 logged out. Waiting for processes to exit. Oct 28 04:46:11.290505 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56370). Oct 28 04:46:11.291244 systemd-logind[917]: Removed session 2. Oct 28 04:46:11.329675 sshd[967]: Accepted publickey for core from 10.0.0.1 port 56370 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:11.330792 sshd[967]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:11.333923 systemd-logind[917]: New session 3 of user core. Oct 28 04:46:11.345815 systemd[1]: Started Session 3 of User core. Oct 28 04:46:11.395230 sshd[967]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:11.408322 systemd[1]: sshd@2-10.0.0.8:22-10.0.0.1:56370.service: Deactivated successfully. Oct 28 04:46:11.409027 systemd[1]: session-3.scope: Deactivated successfully. Oct 28 04:46:11.409850 systemd-logind[917]: Session 3 logged out. Waiting for processes to exit. Oct 28 04:46:11.411249 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56384). Oct 28 04:46:11.412052 systemd-logind[917]: Removed session 3. Oct 28 04:46:11.455049 sshd[973]: Accepted publickey for core from 10.0.0.1 port 56384 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:11.456433 sshd[973]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:11.460140 systemd-logind[917]: New session 4 of user core. Oct 28 04:46:11.479816 systemd[1]: Started Session 4 of User core. Oct 28 04:46:11.532446 sshd[973]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:11.546987 systemd[1]: sshd@3-10.0.0.8:22-10.0.0.1:56384.service: Deactivated successfully. Oct 28 04:46:11.548378 systemd[1]: session-4.scope: Deactivated successfully. Oct 28 04:46:11.550170 systemd-logind[917]: Session 4 logged out. Waiting for processes to exit. Oct 28 04:46:11.551715 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56398). Oct 28 04:46:11.552439 systemd-logind[917]: Removed session 4. Oct 28 04:46:11.595066 sshd[979]: Accepted publickey for core from 10.0.0.1 port 56398 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:11.596124 sshd[979]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:11.599041 systemd-logind[917]: New session 5 of user core. Oct 28 04:46:11.604848 systemd[1]: Started Session 5 of User core. Oct 28 04:46:11.670391 sudo[982]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 28 04:46:11.670938 sudo[982]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:46:11.684154 sudo[982]: pam_unix(sudo:session): session closed for user root Oct 28 04:46:11.687207 sshd[979]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:11.699627 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56410). Oct 28 04:46:11.703073 dbus-daemon[903]: [system] Reloaded configuration Oct 28 04:46:11.705685 systemd[1]: sshd@4-10.0.0.8:22-10.0.0.1:56398.service: Deactivated successfully. Oct 28 04:46:11.706770 systemd[1]: session-5.scope: Deactivated successfully. Oct 28 04:46:11.707437 systemd-logind[917]: Session 5 logged out. Waiting for processes to exit. Oct 28 04:46:11.708232 systemd-logind[917]: Removed session 5. Oct 28 04:46:11.739752 sshd[985]: Accepted publickey for core from 10.0.0.1 port 56410 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:11.740813 sshd[985]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:11.744078 systemd-logind[917]: New session 6 of user core. Oct 28 04:46:11.754779 systemd[1]: Started Session 6 of User core. Oct 28 04:46:11.810396 sudo[990]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 28 04:46:11.810642 sudo[990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:46:11.813197 sudo[990]: pam_unix(sudo:session): session closed for user root Oct 28 04:46:11.817104 sudo[989]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 28 04:46:11.817325 sudo[989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:46:11.833675 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 04:46:11.833000 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:46:11.834993 auditctl[993]: No rules Oct 28 04:46:11.835234 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 04:46:11.835508 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 04:46:11.837087 systemd[1]: Starting Load Security Auditing Rules... Oct 28 04:46:11.851766 augenrules[1010]: No rules Oct 28 04:46:11.852475 systemd[1]: Finished Load Security Auditing Rules. Oct 28 04:46:11.853390 sudo[989]: pam_unix(sudo:session): session closed for user root Oct 28 04:46:11.855119 sshd[985]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:11.858772 systemd[1]: sshd@5-10.0.0.8:22-10.0.0.1:56410.service: Deactivated successfully. Oct 28 04:46:11.859431 systemd[1]: session-6.scope: Deactivated successfully. Oct 28 04:46:11.860134 systemd-logind[917]: Session 6 logged out. Waiting for processes to exit. Oct 28 04:46:11.861208 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56412). Oct 28 04:46:11.861934 systemd-logind[917]: Removed session 6. Oct 28 04:46:11.900720 sshd[1016]: Accepted publickey for core from 10.0.0.1 port 56412 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:11.902175 sshd[1016]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:11.905055 systemd-logind[917]: New session 7 of user core. Oct 28 04:46:11.912769 systemd[1]: Started Session 7 of User core. Oct 28 04:46:11.965123 sudo[1019]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/bash -c cat >/etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem </etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem < audit_backlog_limit=64 Oct 28 04:46:14.596916 kernel: audit: type=1400 audit(1761626774.577: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:46:14.577000 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:46:14.597581 kernel: audit: audit_lost=1 audit_rate_limit=0 audit_backlog_limit=64 Oct 28 04:46:14.577000 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:46:14.579000 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:46:14.579000 audit: BPF prog-id=56 op=LOAD Oct 28 04:46:14.579000 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:46:14.579000 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:46:14.579000 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:46:14.579000 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:46:14.579000 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:46:14.579000 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:46:14.579000 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:46:14.579000 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:46:14.579000 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:46:14.582000 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:46:14.582000 audit: BPF prog-id=57 op=LOAD Oct 28 04:46:14.582000 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:46:14.582000 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:46:14.582000 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:46:14.582000 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:46:14.582000 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:46:14.582000 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:46:14.582000 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:46:14.582000 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:46:14.582000 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:46:14.585000 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:46:14.585000 audit: BPF prog-id=58 op=LOAD Oct 28 04:46:14.585000 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:46:14.585000 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:46:14.585000 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:46:14.585000 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:46:14.585000 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:46:14.585000 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:46:14.585000 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:46:14.585000 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:46:14.588000 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:46:14.588000 audit: BPF prog-id=59 op=LOAD Oct 28 04:46:14.588000 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:46:14.588000 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:46:14.588000 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:46:14.588000 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:46:14.588000 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:46:14.588000 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:46:14.588000 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:46:14.588000 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:46:14.589000 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:46:14.589000 audit: BPF prog-id=60 op=LOAD Oct 28 04:46:14.589000 audit: BPF prog-id=47 op=UNLOAD Oct 28 04:46:14.589000 audit: BPF prog-id=48 op=UNLOAD Oct 28 04:46:14.589000 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:46:14.589000 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:46:14.589000 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:46:14.589000 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:46:14.589000 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:46:14.589000 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:46:14.589000 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:46:14.589000 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:46:14.589000 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:46:14.593000 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:46:14.593000 audit: BPF prog-id=61 op=LOAD Oct 28 04:46:14.593000 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:46:14.593000 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:46:14.593000 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:46:14.593000 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:46:14.593000 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:46:14.593000 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:46:14.599000 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:46:14.599000 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:46:14.599000 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:46:14.599000 audit: BPF prog-id=62 op=LOAD Oct 28 04:46:14.599000 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:46:14.599000 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:46:14.599000 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:46:14.599000 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:46:14.599000 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:46:14.599000 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:46:14.599000 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:46:14.599000 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:46:14.600000 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:46:14.600000 audit: BPF prog-id=63 op=LOAD Oct 28 04:46:14.600000 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:46:14.600000 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:46:14.600000 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:46:14.600000 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:46:14.600000 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:46:14.600000 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:46:14.600000 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:46:14.600000 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:46:14.600000 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:46:14.600000 audit: BPF prog-id=64 op=LOAD Oct 28 04:46:14.600000 audit: BPF prog-id=51 op=UNLOAD Oct 28 04:46:14.600000 audit: BPF prog-id=52 op=UNLOAD Oct 28 04:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 audit: BPF prog-id=65 op=LOAD Oct 28 04:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 audit: BPF prog-id=66 op=LOAD Oct 28 04:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 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:46:14.603000 audit: BPF prog-id=67 op=LOAD Oct 28 04:46:14.603000 audit: BPF prog-id=54 op=UNLOAD Oct 28 04:46:14.603000 audit: BPF prog-id=55 op=UNLOAD Oct 28 04:46:14.619645 sudo[1195]: pam_unix(sudo:session): session closed for user root Oct 28 04:46:14.621151 sshd[1192]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:14.637927 systemd[1]: sshd@20-10.0.0.8:22-10.0.0.1:56526.service: Deactivated successfully. Oct 28 04:46:14.638913 systemd[1]: session-21.scope: Deactivated successfully. Oct 28 04:46:14.639801 systemd-logind[917]: Session 21 logged out. Waiting for processes to exit. Oct 28 04:46:14.640800 systemd-logind[917]: Removed session 21. Oct 28 04:46:14.642818 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56530). Oct 28 04:46:14.681886 sshd[1255]: Accepted publickey for core from 10.0.0.1 port 56530 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:14.683392 sshd[1255]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:14.686191 systemd-logind[917]: New session 22 of user core. Oct 28 04:46:14.696752 systemd[1]: Started Session 22 of User core. Oct 28 04:46:14.748280 sudo[1258]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl reset-failed locksmithd.service Oct 28 04:46:14.748509 sudo[1258]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:46:14.755113 sudo[1258]: pam_unix(sudo:session): session closed for user root Oct 28 04:46:14.756624 sshd[1255]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:14.768493 systemd[1]: sshd@21-10.0.0.8:22-10.0.0.1:56530.service: Deactivated successfully. Oct 28 04:46:14.769161 systemd[1]: session-22.scope: Deactivated successfully. Oct 28 04:46:14.769823 systemd-logind[917]: Session 22 logged out. Waiting for processes to exit. Oct 28 04:46:14.770997 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56542). Oct 28 04:46:14.771685 systemd-logind[917]: Removed session 22. Oct 28 04:46:14.809760 sshd[1262]: Accepted publickey for core from 10.0.0.1 port 56542 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:14.812455 sshd[1262]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:14.815628 systemd-logind[917]: New session 23 of user core. Oct 28 04:46:14.829758 systemd[1]: Started Session 23 of User core. Oct 28 04:46:14.882245 sudo[1265]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart update-engine.service Oct 28 04:46:14.882790 sudo[1265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:46:14.890841 systemd[1]: Stopping Update Engine... Oct 28 04:46:14.891080 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 28 04:46:14.891144 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 28 04:46:14.891422 systemd[1]: Stopped Update Engine. Oct 28 04:46:14.905956 systemd[1]: Starting Update Engine... Oct 28 04:46:14.913123 update_engine[1267]: I1028 04:46:14.913043 1267 main.cc:89] Flatcar Update Engine starting Oct 28 04:46:14.914330 systemd[1]: Started Update Engine. Oct 28 04:46:14.914419 update_engine[1267]: I1028 04:46:14.914316 1267 update_check_scheduler.cc:74] Next update check in 3m58s Oct 28 04:46:14.915400 sudo[1265]: pam_unix(sudo:session): session closed for user root Oct 28 04:46:14.916735 sshd[1262]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:14.919197 systemd[1]: sshd@22-10.0.0.8:22-10.0.0.1:56542.service: Deactivated successfully. Oct 28 04:46:14.919972 systemd[1]: session-23.scope: Deactivated successfully. Oct 28 04:46:14.920595 systemd-logind[917]: Session 23 logged out. Waiting for processes to exit. Oct 28 04:46:14.921735 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56556). Oct 28 04:46:14.922438 systemd-logind[917]: Removed session 23. Oct 28 04:46:14.961023 sshd[1270]: Accepted publickey for core from 10.0.0.1 port 56556 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:14.962141 sshd[1270]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:14.966748 systemd-logind[917]: New session 24 of user core. Oct 28 04:46:14.985814 systemd[1]: Started Session 24 of User core. Oct 28 04:46:15.041128 update_engine[1267]: I1028 04:46:15.041085 1267 dbus_service.cc:57] Attempting interactive update Oct 28 04:46:15.041128 update_engine[1267]: I1028 04:46:15.041107 1267 update_attempter.cc:275] New update check requested Oct 28 04:46:15.041474 update_engine[1267]: I1028 04:46:15.041450 1267 prefs.cc:51] aleph-version not present in /var/lib/update_engine/prefs Oct 28 04:46:15.041939 update_engine[1267]: I1028 04:46:15.041909 1267 omaha_request_params.cc:62] Current group set to developer Oct 28 04:46:15.042163 update_engine[1267]: I1028 04:46:15.042138 1267 update_attempter.cc:505] Updating boot flags... Oct 28 04:46:15.045819 sshd[1270]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:15.064448 systemd[1]: sshd@23-10.0.0.8:22-10.0.0.1:56556.service: Deactivated successfully. Oct 28 04:46:15.065633 systemd[1]: session-24.scope: Deactivated successfully. Oct 28 04:46:15.071767 systemd-logind[917]: Session 24 logged out. Waiting for processes to exit. Oct 28 04:46:15.083991 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56562). Oct 28 04:46:15.088044 systemd-logind[917]: Removed session 24. Oct 28 04:46:15.092424 update_engine[1267]: I1028 04:46:15.092363 1267 update_attempter.cc:638] Scheduling an action processor start. Oct 28 04:46:15.092424 update_engine[1267]: I1028 04:46:15.092407 1267 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 28 04:46:15.092543 update_engine[1267]: I1028 04:46:15.092458 1267 prefs.cc:51] previous-version not present in /var/lib/update_engine/prefs Oct 28 04:46:15.092581 update_engine[1267]: I1028 04:46:15.092545 1267 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.7:34567/v1/update Oct 28 04:46:15.092581 update_engine[1267]: I1028 04:46:15.092552 1267 omaha_request_action.cc:269] Request: Oct 28 04:46:15.092581 update_engine[1267]: Oct 28 04:46:15.092581 update_engine[1267]: Oct 28 04:46:15.092581 update_engine[1267]: Oct 28 04:46:15.092581 update_engine[1267]: Oct 28 04:46:15.092581 update_engine[1267]: Oct 28 04:46:15.092581 update_engine[1267]: Oct 28 04:46:15.092581 update_engine[1267]: Oct 28 04:46:15.092581 update_engine[1267]: Oct 28 04:46:15.092581 update_engine[1267]: I1028 04:46:15.092571 1267 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 28 04:46:15.097988 update_engine[1267]: I1028 04:46:15.097582 1267 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 28 04:46:15.097988 update_engine[1267]: I1028 04:46:15.097855 1267 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 28 04:46:15.100117 update_engine[1267]: I1028 04:46:15.100082 1267 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 28 04:46:15.100236 update_engine[1267]: I1028 04:46:15.100185 1267 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Oct 28 04:46:15.100236 update_engine[1267]: I1028 04:46:15.100194 1267 omaha_request_action.cc:619] Omaha request response: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.100236 update_engine[1267]: Oct 28 04:46:15.111833 update_engine[1267]: I1028 04:46:15.111788 1267 omaha_request_action.cc:447] Omaha Response manifest version = Oct 28 04:46:15.111833 update_engine[1267]: I1028 04:46:15.111832 1267 omaha_request_action.cc:470] Found 1 url(s) Oct 28 04:46:15.111932 update_engine[1267]: I1028 04:46:15.111847 1267 omaha_request_action.cc:506] Processing first of 1 package(s) Oct 28 04:46:15.111932 update_engine[1267]: I1028 04:46:15.111851 1267 omaha_request_action.cc:513] Omaha Response package name = update.gz Oct 28 04:46:15.111932 update_engine[1267]: I1028 04:46:15.111855 1267 omaha_request_action.cc:529] Url0: http://10.0.0.7:34567/packages/update.gz Oct 28 04:46:15.111932 update_engine[1267]: I1028 04:46:15.111864 1267 omaha_request_action.cc:541] Payload size = 439465725 bytes Oct 28 04:46:15.111932 update_engine[1267]: I1028 04:46:15.111876 1267 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Oct 28 04:46:15.111932 update_engine[1267]: I1028 04:46:15.111887 1267 payload_state.cc:51] Resetting all persisted state as this is a new response Oct 28 04:46:15.111932 update_engine[1267]: I1028 04:46:15.111891 1267 payload_state.cc:360] Current Response Signature = Oct 28 04:46:15.111932 update_engine[1267]: NumURLs = 1 Oct 28 04:46:15.111932 update_engine[1267]: Url0 = http://10.0.0.7:34567/packages/update.gz Oct 28 04:46:15.111932 update_engine[1267]: Payload Size = 439465725 Oct 28 04:46:15.111932 update_engine[1267]: Payload Sha256 Hash = dykyx/Y4jQdfCP1f9j5W1sV+S815EIPi4QJ65LWeHik= Oct 28 04:46:15.111932 update_engine[1267]: Is Delta Payload = 0 Oct 28 04:46:15.111932 update_engine[1267]: Max Failure Count Per Url = 10 Oct 28 04:46:15.111932 update_engine[1267]: Disable Payload Backoff = 1 Oct 28 04:46:15.112166 update_engine[1267]: I1028 04:46:15.111995 1267 payload_state.cc:381] Payload Attempt Number = 0 Oct 28 04:46:15.112166 update_engine[1267]: I1028 04:46:15.112028 1267 payload_state.cc:404] Current URL Index = 0 Oct 28 04:46:15.112166 update_engine[1267]: I1028 04:46:15.112058 1267 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Oct 28 04:46:15.112166 update_engine[1267]: I1028 04:46:15.112087 1267 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Oct 28 04:46:15.112166 update_engine[1267]: I1028 04:46:15.112089 1267 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 28 04:46:15.112166 update_engine[1267]: I1028 04:46:15.112125 1267 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Oct 28 04:46:15.112166 update_engine[1267]: I1028 04:46:15.112145 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Oct 28 04:46:15.112166 update_engine[1267]: I1028 04:46:15.112149 1267 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Oct 28 04:46:15.112166 update_engine[1267]: I1028 04:46:15.112164 1267 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Oct 28 04:46:15.112166 update_engine[1267]: E1028 04:46:15.112169 1267 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Oct 28 04:46:15.113338 update_engine[1267]: I1028 04:46:15.112843 1267 omaha_response_handler_action.cc:85] Using this install plan: Oct 28 04:46:15.113338 update_engine[1267]: I1028 04:46:15.112864 1267 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.7: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:46:15.113338 update_engine[1267]: I1028 04:46:15.112953 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Oct 28 04:46:15.115236 update_engine[1267]: I1028 04:46:15.115190 1267 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Oct 28 04:46:15.133847 sshd[1287]: Accepted publickey for core from 10.0.0.1 port 56562 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:15.135118 sshd[1287]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:15.138655 systemd-logind[917]: New session 25 of user core. Oct 28 04:46:15.150824 systemd[1]: Started Session 25 of User core. Oct 28 04:46:15.213854 sshd[1287]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:15.216509 systemd[1]: sshd@24-10.0.0.8:22-10.0.0.1:56562.service: Deactivated successfully. Oct 28 04:46:15.217198 systemd[1]: session-25.scope: Deactivated successfully. Oct 28 04:46:15.218215 systemd-logind[917]: Session 25 logged out. Waiting for processes to exit. Oct 28 04:46:15.219142 systemd-logind[917]: Removed session 25. Oct 28 04:46:16.912668 update_engine[1267]: I1028 04:46:16.912249 1267 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Oct 28 04:46:16.912668 update_engine[1267]: I1028 04:46:16.912290 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Oct 28 04:46:16.986090 update_engine[1267]: E1028 04:46:16.986034 1267 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Oct 28 04:46:16.986090 update_engine[1267]: I1028 04:46:16.986080 1267 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Oct 28 04:46:16.986090 update_engine[1267]: I1028 04:46:16.986084 1267 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Oct 28 04:46:16.986090 update_engine[1267]: I1028 04:46:16.986088 1267 update_attempter.cc:302] Processing Done. Oct 28 04:46:16.986244 update_engine[1267]: E1028 04:46:16.986140 1267 update_attempter.cc:615] Update failed. Oct 28 04:46:16.986244 update_engine[1267]: I1028 04:46:16.986145 1267 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Oct 28 04:46:16.986244 update_engine[1267]: I1028 04:46:16.986147 1267 payload_state.cc:276] Incrementing the URL failure count Oct 28 04:46:16.986244 update_engine[1267]: I1028 04:46:16.986150 1267 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 28 04:46:16.986400 update_engine[1267]: I1028 04:46:16.986369 1267 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 28 04:46:16.986400 update_engine[1267]: I1028 04:46:16.986397 1267 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.7:34567/v1/update Oct 28 04:46:16.986454 update_engine[1267]: I1028 04:46:16.986402 1267 omaha_request_action.cc:269] Request: Oct 28 04:46:16.986454 update_engine[1267]: Oct 28 04:46:16.986454 update_engine[1267]: Oct 28 04:46:16.986454 update_engine[1267]: Oct 28 04:46:16.986454 update_engine[1267]: Oct 28 04:46:16.986454 update_engine[1267]: Oct 28 04:46:16.986454 update_engine[1267]: Oct 28 04:46:16.986454 update_engine[1267]: I1028 04:46:16.986407 1267 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 28 04:46:16.986625 update_engine[1267]: I1028 04:46:16.986466 1267 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 28 04:46:16.986625 update_engine[1267]: I1028 04:46:16.986601 1267 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 28 04:46:17.173309 update_engine[1267]: I1028 04:46:17.173183 1267 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 28 04:46:17.173309 update_engine[1267]: I1028 04:46:17.173290 1267 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Oct 28 04:46:17.173309 update_engine[1267]: I1028 04:46:17.173297 1267 omaha_request_action.cc:619] Omaha request response: Oct 28 04:46:17.173309 update_engine[1267]: Oct 28 04:46:17.173309 update_engine[1267]: Oct 28 04:46:17.173309 update_engine[1267]: Oct 28 04:46:17.173309 update_engine[1267]: Oct 28 04:46:17.173309 update_engine[1267]: Oct 28 04:46:17.173309 update_engine[1267]: Oct 28 04:46:17.173309 update_engine[1267]: E1028 04:46:17.173313 1267 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Oct 28 04:46:17.173309 update_engine[1267]: I1028 04:46:17.173318 1267 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 28 04:46:17.173906 update_engine[1267]: I1028 04:46:17.173321 1267 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 28 04:46:17.173906 update_engine[1267]: I1028 04:46:17.173324 1267 update_attempter.cc:302] Processing Done. Oct 28 04:46:17.173906 update_engine[1267]: I1028 04:46:17.173329 1267 update_attempter.cc:306] Error event sent. Oct 28 04:46:25.223445 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55610). Oct 28 04:46:25.264425 sshd[1302]: Accepted publickey for core from 10.0.0.1 port 55610 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:25.265533 sshd[1302]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:25.266054 kernel: kauditd_printk_skb: 128 callbacks suppressed Oct 28 04:46:25.266094 kernel: audit: type=1006 audit(1761626785.263:364): pid=1302 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:46:25.268898 systemd-logind[917]: New session 26 of user core. Oct 28 04:46:25.283758 systemd[1]: Started Session 26 of User core. Oct 28 04:46:25.341822 sshd[1302]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:25.350817 systemd[1]: sshd@25-10.0.0.8:22-10.0.0.1:55610.service: Deactivated successfully. Oct 28 04:46:25.351426 systemd[1]: session-26.scope: Deactivated successfully. Oct 28 04:46:25.352106 systemd-logind[917]: Session 26 logged out. Waiting for processes to exit. Oct 28 04:46:25.353336 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55620). Oct 28 04:46:25.354048 systemd-logind[917]: Removed session 26. Oct 28 04:46:25.391613 sshd[1309]: Accepted publickey for core from 10.0.0.1 port 55620 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:25.392936 sshd[1309]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:25.395608 kernel: audit: type=1006 audit(1761626785.391:365): pid=1309 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:46:25.396662 systemd-logind[917]: New session 27 of user core. Oct 28 04:46:25.407244 systemd[1]: Started Session 27 of User core. Oct 28 04:46:25.463862 sshd[1309]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:25.472814 systemd[1]: sshd@26-10.0.0.8:22-10.0.0.1:55620.service: Deactivated successfully. Oct 28 04:46:25.473442 systemd[1]: session-27.scope: Deactivated successfully. Oct 28 04:46:25.474266 systemd-logind[917]: Session 27 logged out. Waiting for processes to exit. Oct 28 04:46:25.475806 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55626). Oct 28 04:46:25.476582 systemd-logind[917]: Removed session 27. Oct 28 04:46:25.514216 sshd[1317]: Accepted publickey for core from 10.0.0.1 port 55626 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:25.515686 sshd[1317]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:25.518580 kernel: audit: type=1006 audit(1761626785.513:366): pid=1317 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:46:25.520226 systemd-logind[917]: New session 28 of user core. Oct 28 04:46:25.530734 systemd[1]: Started Session 28 of User core. Oct 28 04:46:25.579118 sshd[1317]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:25.587820 systemd[1]: sshd@27-10.0.0.8:22-10.0.0.1:55626.service: Deactivated successfully. Oct 28 04:46:25.588649 systemd[1]: session-28.scope: Deactivated successfully. Oct 28 04:46:25.589495 systemd-logind[917]: Session 28 logged out. Waiting for processes to exit. Oct 28 04:46:25.590995 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55630). Oct 28 04:46:25.591889 systemd-logind[917]: Removed session 28. Oct 28 04:46:25.629147 sshd[1323]: Accepted publickey for core from 10.0.0.1 port 55630 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:25.630171 sshd[1323]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:25.632581 kernel: audit: type=1006 audit(1761626785.628:367): pid=1323 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:46:25.634437 systemd-logind[917]: New session 29 of user core. Oct 28 04:46:25.648740 systemd[1]: Started Session 29 of User core. Oct 28 04:46:25.696922 sshd[1323]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:25.705813 systemd[1]: sshd@28-10.0.0.8:22-10.0.0.1:55630.service: Deactivated successfully. Oct 28 04:46:25.706670 systemd[1]: session-29.scope: Deactivated successfully. Oct 28 04:46:25.707498 systemd-logind[917]: Session 29 logged out. Waiting for processes to exit. Oct 28 04:46:25.709138 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55636). Oct 28 04:46:25.709808 systemd-logind[917]: Removed session 29. Oct 28 04:46:25.747922 sshd[1329]: Accepted publickey for core from 10.0.0.1 port 55636 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:25.749201 sshd[1329]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:25.751577 kernel: audit: type=1006 audit(1761626785.747:368): pid=1329 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:46:25.753310 systemd-logind[917]: New session 30 of user core. Oct 28 04:46:25.762751 systemd[1]: Started Session 30 of User core. Oct 28 04:46:25.815018 sudo[1333]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Oct 28 04:46:25.815584 sudo[1333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:46:25.821866 systemd[1]: sshd.socket: Deactivated successfully. Oct 28 04:46:25.822399 systemd[1]: Closed OpenSSH Server Socket. Oct 28 04:46:25.823760 sudo[1333]: pam_unix(sudo:session): session closed for user root Oct 28 04:46:25.827853 sudo[1332]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Oct 28 04:46:25.828063 sudo[1332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:46:25.843213 systemd[1]: Stopping Session 1 of User core... Oct 28 04:46:25.843758 sshd[949]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:25.844583 systemd[1]: Stopping Session 30 of User core... Oct 28 04:46:25.844660 sshd[1329]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:25.845457 sudo[1332]: pam_unix(sudo:session): session closed for user root Oct 28 04:46:25.846450 systemd[1]: Removed slice Slice /system/addon-config. Oct 28 04:46:25.847883 systemd[1]: Removed slice Slice /system/addon-run. Oct 28 04:46:25.849210 systemd[1]: Removed slice Slice /system/modprobe. Oct 28 04:46:25.850634 systemd[1]: Removed slice Slice /system/system-cloudinit. Oct 28 04:46:25.851789 systemd[1]: Stopped target Multi-User System. Oct 28 04:46:25.852867 systemd[1]: Stopped target Login Prompts. Oct 28 04:46:25.853731 systemd[1]: Stopped target Containers. Oct 28 04:46:25.854531 systemd[1]: Stopped target Host and Network Name Lookups. Oct 28 04:46:25.855790 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 04:46:25.856805 systemd[1]: Stopped target Timer Units. Oct 28 04:46:25.857636 systemd[1]: logrotate.timer: Deactivated successfully. Oct 28 04:46:25.857690 systemd[1]: Stopped Daily Log Rotation. Oct 28 04:46:25.858541 systemd[1]: mdadm.timer: Deactivated successfully. Oct 28 04:46:25.858610 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Oct 28 04:46:25.859734 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Oct 28 04:46:25.859777 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Oct 28 04:46:25.860824 systemd[1]: Stopped target System Time Set. Oct 28 04:46:25.861695 systemd[1]: Stopped target Load user-provided cloud configs. Oct 28 04:46:25.862921 systemd[1]: Stopped target Load system-provided cloud configs. Oct 28 04:46:25.864061 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 28 04:46:25.864170 systemd[1]: Closed Process Core Dump Socket. Oct 28 04:46:25.865935 systemd[1]: Unmounting Boot partition... Oct 28 04:46:25.867273 systemd[1]: Stopping Getty on tty1... Oct 28 04:46:25.868148 systemd[1]: Stopping Serial Getty on ttyAMA0... Oct 28 04:46:25.869844 systemd[1]: Stopping OpenSSH per-connection server daemon... Oct 28 04:46:25.870922 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:55636)... Oct 28 04:46:25.871958 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Oct 28 04:46:25.872124 systemd[1]: Stopped Commit a transient machine-id on disk. Oct 28 04:46:25.873276 systemd[1]: Stopped target First Boot Complete. Oct 28 04:46:25.875426 systemd[1]: Stopping Load/Save Random Seed... Oct 28 04:46:25.876578 systemd[1]: Stopping Update Engine... Oct 28 04:46:25.881002 systemd[1]: getty@tty1.service: Deactivated successfully. Oct 28 04:46:25.881222 systemd[1]: Stopped Getty on tty1. Oct 28 04:46:25.882572 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Oct 28 04:46:25.882789 systemd[1]: Stopped Serial Getty on ttyAMA0. Oct 28 04:46:25.884238 systemd[1]: sshd@0-10.0.0.8:22-10.0.0.1:45998.service: Deactivated successfully. Oct 28 04:46:25.884450 systemd[1]: Stopped OpenSSH per-connection server daemon. Oct 28 04:46:25.886081 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 28 04:46:25.886161 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 28 04:46:25.886431 systemd[1]: Stopped Update Engine. Oct 28 04:46:25.887441 systemd[1]: update-engine.service: Consumed 2.469s CPU time. Oct 28 04:46:25.887735 systemd[1]: sshd@29-10.0.0.8:22-10.0.0.1:55636.service: Deactivated successfully. Oct 28 04:46:25.887933 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:55636). Oct 28 04:46:25.895334 systemd[1]: systemd-random-seed.service: Deactivated successfully. Oct 28 04:46:25.895620 systemd[1]: Stopped Load/Save Random Seed. Oct 28 04:46:25.896846 systemd[1]: session-1.scope: Deactivated successfully. Oct 28 04:46:25.897131 systemd[1]: Stopped Session 1 of User core. Oct 28 04:46:25.898318 systemd[1]: session-30.scope: Deactivated successfully. Oct 28 04:46:25.898602 systemd[1]: Stopped Session 30 of User core. Oct 28 04:46:25.899761 systemd[1]: boot.mount: Deactivated successfully. Oct 28 04:46:25.900032 systemd[1]: Unmounted Boot partition. Oct 28 04:46:25.901354 systemd-logind[917]: Session 1 logged out. Waiting for processes to exit. Oct 28 04:46:25.902328 systemd-logind[917]: Session 30 logged out. Waiting for processes to exit. Oct 28 04:46:25.902975 systemd[1]: Removed slice Slice /system/getty. Oct 28 04:46:25.904395 systemd[1]: Removed slice Slice /system/serial-getty. Oct 28 04:46:25.905779 systemd[1]: Removed slice Slice /system/sshd. Oct 28 04:46:25.906785 systemd[1]: sshd-keygen.service: Deactivated successfully. Oct 28 04:46:25.906901 systemd[1]: Stopped Generate sshd host keys. Oct 28 04:46:25.907847 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Oct 28 04:46:25.907976 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Oct 28 04:46:25.909382 systemd[1]: Stopping User Login Management... Oct 28 04:46:25.910274 systemd[1]: Stopping User Manager for UID 500... Oct 28 04:46:25.911115 systemd[952]: Stopped target Main User Target. Oct 28 04:46:25.911133 systemd[952]: Stopped target Basic System. Oct 28 04:46:25.911142 systemd[952]: Stopped target Paths. Oct 28 04:46:25.911150 systemd[952]: Stopped target Sockets. Oct 28 04:46:25.911166 systemd[952]: Reached target Shutdown. Oct 28 04:46:25.911172 systemd[952]: Stopped target Timers. Oct 28 04:46:25.911291 systemd[952]: Finished Exit the Session. Oct 28 04:46:25.911315 systemd[952]: Reached target Exit the Session. Oct 28 04:46:25.912926 systemd-logind[917]: Removed session 30. Oct 28 04:46:25.913944 systemd[1]: user@500.service: Deactivated successfully. Oct 28 04:46:25.914129 systemd[1]: Stopped User Manager for UID 500. Oct 28 04:46:25.931340 systemd[1]: Stopping User Runtime Directory /run/user/500... Oct 28 04:46:25.932672 systemd[1]: systemd-logind.service: Deactivated successfully. Oct 28 04:46:25.932975 systemd[1]: Stopped User Login Management. Oct 28 04:46:25.936849 systemd[1]: run-user-500.mount: Deactivated successfully. Oct 28 04:46:25.936922 systemd[1]: Unmounted /run/user/500. Oct 28 04:46:25.938145 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Oct 28 04:46:25.938383 systemd[1]: Stopped User Runtime Directory /run/user/500. Oct 28 04:46:25.940249 systemd[1]: Removed slice User Slice of UID 500. Oct 28 04:46:25.939000 audit: BPF prog-id=62 op=UNLOAD Oct 28 04:46:25.942591 kernel: audit: type=1334 audit(1761626785.939:369): prog-id=62 op=UNLOAD Oct 28 04:46:25.943183 systemd[1]: Stopping D-Bus System Message Bus... Oct 28 04:46:25.945127 systemd[1]: Stopping Permit User Sessions... Oct 28 04:46:25.946721 systemd[1]: dbus.service: Deactivated successfully. Oct 28 04:46:25.946988 systemd[1]: Stopped D-Bus System Message Bus. Oct 28 04:46:25.949913 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Oct 28 04:46:25.950164 systemd[1]: Stopped Permit User Sessions. Oct 28 04:46:25.951163 systemd[1]: Stopped target Basic System. Oct 28 04:46:25.951973 systemd[1]: Stopped target Network. Oct 28 04:46:25.952677 systemd[1]: Stopped target Path Units. Oct 28 04:46:25.953398 systemd[1]: motdgen.path: Deactivated successfully. Oct 28 04:46:25.954641 systemd[1]: Stopped Watch for update engine configuration changes. Oct 28 04:46:25.955984 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Oct 28 04:46:25.958600 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 04:46:25.959699 systemd[1]: Stopped target Remote File Systems. Oct 28 04:46:25.960530 systemd[1]: Stopped target Slice Units. Oct 28 04:46:25.961678 systemd[1]: Removed slice User and Session Slice. Oct 28 04:46:25.962536 systemd[1]: Stopped target Socket Units. Oct 28 04:46:25.963350 systemd[1]: dbus.socket: Deactivated successfully. Oct 28 04:46:25.963415 systemd[1]: Closed D-Bus System Message Bus Socket. Oct 28 04:46:25.964496 systemd[1]: docker.socket: Deactivated successfully. Oct 28 04:46:25.964767 systemd[1]: Closed Docker Socket for the API. Oct 28 04:46:25.965629 systemd[1]: Stopped target System Initialization. Oct 28 04:46:25.966504 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Oct 28 04:46:25.966663 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Oct 28 04:46:25.967765 systemd[1]: Stopped target Local Verity Protected Volumes. Oct 28 04:46:25.969887 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 04:46:25.970854 systemd[1]: Stopping Network Name Resolution... Oct 28 04:46:25.971803 auditctl[1348]: No rules Oct 28 04:46:25.971997 systemd[1]: Stopping Network Time Synchronization... Oct 28 04:46:25.972922 systemd[1]: systemd-update-done.service: Deactivated successfully. Oct 28 04:46:25.973003 systemd[1]: Stopped Update is Completed. Oct 28 04:46:25.973804 systemd[1]: ldconfig.service: Deactivated successfully. Oct 28 04:46:25.973866 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Oct 28 04:46:25.975732 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Oct 28 04:46:25.975799 systemd[1]: Stopped Rebuild Hardware Database. Oct 28 04:46:25.976678 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Oct 28 04:46:25.976743 systemd[1]: Stopped Rebuild Journal Catalog. Oct 28 04:46:25.978496 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Oct 28 04:46:25.981164 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 28 04:46:25.981435 systemd[1]: Stopped Network Name Resolution. Oct 28 04:46:25.982723 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Oct 28 04:46:25.982970 systemd[1]: Stopped Network Time Synchronization. Oct 28 04:46:25.984360 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 04:46:25.984618 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 04:46:25.986943 systemd[1]: Stopping Network Configuration... Oct 28 04:46:25.986000 audit: BPF prog-id=61 op=UNLOAD Oct 28 04:46:25.988964 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Oct 28 04:46:25.989206 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Oct 28 04:46:25.989567 kernel: audit: type=1334 audit(1761626785.986:370): prog-id=61 op=UNLOAD Oct 28 04:46:25.990894 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 28 04:46:25.991005 systemd[1]: Stopped Create Volatile Files and Directories. Oct 28 04:46:25.990000 audit: BPF prog-id=56 op=UNLOAD Oct 28 04:46:25.992607 systemd-networkd[833]: eth0: DHCPv6 lease lost Oct 28 04:46:25.992996 systemd[1]: Stopped target Local File Systems. Oct 28 04:46:25.993583 kernel: audit: type=1334 audit(1761626785.990:371): prog-id=56 op=UNLOAD Oct 28 04:46:25.995015 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Oct 28 04:46:25.996613 systemd[1]: Unmounting External Media Directory... Oct 28 04:46:25.998629 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Oct 28 04:46:26.000457 systemd[1]: Unmounting /run/torcx/unpack... Oct 28 04:46:26.001917 systemd[1]: Unmounting Temporary Directory /tmp... Oct 28 04:46:26.003310 systemd[1]: Unmounting /usr/share/oem... Oct 28 04:46:26.005035 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Oct 28 04:46:26.007966 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 28 04:46:26.008239 systemd[1]: Stopped Network Configuration. Oct 28 04:46:26.009280 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 28 04:46:26.009569 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Oct 28 04:46:26.010975 systemd[1]: media.mount: Deactivated successfully. Oct 28 04:46:26.011245 systemd[1]: Unmounted External Media Directory. Oct 28 04:46:26.012330 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Oct 28 04:46:26.012635 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Oct 28 04:46:26.017794 systemd[1]: tmp.mount: Deactivated successfully. Oct 28 04:46:26.018071 systemd[1]: Unmounted Temporary Directory /tmp. Oct 28 04:46:26.019144 systemd[1]: usr-share-oem.mount: Deactivated successfully. Oct 28 04:46:26.019417 systemd[1]: Unmounted /usr/share/oem. Oct 28 04:46:26.020389 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 28 04:46:26.020668 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Oct 28 04:46:26.022068 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Oct 28 04:46:26.022311 systemd[1]: Unmounted /run/torcx/unpack. Oct 28 04:46:26.021000 audit: BPF prog-id=57 op=UNLOAD Oct 28 04:46:26.023518 systemd[1]: Stopped target Swaps. Oct 28 04:46:26.025024 kernel: audit: type=1334 audit(1761626786.021:372): prog-id=57 op=UNLOAD Oct 28 04:46:26.025354 systemd[1]: Reached target Unmount All Filesystems. Oct 28 04:46:26.026451 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 28 04:46:26.026631 systemd[1]: Closed Network Service Netlink Socket. Oct 28 04:46:26.027600 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Oct 28 04:46:26.027766 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Oct 28 04:46:26.029401 systemd[1]: Removed slice Slice /system/systemd-fsck. Oct 28 04:46:26.030489 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 04:46:26.031604 systemd[1]: lvm2-activation.service: Deactivated successfully. Oct 28 04:46:26.031744 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 28 04:46:26.032871 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 04:46:26.033861 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 04:46:26.034010 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 04:46:26.035219 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Oct 28 04:46:26.036605 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Oct 28 04:46:26.037800 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Oct 28 04:46:26.037958 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 28 04:46:26.038987 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 04:46:26.039124 systemd[1]: Stopped Apply Kernel Variables. Oct 28 04:46:26.040031 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 04:46:26.040162 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 04:46:26.041320 systemd[1]: systemd-sysusers.service: Deactivated successfully. Oct 28 04:46:26.041523 systemd[1]: Stopped Create System Users. Oct 28 04:46:26.042409 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Oct 28 04:46:26.042544 systemd[1]: Stopped Remount Root and Kernel File Systems. Oct 28 04:46:26.043584 systemd[1]: Reached target System Shutdown. Oct 28 04:46:26.044445 systemd[1]: Reached target Late Shutdown Services. Oct 28 04:46:26.045455 systemd[1]: systemd-reboot.service: Deactivated successfully. Oct 28 04:46:26.045839 systemd[1]: Finished System Reboot. Oct 28 04:46:26.046661 systemd[1]: Reached target System Reboot. Oct 28 04:46:26.047490 systemd[1]: Shutting down. Oct 28 04:46:26.049000 audit: BPF prog-id=60 op=UNLOAD Oct 28 04:46:26.050576 kernel: audit: type=1334 audit(1761626786.049:373): prog-id=60 op=UNLOAD Oct 28 04:46:26.049000 audit: BPF prog-id=59 op=UNLOAD Oct 28 04:46:26.049000 audit: BPF prog-id=58 op=UNLOAD Oct 28 04:46:26.049000 audit: BPF prog-id=64 op=UNLOAD Oct 28 04:46:26.049000 audit: BPF prog-id=63 op=UNLOAD Oct 28 04:46:26.051000 audit: BPF prog-id=67 op=UNLOAD Oct 28 04:46:26.051000 audit: BPF prog-id=66 op=UNLOAD Oct 28 04:46:26.051000 audit: BPF prog-id=65 op=UNLOAD Oct 28 04:46:26.084578 systemd-shutdown[1]: Syncing filesystems and block devices. Oct 28 04:46:26.091052 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Oct 28 04:46:26.091125 systemd-journald[800]: Journal stopped -- Reboot -- Oct 28 04:46:33.677422 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 28 04:46:33.677439 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:46:33.677447 kernel: efi: EFI v2.70 by EDK II Oct 28 04:46:33.677452 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 28 04:46:33.677457 kernel: efi: seeding entropy pool Oct 28 04:46:33.677462 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 28 04:46:33.677468 kernel: ACPI: Early table checksum verification disabled Oct 28 04:46:33.677473 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 28 04:46:33.677478 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 28 04:46:33.677483 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:33.677489 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:33.677494 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:33.677499 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:33.677504 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:33.677510 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:33.677516 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:33.677522 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:33.677528 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:46:33.677533 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 28 04:46:33.677538 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 28 04:46:33.677543 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:46:33.677549 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 28 04:46:33.677554 kernel: Zone ranges: Oct 28 04:46:33.677559 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:46:33.677564 kernel: DMA32 empty Oct 28 04:46:33.677569 kernel: Normal empty Oct 28 04:46:33.677574 kernel: Movable zone start for each node Oct 28 04:46:33.677580 kernel: Early memory node ranges Oct 28 04:46:33.677586 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 28 04:46:33.677591 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 28 04:46:33.677596 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 28 04:46:33.677601 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 28 04:46:33.677606 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 28 04:46:33.677611 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 28 04:46:33.677616 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 28 04:46:33.677622 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 28 04:46:33.677627 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 28 04:46:33.677632 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 28 04:46:33.677637 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 28 04:46:33.677642 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:46:33.677650 kernel: On node 0 totalpages: 643072 Oct 28 04:46:33.677656 kernel: DMA zone: 10048 pages used for memmap Oct 28 04:46:33.677661 kernel: DMA zone: 0 pages reserved Oct 28 04:46:33.677667 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 28 04:46:33.677672 kernel: psci: probing for conduit method from ACPI. Oct 28 04:46:33.677678 kernel: psci: PSCIv1.1 detected in firmware. Oct 28 04:46:33.677683 kernel: psci: Using standard PSCI v0.2 function IDs Oct 28 04:46:33.677688 kernel: psci: Trusted OS migration not required Oct 28 04:46:33.677695 kernel: psci: SMC Calling Convention v1.1 Oct 28 04:46:33.677700 kernel: ACPI: SRAT not present Oct 28 04:46:33.677706 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 28 04:46:33.677711 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 28 04:46:33.677717 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 28 04:46:33.677722 kernel: Detected PIPT I-cache on CPU0 Oct 28 04:46:33.677727 kernel: CPU features: detected: GIC system register CPU interface Oct 28 04:46:33.677733 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 28 04:46:33.677738 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 28 04:46:33.677744 kernel: CPU features: detected: Hardware dirty bit management Oct 28 04:46:33.677749 kernel: CPU features: detected: Spectre-v4 Oct 28 04:46:33.677756 kernel: CPU features: detected: ARM erratum 1418040 Oct 28 04:46:33.677761 kernel: CPU features: detected: Spectre-BHB Oct 28 04:46:33.677767 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 28 04:46:33.677772 kernel: Policy zone: DMA Oct 28 04:46:33.677779 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:46:33.677784 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 28 04:46:33.677790 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 28 04:46:33.677795 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 28 04:46:33.677801 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 28 04:46:33.677807 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 28 04:46:33.677812 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 28 04:46:33.677819 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 28 04:46:33.677825 kernel: rcu: RCU event tracing is enabled. Oct 28 04:46:33.677831 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 28 04:46:33.677836 kernel: Trampoline variant of Tasks RCU enabled. Oct 28 04:46:33.677842 kernel: Tracing variant of Tasks RCU enabled. Oct 28 04:46:33.677847 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 28 04:46:33.677853 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 28 04:46:33.677859 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 28 04:46:33.677864 kernel: GICv3: 256 SPIs implemented Oct 28 04:46:33.677869 kernel: GICv3: 0 Extended SPIs implemented Oct 28 04:46:33.677875 kernel: GICv3: Distributor has no Range Selector support Oct 28 04:46:33.677880 kernel: GICv3: 16 PPIs implemented Oct 28 04:46:33.677887 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 28 04:46:33.677893 kernel: ACPI: SRAT not present Oct 28 04:46:33.677898 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 28 04:46:33.677904 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 28 04:46:33.677909 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 28 04:46:33.677915 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 28 04:46:33.677921 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 28 04:46:33.677927 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:46:33.677933 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 28 04:46:33.677938 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 28 04:46:33.677944 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 28 04:46:33.677950 kernel: arm-pv: using stolen time PV Oct 28 04:46:33.677957 kernel: Console: colour dummy device 80x25 Oct 28 04:46:33.677963 kernel: ACPI: Core revision 20200925 Oct 28 04:46:33.677969 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 28 04:46:33.677975 kernel: pid_max: default: 32768 minimum: 301 Oct 28 04:46:33.677981 kernel: LSM: Security Framework initializing Oct 28 04:46:33.677987 kernel: SELinux: Initializing. Oct 28 04:46:33.677992 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:46:33.677998 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:46:33.678005 kernel: rcu: Hierarchical SRCU implementation. Oct 28 04:46:33.678012 kernel: Platform MSI: ITS@0x8080000 domain created Oct 28 04:46:33.678017 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 28 04:46:33.678023 kernel: Remapping and enabling EFI services. Oct 28 04:46:33.678029 kernel: smp: Bringing up secondary CPUs ... Oct 28 04:46:33.678035 kernel: Detected PIPT I-cache on CPU1 Oct 28 04:46:33.678040 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 28 04:46:33.678046 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 28 04:46:33.678052 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:46:33.678058 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 28 04:46:33.678063 kernel: Detected PIPT I-cache on CPU2 Oct 28 04:46:33.678070 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 28 04:46:33.678076 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 28 04:46:33.678082 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:46:33.678088 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 28 04:46:33.678093 kernel: Detected PIPT I-cache on CPU3 Oct 28 04:46:33.678103 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 28 04:46:33.678109 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 28 04:46:33.678116 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:46:33.678122 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 28 04:46:33.678128 kernel: smp: Brought up 1 node, 4 CPUs Oct 28 04:46:33.678134 kernel: SMP: Total of 4 processors activated. Oct 28 04:46:33.678140 kernel: CPU features: detected: Privileged Access Never Oct 28 04:46:33.678146 kernel: CPU features: detected: LSE atomic instructions Oct 28 04:46:33.678152 kernel: CPU features: detected: User Access Override Oct 28 04:46:33.678158 kernel: CPU features: detected: 32-bit EL0 Support Oct 28 04:46:33.678164 kernel: CPU features: detected: Common not Private translations Oct 28 04:46:33.678170 kernel: CPU features: detected: RAS Extension Support Oct 28 04:46:33.678177 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 28 04:46:33.678183 kernel: CPU features: detected: CRC32 instructions Oct 28 04:46:33.678189 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 28 04:46:33.678195 kernel: CPU: All CPU(s) started at EL1 Oct 28 04:46:33.678219 kernel: alternatives: patching kernel code Oct 28 04:46:33.678226 kernel: devtmpfs: initialized Oct 28 04:46:33.678232 kernel: KASLR enabled Oct 28 04:46:33.678238 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 28 04:46:33.678244 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 28 04:46:33.678250 kernel: pinctrl core: initialized pinctrl subsystem Oct 28 04:46:33.678256 kernel: SMBIOS 3.0.0 present. Oct 28 04:46:33.678262 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 28 04:46:33.678268 kernel: NET: Registered protocol family 16 Oct 28 04:46:33.678274 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 28 04:46:33.678280 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 28 04:46:33.678287 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 28 04:46:33.678294 kernel: audit: initializing netlink subsys (disabled) Oct 28 04:46:33.678300 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Oct 28 04:46:33.678305 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 28 04:46:33.678311 kernel: cpuidle: using governor menu Oct 28 04:46:33.678317 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 28 04:46:33.678323 kernel: ASID allocator initialised with 32768 entries Oct 28 04:46:33.678330 kernel: ACPI: bus type PCI registered Oct 28 04:46:33.678336 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 28 04:46:33.678342 kernel: Serial: AMBA PL011 UART driver Oct 28 04:46:33.678348 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 28 04:46:33.678355 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 28 04:46:33.678361 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 28 04:46:33.678370 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 28 04:46:33.678377 kernel: cryptd: max_cpu_qlen set to 1000 Oct 28 04:46:33.678383 kernel: ACPI: Added _OSI(Module Device) Oct 28 04:46:33.678390 kernel: ACPI: Added _OSI(Processor Device) Oct 28 04:46:33.678395 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 28 04:46:33.678401 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 28 04:46:33.678409 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 28 04:46:33.678415 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 28 04:46:33.678421 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 28 04:46:33.678428 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 28 04:46:33.678434 kernel: ACPI: Interpreter enabled Oct 28 04:46:33.678440 kernel: ACPI: Using GIC for interrupt routing Oct 28 04:46:33.678446 kernel: ACPI: MCFG table detected, 1 entries Oct 28 04:46:33.678452 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 28 04:46:33.678458 kernel: printk: console [ttyAMA0] enabled Oct 28 04:46:33.678466 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 28 04:46:33.678575 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 28 04:46:33.678633 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 28 04:46:33.678699 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 28 04:46:33.679390 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 28 04:46:33.679464 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 28 04:46:33.679473 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 28 04:46:33.679484 kernel: PCI host bridge to bus 0000:00 Oct 28 04:46:33.679556 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 28 04:46:33.679609 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 28 04:46:33.679657 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 28 04:46:33.679705 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 28 04:46:33.679773 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 28 04:46:33.679836 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 28 04:46:33.679894 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 28 04:46:33.679949 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 28 04:46:33.680003 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 04:46:33.680056 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 04:46:33.680114 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 28 04:46:33.680170 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 28 04:46:33.680234 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 28 04:46:33.680286 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 28 04:46:33.680343 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 28 04:46:33.680351 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 28 04:46:33.680357 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 28 04:46:33.680363 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 28 04:46:33.680375 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 28 04:46:33.680381 kernel: vgaarb: loaded Oct 28 04:46:33.680387 kernel: Registered efivars operations Oct 28 04:46:33.680394 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 28 04:46:33.680402 kernel: VFS: Disk quotas dquot_6.6.0 Oct 28 04:46:33.680408 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 28 04:46:33.680414 kernel: pnp: PnP ACPI init Oct 28 04:46:33.680485 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 28 04:46:33.680536 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 28 04:46:33.680545 kernel: pnp: PnP ACPI: found 1 devices Oct 28 04:46:33.680551 kernel: NET: Registered protocol family 2 Oct 28 04:46:33.680557 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 28 04:46:33.680564 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 28 04:46:33.680571 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 28 04:46:33.680577 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 28 04:46:33.680583 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 28 04:46:33.680589 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:46:33.680595 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:46:33.680601 kernel: NET: Registered protocol family 1 Oct 28 04:46:33.680607 kernel: PCI: CLS 0 bytes, default 64 Oct 28 04:46:33.680613 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 28 04:46:33.680621 kernel: kvm [1]: HYP mode not available Oct 28 04:46:33.680627 kernel: Initialise system trusted keyrings Oct 28 04:46:33.680633 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 28 04:46:33.680638 kernel: Key type asymmetric registered Oct 28 04:46:33.680644 kernel: Asymmetric key parser 'x509' registered Oct 28 04:46:33.680650 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 28 04:46:33.680657 kernel: io scheduler mq-deadline registered Oct 28 04:46:33.680663 kernel: io scheduler kyber registered Oct 28 04:46:33.680669 kernel: io scheduler bfq registered Oct 28 04:46:33.680676 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 28 04:46:33.680682 kernel: ACPI: Power Button [PWRB] Oct 28 04:46:33.680688 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 28 04:46:33.680745 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 28 04:46:33.680753 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 28 04:46:33.680759 kernel: msm_serial: driver initialized Oct 28 04:46:33.680765 kernel: random: fast init done Oct 28 04:46:33.680771 kernel: random: crng init done Oct 28 04:46:33.680777 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 28 04:46:33.680783 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 28 04:46:33.680791 kernel: thunder_xcv, ver 1.0 Oct 28 04:46:33.680797 kernel: thunder_bgx, ver 1.0 Oct 28 04:46:33.680802 kernel: nicpf, ver 1.0 Oct 28 04:46:33.680808 kernel: nicvf, ver 1.0 Oct 28 04:46:33.680870 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 28 04:46:33.680921 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-28T04:46:33 UTC (1761626793) Oct 28 04:46:33.680930 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 28 04:46:33.680936 kernel: NET: Registered protocol family 10 Oct 28 04:46:33.680943 kernel: Segment Routing with IPv6 Oct 28 04:46:33.680950 kernel: NET: Registered protocol family 17 Oct 28 04:46:33.680956 kernel: Key type dns_resolver registered Oct 28 04:46:33.680961 kernel: registered taskstats version 1 Oct 28 04:46:33.680967 kernel: Loading compiled-in X.509 certificates Oct 28 04:46:33.680974 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 28 04:46:33.680980 kernel: Key type ._fscrypt registered Oct 28 04:46:33.680986 kernel: Key type .fscrypt registered Oct 28 04:46:33.680992 kernel: Key type fscrypt-provisioning registered Oct 28 04:46:33.680999 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 28 04:46:33.681005 kernel: ima: Allocated hash algorithm: sha1 Oct 28 04:46:33.681011 kernel: ima: No architecture policies found Oct 28 04:46:33.681017 kernel: Freeing unused kernel memory: 34240K Oct 28 04:46:33.681023 kernel: Run /init as init process Oct 28 04:46:33.681029 kernel: with arguments: Oct 28 04:46:33.681035 kernel: /init Oct 28 04:46:33.681041 kernel: with environment: Oct 28 04:46:33.681046 kernel: HOME=/ Oct 28 04:46:33.681052 kernel: TERM=linux Oct 28 04:46:33.681059 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 28 04:46:33.681067 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:46:33.681076 systemd[1]: Detected virtualization kvm. Oct 28 04:46:33.681082 systemd[1]: Detected architecture arm64. Oct 28 04:46:33.681089 systemd[1]: Running in initial RAM disk. Oct 28 04:46:33.681095 systemd[1]: No hostname configured, using default hostname. Oct 28 04:46:33.681101 systemd[1]: Hostname set to . Oct 28 04:46:33.681109 systemd[1]: Initializing machine ID from VM UUID. Oct 28 04:46:33.681116 systemd[1]: Queued start job for default target Initrd Default Target. Oct 28 04:46:33.681122 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 04:46:33.681129 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 04:46:33.681135 systemd[1]: Reached target Path Units. Oct 28 04:46:33.681141 systemd[1]: Reached target Slice Units. Oct 28 04:46:33.681147 systemd[1]: Reached target Swaps. Oct 28 04:46:33.681154 systemd[1]: Reached target Timer Units. Oct 28 04:46:33.681161 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 28 04:46:33.681168 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 28 04:46:33.681175 systemd[1]: Listening on Journal Audit Socket. Oct 28 04:46:33.681181 systemd[1]: Listening on Journal Socket (/dev/log). Oct 28 04:46:33.681188 systemd[1]: Listening on Journal Socket. Oct 28 04:46:33.681194 systemd[1]: Listening on udev Control Socket. Oct 28 04:46:33.681208 systemd[1]: Listening on udev Kernel Socket. Oct 28 04:46:33.681215 systemd[1]: Reached target Socket Units. Oct 28 04:46:33.681221 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 28 04:46:33.681229 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 04:46:33.681236 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 28 04:46:33.681242 systemd[1]: Starting Journal Service... Oct 28 04:46:33.681249 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 04:46:33.681255 systemd[1]: Starting Apply Kernel Variables... Oct 28 04:46:33.681261 systemd[1]: Starting Setup Virtual Console... Oct 28 04:46:33.681268 kernel: SCSI subsystem initialized Oct 28 04:46:33.681274 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 28 04:46:33.681280 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 04:46:33.681286 kernel: Loading iSCSI transport class v2.0-870. Oct 28 04:46:33.681294 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 04:46:33.681300 systemd[1]: Finished Setup Virtual Console. Oct 28 04:46:33.681309 systemd-journald[270]: Journal started Oct 28 04:46:33.681346 systemd-journald[270]: Runtime Journal (/run/log/journal/419b7e9678d1437eaeffbe6d8914f0ff) is 6.0M, max 48.5M, 42.4M free. Oct 28 04:46:33.683244 systemd[1]: Started Journal Service. Oct 28 04:46:33.683624 systemd[1]: Finished Apply Kernel Variables. Oct 28 04:46:33.684582 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 04:46:33.686656 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 28 04:46:33.700376 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 28 04:46:33.702160 systemd[1]: Starting dracut cmdline hook... Oct 28 04:46:33.710856 dracut-cmdline[291]: dracut-dracut-053 Oct 28 04:46:33.712991 dracut-cmdline[291]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 28 04:46:33.771246 kernel: iscsi: registered transport (tcp) Oct 28 04:46:33.782231 kernel: iscsi: registered transport (qla4xxx) Oct 28 04:46:33.782254 kernel: QLogic iSCSI HBA Driver Oct 28 04:46:33.791915 systemd[1]: Finished dracut cmdline hook. Oct 28 04:46:33.793558 systemd[1]: Starting dracut pre-udev hook... Oct 28 04:46:33.794814 systemd[1]: Starting Open-iSCSI... Oct 28 04:46:33.797217 iscsid[376]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 28 04:46:33.797217 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:46:33.797217 iscsid[376]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 28 04:46:33.797217 iscsid[376]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 28 04:46:33.797217 iscsid[376]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 28 04:46:33.809463 kernel: device-mapper: uevent: version 1.0.3 Oct 28 04:46:33.809483 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 28 04:46:33.809492 iscsid[376]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 28 04:46:33.800705 systemd[1]: Started Open-iSCSI. Oct 28 04:46:33.843237 kernel: raid6: neonx8 gen() 13797 MB/s Oct 28 04:46:33.860224 kernel: raid6: neonx8 xor() 10746 MB/s Oct 28 04:46:33.877257 kernel: raid6: neonx4 gen() 13579 MB/s Oct 28 04:46:33.894254 kernel: raid6: neonx4 xor() 11586 MB/s Oct 28 04:46:33.911254 kernel: raid6: neonx2 gen() 13020 MB/s Oct 28 04:46:33.928227 kernel: raid6: neonx2 xor() 9892 MB/s Oct 28 04:46:33.945223 kernel: raid6: neonx1 gen() 10693 MB/s Oct 28 04:46:33.962222 kernel: raid6: neonx1 xor() 8835 MB/s Oct 28 04:46:33.979237 kernel: raid6: int64x8 gen() 6834 MB/s Oct 28 04:46:33.996231 kernel: raid6: int64x8 xor() 3798 MB/s Oct 28 04:46:34.013230 kernel: raid6: int64x4 gen() 6915 MB/s Oct 28 04:46:34.030232 kernel: raid6: int64x4 xor() 3835 MB/s Oct 28 04:46:34.047231 kernel: raid6: int64x2 gen() 6188 MB/s Oct 28 04:46:34.064225 kernel: raid6: int64x2 xor() 3312 MB/s Oct 28 04:46:34.081223 kernel: raid6: int64x1 gen() 5012 MB/s Oct 28 04:46:34.098376 kernel: raid6: int64x1 xor() 2598 MB/s Oct 28 04:46:34.098391 kernel: raid6: using algorithm neonx8 gen() 13797 MB/s Oct 28 04:46:34.098400 kernel: raid6: .... xor() 10746 MB/s, rmw enabled Oct 28 04:46:34.099530 kernel: raid6: using neon recovery algorithm Oct 28 04:46:34.109232 kernel: xor: measuring software checksum speed Oct 28 04:46:34.110232 kernel: 8regs : 16701 MB/sec Oct 28 04:46:34.111224 kernel: 32regs : 20739 MB/sec Oct 28 04:46:34.112569 kernel: arm64_neon : 28764 MB/sec Oct 28 04:46:34.112587 kernel: xor: using function: arm64_neon (28764 MB/sec) Oct 28 04:46:34.157239 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 28 04:46:34.167307 systemd[1]: Finished dracut pre-udev hook. Oct 28 04:46:34.168000 audit: BPF prog-id=6 op=LOAD Oct 28 04:46:34.169000 audit: BPF prog-id=7 op=LOAD Oct 28 04:46:34.170423 kernel: audit: type=1334 audit(1761626794.168:2): prog-id=6 op=LOAD Oct 28 04:46:34.170447 kernel: audit: type=1334 audit(1761626794.169:3): prog-id=7 op=LOAD Oct 28 04:46:34.170455 kernel: audit: type=1334 audit(1761626794.169:4): prog-id=8 op=LOAD Oct 28 04:46:34.169000 audit: BPF prog-id=8 op=LOAD Oct 28 04:46:34.170778 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 04:46:34.182370 systemd-udevd[407]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 04:46:34.184036 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 04:46:34.187381 systemd[1]: Starting dracut pre-trigger hook... Oct 28 04:46:34.198952 dracut-pre-trigger[417]: rd.md=0: removing MD RAID activation Oct 28 04:46:34.222632 systemd[1]: Finished dracut pre-trigger hook. Oct 28 04:46:34.224147 systemd[1]: Starting Coldplug All udev Devices... Oct 28 04:46:34.233913 systemd-udevd[407]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 28 04:46:34.253674 systemd[1]: Finished Coldplug All udev Devices. Oct 28 04:46:34.255308 systemd[1]: Starting dracut initqueue hook... Oct 28 04:46:34.272441 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 28 04:46:34.272592 kernel: vda: detected capacity change from 0 to 4756340736 Oct 28 04:46:34.285150 systemd-udevd[456]: Using default interface naming scheme 'v249'. Oct 28 04:46:34.287215 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 04:46:34.303737 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 28 04:46:34.306423 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (469) Oct 28 04:46:34.305334 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 28 04:46:34.312167 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 28 04:46:34.314847 systemd[1]: Reached target Initrd Root Device. Oct 28 04:46:34.316393 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 28 04:46:34.317569 systemd[1]: Finished dracut initqueue hook. Oct 28 04:46:34.319130 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 28 04:46:34.319254 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 28 04:46:34.320696 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 04:46:34.322253 systemd[1]: Reached target Preparation for Remote File Systems. Oct 28 04:46:34.324177 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 04:46:34.325932 systemd[1]: Reached target Remote File Systems. Oct 28 04:46:34.328314 systemd[1]: Starting dracut pre-mount hook... Oct 28 04:46:34.329579 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 28 04:46:34.336276 systemd[1]: Finished dracut pre-mount hook. Oct 28 04:46:34.338010 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 28 04:46:34.342223 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 28 04:46:34.348393 systemd-fsck[502]: ROOT: clean, 641/553792 files, 42010/553472 blocks Oct 28 04:46:34.351241 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 28 04:46:34.353008 systemd[1]: Mounting /sysroot... Oct 28 04:46:34.367664 systemd[1]: Found device /dev/mapper/usr. Oct 28 04:46:34.369728 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 28 04:46:34.372540 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 28 04:46:34.379777 systemd-fsck[514]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 28 04:46:34.379777 systemd-fsck[514]: You must have r/w access to the filesystem or be root Oct 28 04:46:34.382319 systemd-fsck[510]: fsck failed with exit status 8. Oct 28 04:46:34.382325 systemd-fsck[510]: Ignoring error. Oct 28 04:46:34.384586 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 28 04:46:34.386166 systemd[1]: Mounting /sysusr/usr... Oct 28 04:46:34.396443 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 28 04:46:34.396482 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 28 04:46:34.396940 systemd[1]: Mounted /sysroot. Oct 28 04:46:34.397703 systemd[1]: Reached target Initrd Root File System. Oct 28 04:46:34.399628 systemd[1]: Starting Reload Configuration from the Real Root... Oct 28 04:46:34.403890 systemd[1]: Reloading. Oct 28 04:46:34.405000 audit: BPF prog-id=3 op=UNLOAD Oct 28 04:46:34.406211 kernel: audit: type=1334 audit(1761626794.405:5): prog-id=3 op=UNLOAD Oct 28 04:46:34.411000 audit: BPF prog-id=6 op=UNLOAD Oct 28 04:46:34.414499 kernel: audit: type=1334 audit(1761626794.411:6): prog-id=6 op=UNLOAD Oct 28 04:46:34.418222 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 28 04:46:34.489000 audit: BPF prog-id=9 op=LOAD Oct 28 04:46:34.493079 kernel: audit: type=1334 audit(1761626794.489:7): prog-id=9 op=LOAD Oct 28 04:46:34.493131 kernel: audit: type=1334 audit(1761626794.490:8): prog-id=10 op=LOAD Oct 28 04:46:34.493141 kernel: audit: type=1334 audit(1761626794.490:9): prog-id=11 op=LOAD Oct 28 04:46:34.493149 kernel: audit: type=1334 audit(1761626794.490:10): prog-id=4 op=UNLOAD Oct 28 04:46:34.490000 audit: BPF prog-id=10 op=LOAD Oct 28 04:46:34.490000 audit: BPF prog-id=11 op=LOAD Oct 28 04:46:34.490000 audit: BPF prog-id=4 op=UNLOAD Oct 28 04:46:34.490000 audit: BPF prog-id=5 op=UNLOAD Oct 28 04:46:34.491000 audit: BPF prog-id=12 op=LOAD Oct 28 04:46:34.491000 audit: BPF prog-id=13 op=LOAD Oct 28 04:46:34.492000 audit: BPF prog-id=14 op=LOAD Oct 28 04:46:34.492000 audit: BPF prog-id=7 op=UNLOAD Oct 28 04:46:34.492000 audit: BPF prog-id=8 op=UNLOAD Oct 28 04:46:34.494182 systemd[1]: Mounted /sysusr/usr. Oct 28 04:46:34.496282 systemd[1]: Reached target Local File Systems. Oct 28 04:46:34.497084 systemd[1]: Reached target System Initialization. Oct 28 04:46:34.498643 systemd[1]: Reached target Basic System. Oct 28 04:46:34.500944 systemd[1]: Mounting /sysroot/usr... Oct 28 04:46:34.503478 systemd[1]: Mounted /sysroot/usr. Oct 28 04:46:34.512304 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 28 04:46:34.512427 systemd[1]: Finished Reload Configuration from the Real Root. Oct 28 04:46:34.514299 systemd[1]: Reached target Initrd File Systems. Oct 28 04:46:34.515914 systemd[1]: Reached target Initrd Default Target. Oct 28 04:46:34.517453 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 28 04:46:34.518111 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 28 04:46:34.528030 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 28 04:46:34.529708 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 28 04:46:34.535459 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 28 04:46:34.536457 systemd[1]: Stopped target Timer Units. Oct 28 04:46:34.537897 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 28 04:46:34.537996 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 28 04:46:34.539436 systemd[1]: Stopped target Initrd Default Target. Oct 28 04:46:34.541001 systemd[1]: Stopped target Basic System. Oct 28 04:46:34.542474 systemd[1]: Stopped target Initrd Root Device. Oct 28 04:46:34.543983 systemd[1]: Stopped target Path Units. Oct 28 04:46:34.545300 systemd[1]: Stopped target Remote File Systems. Oct 28 04:46:34.546755 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 28 04:46:34.548338 systemd[1]: Stopped target Slice Units. Oct 28 04:46:34.549636 systemd[1]: Stopped target Socket Units. Oct 28 04:46:34.551115 systemd[1]: Stopped target System Initialization. Oct 28 04:46:34.552503 systemd[1]: Stopped target Local File Systems. Oct 28 04:46:34.553818 systemd[1]: Stopped target Preparation for Local File Systems. Oct 28 04:46:34.555451 systemd[1]: Stopped target Swaps. Oct 28 04:46:34.556714 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 28 04:46:34.556824 systemd[1]: Stopped dracut pre-mount hook. Oct 28 04:46:34.558313 systemd[1]: Stopped target Local Encrypted Volumes. Oct 28 04:46:34.559558 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 04:46:34.564249 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 28 04:46:34.565405 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 28 04:46:34.565506 systemd[1]: Stopped dracut initqueue hook. Oct 28 04:46:34.568627 iscsid[376]: iscsid shutting down. Oct 28 04:46:34.568675 systemd[1]: Stopping Open-iSCSI... Oct 28 04:46:34.569788 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 04:46:34.569903 systemd[1]: Stopped Apply Kernel Variables. Oct 28 04:46:34.571105 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 28 04:46:34.571194 systemd[1]: Stopped Coldplug All udev Devices. Oct 28 04:46:34.572762 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 28 04:46:34.572850 systemd[1]: Stopped dracut pre-trigger hook. Oct 28 04:46:34.576521 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 28 04:46:34.579110 systemd[1]: iscsid.service: Deactivated successfully. Oct 28 04:46:34.579233 systemd[1]: Stopped Open-iSCSI. Oct 28 04:46:34.580778 systemd[1]: iscsid.socket: Deactivated successfully. Oct 28 04:46:34.580824 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 28 04:46:34.584074 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 28 04:46:34.586304 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 28 04:46:34.586426 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 28 04:46:34.587886 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 28 04:46:34.588006 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 28 04:46:34.589695 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 28 04:46:34.589812 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 28 04:46:34.591997 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 28 04:46:34.592048 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 28 04:46:34.592967 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 28 04:46:34.593008 systemd[1]: Closed udev Control Socket. Oct 28 04:46:34.594346 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 28 04:46:34.606000 audit: BPF prog-id=12 op=UNLOAD Oct 28 04:46:34.594390 systemd[1]: Closed udev Kernel Socket. Oct 28 04:46:34.595811 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 28 04:46:34.595856 systemd[1]: Stopped dracut pre-udev hook. Oct 28 04:46:34.597416 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 28 04:46:34.597455 systemd[1]: Stopped dracut cmdline hook. Oct 28 04:46:34.598931 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 28 04:46:34.598973 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 28 04:46:34.601420 systemd[1]: Starting Cleanup udev Database... Oct 28 04:46:34.602318 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 28 04:46:34.603617 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 04:46:34.603677 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 28 04:46:34.620000 audit: BPF prog-id=9 op=UNLOAD Oct 28 04:46:34.605376 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 28 04:46:34.605421 systemd[1]: Stopped Create List of Static Device Nodes. Oct 28 04:46:34.607042 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 04:46:34.607088 systemd[1]: Stopped Setup Virtual Console. Oct 28 04:46:34.609002 systemd[1]: rngd.service: Deactivated successfully. Oct 28 04:46:34.609120 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 28 04:46:34.610382 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 28 04:46:34.610494 systemd[1]: Finished Cleanup udev Database. Oct 28 04:46:34.612051 systemd[1]: Reached target Switch Root. Oct 28 04:46:34.613984 systemd[1]: Starting Switch Root... Oct 28 04:46:34.619975 systemd[1]: Switching root. Oct 28 04:46:34.631443 systemd-journald[270]: Journal stopped Oct 28 04:46:36.704476 systemd-journald[270]: Received SIGTERM from PID 1 (n/a). Oct 28 04:46:36.704524 kernel: SELinux: policy capability network_peer_controls=1 Oct 28 04:46:36.704536 kernel: SELinux: policy capability open_perms=1 Oct 28 04:46:36.704551 kernel: SELinux: policy capability extended_socket_class=1 Oct 28 04:46:36.704561 kernel: SELinux: policy capability always_check_network=0 Oct 28 04:46:36.704570 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 28 04:46:36.704580 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 28 04:46:36.704589 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 28 04:46:36.704598 systemd[1]: Successfully loaded SELinux policy in 30.833ms. Oct 28 04:46:36.704610 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.292ms. Oct 28 04:46:36.704621 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:46:36.704631 systemd[1]: Detected virtualization kvm. Oct 28 04:46:36.704701 systemd[1]: Detected architecture arm64. Oct 28 04:46:36.704719 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:46:36.704730 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:46:36.704742 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 28 04:46:36.704751 systemd[1]: Stopped Switch Root. Oct 28 04:46:36.704761 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 28 04:46:36.704770 systemd[1]: Created slice Slice /system/addon-config. Oct 28 04:46:36.704780 systemd[1]: Created slice Slice /system/addon-run. Oct 28 04:46:36.704827 systemd[1]: Created slice Slice /system/getty. Oct 28 04:46:36.704847 systemd[1]: Created slice Slice /system/modprobe. Oct 28 04:46:36.704857 systemd[1]: Created slice Slice /system/serial-getty. Oct 28 04:46:36.704868 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 28 04:46:36.704878 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 28 04:46:36.704888 systemd[1]: Created slice User and Session Slice. Oct 28 04:46:36.704899 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 28 04:46:36.704909 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 28 04:46:36.704953 systemd[1]: Set up automount Boot partition Automount Point. Oct 28 04:46:36.704969 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 28 04:46:36.704980 systemd[1]: Stopped target Switch Root. Oct 28 04:46:36.704990 systemd[1]: Stopped target Initrd File Systems. Oct 28 04:46:36.705000 systemd[1]: Stopped target Initrd Root File System. Oct 28 04:46:36.705010 systemd[1]: Reached target Remote Encrypted Volumes. Oct 28 04:46:36.705020 systemd[1]: Reached target Remote File Systems. Oct 28 04:46:36.705029 systemd[1]: Reached target Slice Units. Oct 28 04:46:36.705039 systemd[1]: Reached target Swaps. Oct 28 04:46:36.705049 systemd[1]: Reached target Verify torcx succeeded. Oct 28 04:46:36.705058 systemd[1]: Reached target Local Verity Protected Volumes. Oct 28 04:46:36.705069 systemd[1]: Listening on Process Core Dump Socket. Oct 28 04:46:36.705079 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 28 04:46:36.705089 systemd[1]: Listening on Network Service Netlink Socket. Oct 28 04:46:36.705098 systemd[1]: Listening on udev Control Socket. Oct 28 04:46:36.705108 systemd[1]: Listening on udev Kernel Socket. Oct 28 04:46:36.705118 systemd[1]: Mounting Huge Pages File System... Oct 28 04:46:36.705128 systemd[1]: Mounting POSIX Message Queue File System... Oct 28 04:46:36.705137 systemd[1]: Mounting External Media Directory... Oct 28 04:46:36.705147 systemd[1]: Mounting Kernel Debug File System... Oct 28 04:46:36.705158 systemd[1]: Mounting Kernel Trace File System... Oct 28 04:46:36.705168 systemd[1]: Mounting Temporary Directory /tmp... Oct 28 04:46:36.705177 systemd[1]: Starting Create missing system files... Oct 28 04:46:36.705187 systemd[1]: Starting Create List of Static Device Nodes... Oct 28 04:46:36.705206 systemd[1]: Starting Load Kernel Module configfs... Oct 28 04:46:36.705216 systemd[1]: Starting Load Kernel Module drm... Oct 28 04:46:36.705226 systemd[1]: Starting Load Kernel Module fuse... Oct 28 04:46:36.705236 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 28 04:46:36.705247 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 28 04:46:36.705258 systemd[1]: Stopped File System Check on Root Device. Oct 28 04:46:36.705270 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 28 04:46:36.705279 kernel: fuse: init (API version 7.32) Oct 28 04:46:36.705289 systemd[1]: Stopped systemd-fsck-usr.service. Oct 28 04:46:36.705299 systemd[1]: Stopped Journal Service. Oct 28 04:46:36.705309 systemd[1]: Starting Journal Service... Oct 28 04:46:36.705319 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 28 04:46:36.705330 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 28 04:46:36.705340 systemd[1]: Starting Apply Kernel Variables... Oct 28 04:46:36.705349 systemd[1]: Starting Coldplug All udev Devices... Oct 28 04:46:36.705364 systemd[1]: verity-setup.service: Deactivated successfully. Oct 28 04:46:36.705375 systemd[1]: Stopped verity-setup.service. Oct 28 04:46:36.705387 systemd-journald[694]: Journal started Oct 28 04:46:36.705430 systemd-journald[694]: Runtime Journal (/run/log/journal/419b7e9678d1437eaeffbe6d8914f0ff) is 6.0M, max 48.5M, 42.4M free. Oct 28 04:46:34.703000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 28 04:46:34.732000 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:46:34.732000 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:46:34.732000 audit: BPF prog-id=15 op=LOAD Oct 28 04:46:34.732000 audit: BPF prog-id=15 op=UNLOAD Oct 28 04:46:34.732000 audit: BPF prog-id=16 op=LOAD Oct 28 04:46:34.732000 audit: BPF prog-id=16 op=UNLOAD Oct 28 04:46:34.769000 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:46:36.581000 audit: BPF prog-id=17 op=LOAD Oct 28 04:46:36.581000 audit: BPF prog-id=18 op=LOAD Oct 28 04:46:36.581000 audit: BPF prog-id=19 op=LOAD Oct 28 04:46:36.581000 audit: BPF prog-id=10 op=UNLOAD Oct 28 04:46:36.581000 audit: BPF prog-id=11 op=UNLOAD Oct 28 04:46:36.595000 audit: BPF prog-id=17 op=UNLOAD Oct 28 04:46:36.691000 audit: BPF prog-id=20 op=LOAD Oct 28 04:46:36.691000 audit: BPF prog-id=21 op=LOAD Oct 28 04:46:36.692000 audit: BPF prog-id=22 op=LOAD Oct 28 04:46:36.692000 audit: BPF prog-id=18 op=UNLOAD Oct 28 04:46:36.692000 audit: BPF prog-id=19 op=UNLOAD Oct 28 04:46:36.703000 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:46:36.570882 systemd[1]: Queued start job for default target Multi-User System. Oct 28 04:46:34.767884 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" 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:46:36.582068 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 28 04:46:34.768167 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 04:46:34.768187 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 04:46:34.768524 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 28 04:46:34.768537 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 28 04:46:34.768574 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 28 04:46:34.768587 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 28 04:46:34.768934 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 28 04:46:34.768973 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 28 04:46:34.768986 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 28 04:46:34.769451 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" 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:46:34.769483 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" 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:46:34.769504 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" 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:46:34.769519 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" 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:46:34.769632 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" 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:46:34.769651 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:34Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 28 04:46:36.482033 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:36Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 28 04:46:36.482316 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:36Z" 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:46:36.482431 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:36Z" 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:46:36.482550 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:36Z" 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:46:36.482642 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:36Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 28 04:46:36.482697 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-10-28T04:46:36Z" 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:46:36.709802 systemd[1]: Started Journal Service. Oct 28 04:46:36.710344 systemd[1]: Mounted Huge Pages File System. Oct 28 04:46:36.711312 systemd[1]: Mounted POSIX Message Queue File System. Oct 28 04:46:36.712342 systemd[1]: Mounted External Media Directory. Oct 28 04:46:36.713342 systemd[1]: Mounted Kernel Debug File System. Oct 28 04:46:36.714312 systemd[1]: Mounted Kernel Trace File System. Oct 28 04:46:36.715335 systemd[1]: Mounted Temporary Directory /tmp. Oct 28 04:46:36.716619 systemd[1]: Finished Create missing system files. Oct 28 04:46:36.717867 systemd[1]: Finished Create List of Static Device Nodes. Oct 28 04:46:36.719143 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 28 04:46:36.719379 systemd[1]: Finished Load Kernel Module configfs. Oct 28 04:46:36.720505 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 04:46:36.720700 systemd[1]: Finished Load Kernel Module drm. Oct 28 04:46:36.721766 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 28 04:46:36.721948 systemd[1]: Finished Load Kernel Module fuse. Oct 28 04:46:36.723173 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 28 04:46:36.724596 systemd[1]: Finished Apply Kernel Variables. Oct 28 04:46:36.742213 systemd[1]: Mounting FUSE Control File System... Oct 28 04:46:36.744111 systemd[1]: Mounting Kernel Configuration File System... Oct 28 04:46:36.745102 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 28 04:46:36.746130 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 28 04:46:36.747145 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 28 04:46:36.748272 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 28 04:46:36.749272 systemd[1]: Starting Load/Save Random Seed... Oct 28 04:46:36.751780 systemd-journald[694]: Time spent on flushing to /var/log/journal/419b7e9678d1437eaeffbe6d8914f0ff is 13.117ms for 654 entries. Oct 28 04:46:36.751780 systemd-journald[694]: System Journal (/var/log/journal/419b7e9678d1437eaeffbe6d8914f0ff) is 16.0M, max 203.0M, 187.0M free. Oct 28 04:46:36.750121 systemd[1]: Condition check resulted in Create System Users being skipped. Oct 28 04:46:36.751281 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 28 04:46:36.754351 systemd[1]: Mounted FUSE Control File System. Oct 28 04:46:36.755538 systemd[1]: Mounted Kernel Configuration File System. Oct 28 04:46:36.756997 systemd[1]: Finished Load/Save Random Seed. Oct 28 04:46:36.758316 systemd[1]: Condition check resulted in First Boot Complete being skipped. Oct 28 04:46:36.769596 systemd[1]: Finished Coldplug All udev Devices. Oct 28 04:46:36.771952 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 28 04:46:36.779146 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 28 04:46:36.780680 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 28 04:46:36.782000 audit: BPF prog-id=23 op=LOAD Oct 28 04:46:36.782000 audit: BPF prog-id=24 op=LOAD Oct 28 04:46:36.782000 audit: BPF prog-id=25 op=LOAD Oct 28 04:46:36.782000 audit: BPF prog-id=13 op=UNLOAD Oct 28 04:46:36.782000 audit: BPF prog-id=14 op=UNLOAD Oct 28 04:46:36.783414 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 28 04:46:36.811149 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 28 04:46:36.821528 systemd[1]: Starting Network Configuration... Oct 28 04:46:36.820000 audit: BPF prog-id=26 op=LOAD Oct 28 04:46:36.847899 systemd-udevd[723]: Using default interface naming scheme 'v249'. Oct 28 04:46:36.849308 systemd-networkd[726]: lo: Link UP Oct 28 04:46:36.849319 systemd-networkd[726]: lo: Gained carrier Oct 28 04:46:36.849662 systemd-networkd[726]: Enumeration completed Oct 28 04:46:36.849771 systemd[1]: Started Network Configuration. Oct 28 04:46:36.852154 systemd-networkd[726]: eth0: Link UP Oct 28 04:46:36.860243 systemd-networkd[726]: eth0: Gained carrier Oct 28 04:46:36.864364 systemd-networkd[726]: eth0: DHCPv4 address 10.0.0.8/16 via 10.0.0.1 Oct 28 04:46:36.877854 udevadm[706]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 28 04:46:36.900455 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 28 04:46:36.915756 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 04:46:36.924013 lvm[734]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 04:46:36.954423 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 04:46:36.957608 systemd[1]: Reached target Local Encrypted Volumes. Oct 28 04:46:36.971340 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 28 04:46:36.974827 lvm[735]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 28 04:46:37.000338 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 28 04:46:37.001462 systemd[1]: Reached target Preparation for Local File Systems. Oct 28 04:46:37.002609 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 28 04:46:37.002635 systemd[1]: Reached target Containers. Oct 28 04:46:37.012490 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 28 04:46:37.025126 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 28 04:46:37.027767 systemd[1]: Mounting /usr/share/oem... Oct 28 04:46:37.034459 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 28 04:46:37.034529 kernel: BTRFS info (device vda6): has skinny extents Oct 28 04:46:37.036813 systemd[1]: Mounted /usr/share/oem. Oct 28 04:46:37.037706 systemd[1]: Reached target Local File Systems. Oct 28 04:46:37.038704 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Oct 28 04:46:37.039060 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 28 04:46:37.039097 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 28 04:46:37.039129 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 28 04:46:37.040244 systemd[1]: Starting Create Volatile Files and Directories... Oct 28 04:46:37.046382 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 28 04:46:37.047453 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 28 04:46:37.076171 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 04:46:37.076181 systemd-tmpfiles[758]: Skipping /boot Oct 28 04:46:37.082988 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Oct 28 04:46:37.083005 systemd-tmpfiles[758]: Skipping /boot Oct 28 04:46:37.115944 systemd[1]: Finished Create Volatile Files and Directories. Oct 28 04:46:37.127227 systemd[1]: Starting Load Security Auditing Rules... Oct 28 04:46:37.129097 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 28 04:46:37.130329 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Oct 28 04:46:37.130000 audit: BPF prog-id=27 op=LOAD Oct 28 04:46:37.132262 systemd[1]: Starting Network Name Resolution... Oct 28 04:46:37.134000 audit: BPF prog-id=28 op=LOAD Oct 28 04:46:37.135292 systemd[1]: Starting Network Time Synchronization... Oct 28 04:46:37.136251 systemd[1]: Condition check resulted in Update is Completed being skipped. Oct 28 04:46:37.137310 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 28 04:46:37.138789 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 28 04:46:37.140161 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 28 04:46:37.144555 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 28 04:46:37.153000 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:46:37.153683 augenrules[779]: No rules Oct 28 04:46:37.154764 systemd[1]: Finished Load Security Auditing Rules. Oct 28 04:46:37.171422 systemd-timesyncd[768]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 28 04:46:37.172394 systemd[1]: Started Network Time Synchronization. Oct 28 04:46:37.172611 systemd-resolved[764]: Positive Trust Anchors: Oct 28 04:46:37.172618 systemd-resolved[764]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 04:46:37.172645 systemd-resolved[764]: 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:46:37.173650 systemd[1]: Reached target System Initialization. Oct 28 04:46:37.173832 systemd-resolved[764]: Defaulting to hostname 'linux'. Oct 28 04:46:37.174657 systemd[1]: Started Watch for update engine configuration changes. Oct 28 04:46:37.177923 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 04:46:37.180188 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 28 04:46:37.181184 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 28 04:46:37.181238 systemd[1]: Reached target Path Units. Oct 28 04:46:37.183012 systemd[1]: Reached target System Time Set. Oct 28 04:46:37.184186 systemd[1]: Started Daily Log Rotation. Oct 28 04:46:37.185050 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 28 04:46:37.186240 systemd[1]: Reached target Timer Units. Oct 28 04:46:37.187454 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 28 04:46:37.210979 systemd[1]: Starting Docker Socket for the API... Oct 28 04:46:37.214618 systemd[1]: Listening on OpenSSH Server Socket. Oct 28 04:46:37.216073 systemd[1]: Started Network Name Resolution. Oct 28 04:46:37.217151 systemd[1]: Listening on Docker Socket for the API. Oct 28 04:46:37.218235 systemd[1]: Reached target Network. Oct 28 04:46:37.219005 systemd[1]: Reached target Host and Network Name Lookups. Oct 28 04:46:37.220057 systemd[1]: Reached target Socket Units. Oct 28 04:46:37.220912 systemd[1]: Reached target Basic System. Oct 28 04:46:37.222254 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 28 04:46:37.222291 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 28 04:46:37.223635 systemd[1]: Started D-Bus System Message Bus. Oct 28 04:46:37.227177 systemd[1]: Starting Extend Filesystems... Oct 28 04:46:37.228013 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 28 04:46:37.229043 systemd[1]: Starting Generate /run/flatcar/motd... Oct 28 04:46:37.231026 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 28 04:46:37.234374 systemd[1]: Starting Generate sshd host keys... Oct 28 04:46:37.235182 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 28 04:46:37.235233 systemd[1]: Reached target Load system-provided cloud configs. Oct 28 04:46:37.238251 systemd[1]: Starting User Login Management... Oct 28 04:46:37.239412 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 28 04:46:37.240982 extend-filesystems[788]: Found vda Oct 28 04:46:37.240040 systemd[1]: Starting Update Engine... Oct 28 04:46:37.243294 extend-filesystems[788]: Found vda1 Oct 28 04:46:37.243294 extend-filesystems[788]: Found vda2 Oct 28 04:46:37.243294 extend-filesystems[788]: Found vda3 Oct 28 04:46:37.243294 extend-filesystems[788]: Found usr Oct 28 04:46:37.243294 extend-filesystems[788]: Found vda4 Oct 28 04:46:37.243294 extend-filesystems[788]: Found vda6 Oct 28 04:46:37.243294 extend-filesystems[788]: Found vda7 Oct 28 04:46:37.243294 extend-filesystems[788]: Found vda9 Oct 28 04:46:37.243294 extend-filesystems[788]: Checking size of /dev/vda9 Oct 28 04:46:37.240993 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 28 04:46:37.271228 extend-filesystems[788]: Old size kept for /dev/vda9 Oct 28 04:46:37.241032 systemd[1]: Reached target Load user-provided cloud configs. Oct 28 04:46:37.242914 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 28 04:46:37.243174 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 28 04:46:37.253581 systemd[1]: motdgen.service: Deactivated successfully. Oct 28 04:46:37.253827 systemd[1]: Finished Generate /run/flatcar/motd. Oct 28 04:46:37.258230 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 28 04:46:37.258653 systemd[1]: Finished Extend Filesystems. Oct 28 04:46:37.280445 systemd-logind[799]: Watching system buttons on /dev/input/event0 (Power Button) Oct 28 04:46:37.280734 systemd-logind[799]: New seat seat0. Oct 28 04:46:37.285785 systemd[1]: Started User Login Management. Oct 28 04:46:37.293729 update_engine[803]: I1028 04:46:37.293464 803 main.cc:89] Flatcar Update Engine starting Oct 28 04:46:37.294281 update_engine[803]: I1028 04:46:37.294253 803 payload_state.cc:360] Current Response Signature = Oct 28 04:46:37.294281 update_engine[803]: NumURLs = 1 Oct 28 04:46:37.294281 update_engine[803]: Url0 = http://10.0.0.7:34567/packages/update.gz Oct 28 04:46:37.294281 update_engine[803]: Payload Size = 439465725 Oct 28 04:46:37.294281 update_engine[803]: Payload Sha256 Hash = dykyx/Y4jQdfCP1f9j5W1sV+S815EIPi4QJ65LWeHik= Oct 28 04:46:37.294281 update_engine[803]: Is Delta Payload = 0 Oct 28 04:46:37.294281 update_engine[803]: Max Failure Count Per Url = 10 Oct 28 04:46:37.294281 update_engine[803]: Disable Payload Backoff = 1 Oct 28 04:46:37.294514 update_engine[803]: I1028 04:46:37.294490 803 payload_state.cc:381] Payload Attempt Number = 0 Oct 28 04:46:37.294674 update_engine[803]: I1028 04:46:37.294660 803 payload_state.cc:404] Current URL Index = 0 Oct 28 04:46:37.294818 update_engine[803]: I1028 04:46:37.294806 803 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 28 04:46:37.294965 update_engine[803]: I1028 04:46:37.294940 803 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 28 04:46:37.298515 systemd[1]: Started Update Engine. Oct 28 04:46:37.299315 update_engine[803]: I1028 04:46:37.299275 803 update_check_scheduler.cc:74] Next update check in 7m4s Oct 28 04:46:37.303468 systemd[1]: Finished Generate sshd host keys. Oct 28 04:46:37.316367 systemd[1]: Starting Generate /run/issue... Oct 28 04:46:37.320830 systemd[1]: issuegen.service: Deactivated successfully. Oct 28 04:46:37.321066 systemd[1]: Finished Generate /run/issue. Oct 28 04:46:37.323259 systemd[1]: Starting Permit User Sessions... Oct 28 04:46:37.328158 systemd[1]: Finished Permit User Sessions. Oct 28 04:46:37.330383 systemd[1]: Started Getty on tty1. Oct 28 04:46:37.332420 systemd[1]: Started Serial Getty on ttyAMA0. Oct 28 04:46:37.333480 systemd[1]: Reached target Login Prompts. Oct 28 04:46:37.334503 systemd[1]: Reached target Multi-User System. Oct 28 04:46:37.336680 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 28 04:46:37.342033 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 28 04:46:37.342282 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 28 04:46:37.343312 systemd[1]: Startup finished in 694ms (kernel) + 1.114s (initrd) + 2.672s (userspace) = 4.482s. Oct 28 04:46:37.884625 systemd-networkd[726]: eth0: Gained IPv6LL Oct 28 04:46:46.944286 systemd[1]: Created slice Slice /system/sshd. Oct 28 04:46:46.945418 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58512). Oct 28 04:46:46.989559 sshd[829]: Accepted publickey for core from 10.0.0.1 port 58512 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:46.991472 sshd[829]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:47.008751 systemd[1]: Created slice User Slice of UID 500. Oct 28 04:46:47.009919 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 28 04:46:47.011599 systemd-logind[799]: New session 1 of user core. Oct 28 04:46:47.016503 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 28 04:46:47.017912 systemd[1]: Starting User Manager for UID 500... Oct 28 04:46:47.020371 systemd[832]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:47.069217 systemd[832]: Queued start job for default target Main User Target. Oct 28 04:46:47.069408 systemd[832]: Reached target Paths. Oct 28 04:46:47.069424 systemd[832]: Reached target Sockets. Oct 28 04:46:47.069435 systemd[832]: Reached target Timers. Oct 28 04:46:47.069444 systemd[832]: Reached target Basic System. Oct 28 04:46:47.069487 systemd[832]: Reached target Main User Target. Oct 28 04:46:47.069500 systemd[832]: Startup finished in 44ms. Oct 28 04:46:47.069580 systemd[1]: Started User Manager for UID 500. Oct 28 04:46:47.077398 systemd[1]: Started Session 1 of User core. Oct 28 04:46:47.140519 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58516). Oct 28 04:46:47.179058 sshd[841]: Accepted publickey for core from 10.0.0.1 port 58516 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:47.180224 sshd[841]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:47.183278 systemd-logind[799]: New session 2 of user core. Oct 28 04:46:47.192377 systemd[1]: Started Session 2 of User core. Oct 28 04:46:47.244937 sshd[841]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:47.262953 systemd[1]: sshd@1-10.0.0.8:22-10.0.0.1:58516.service: Deactivated successfully. Oct 28 04:46:47.263589 systemd[1]: session-2.scope: Deactivated successfully. Oct 28 04:46:47.264176 systemd-logind[799]: Session 2 logged out. Waiting for processes to exit. Oct 28 04:46:47.265178 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58532). Oct 28 04:46:47.265733 systemd-logind[799]: Removed session 2. Oct 28 04:46:47.304840 sshd[847]: Accepted publickey for core from 10.0.0.1 port 58532 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:47.305881 sshd[847]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:47.308824 systemd-logind[799]: New session 3 of user core. Oct 28 04:46:47.322344 systemd[1]: Started Session 3 of User core. Oct 28 04:46:47.370181 sshd[847]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:47.379839 systemd[1]: sshd@2-10.0.0.8:22-10.0.0.1:58532.service: Deactivated successfully. Oct 28 04:46:47.380422 systemd[1]: session-3.scope: Deactivated successfully. Oct 28 04:46:47.380974 systemd-logind[799]: Session 3 logged out. Waiting for processes to exit. Oct 28 04:46:47.381985 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58542). Oct 28 04:46:47.382522 systemd-logind[799]: Removed session 3. Oct 28 04:46:47.421763 sshd[854]: Accepted publickey for core from 10.0.0.1 port 58542 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:47.422740 sshd[854]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:47.425557 systemd-logind[799]: New session 4 of user core. Oct 28 04:46:47.433372 systemd[1]: Started Session 4 of User core. Oct 28 04:46:47.484217 sshd[854]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:47.491744 systemd[1]: sshd@3-10.0.0.8:22-10.0.0.1:58542.service: Deactivated successfully. Oct 28 04:46:47.492310 systemd[1]: session-4.scope: Deactivated successfully. Oct 28 04:46:47.492919 systemd-logind[799]: Session 4 logged out. Waiting for processes to exit. Oct 28 04:46:47.493883 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58558). Oct 28 04:46:47.494427 systemd-logind[799]: Removed session 4. Oct 28 04:46:47.532579 sshd[860]: Accepted publickey for core from 10.0.0.1 port 58558 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:47.533882 sshd[860]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:47.536430 systemd-logind[799]: New session 5 of user core. Oct 28 04:46:47.542353 systemd[1]: Started Session 5 of User core. Oct 28 04:46:47.599502 sudo[863]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 28 04:46:47.599755 sudo[863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:46:47.611769 sudo[863]: pam_unix(sudo:session): session closed for user root Oct 28 04:46:47.613553 sshd[860]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:47.628101 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58560). Oct 28 04:46:47.630931 dbus-daemon[787]: [system] Reloaded configuration Oct 28 04:46:47.633741 systemd[1]: sshd@4-10.0.0.8:22-10.0.0.1:58558.service: Deactivated successfully. Oct 28 04:46:47.634457 systemd[1]: session-5.scope: Deactivated successfully. Oct 28 04:46:47.635094 systemd-logind[799]: Session 5 logged out. Waiting for processes to exit. Oct 28 04:46:47.635742 systemd-logind[799]: Removed session 5. Oct 28 04:46:47.666794 sshd[866]: Accepted publickey for core from 10.0.0.1 port 58560 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:47.667858 sshd[866]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:47.670506 systemd-logind[799]: New session 6 of user core. Oct 28 04:46:47.683387 systemd[1]: Started Session 6 of User core. Oct 28 04:46:47.733789 sudo[871]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 28 04:46:47.733989 sudo[871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:46:47.736584 sudo[871]: pam_unix(sudo:session): session closed for user root Oct 28 04:46:47.740054 sudo[870]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 28 04:46:47.740271 sudo[870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 28 04:46:47.764237 systemd[1]: Stopping Load Security Auditing Rules... Oct 28 04:46:47.765000 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:46:47.766356 auditctl[874]: No rules Oct 28 04:46:47.766665 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 04:46:47.766894 systemd[1]: Stopped Load Security Auditing Rules. Oct 28 04:46:47.768007 kernel: kauditd_printk_skb: 37 callbacks suppressed Oct 28 04:46:47.768066 kernel: audit: type=1305 audit(1761626807.765: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:46:47.768244 systemd[1]: Starting Load Security Auditing Rules... Oct 28 04:46:47.783299 augenrules[891]: No rules Oct 28 04:46:47.784283 systemd[1]: Finished Load Security Auditing Rules. Oct 28 04:46:47.785212 sudo[870]: pam_unix(sudo:session): session closed for user root Oct 28 04:46:47.786510 sshd[866]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:47.792807 systemd[1]: sshd@5-10.0.0.8:22-10.0.0.1:58560.service: Deactivated successfully. Oct 28 04:46:47.793347 systemd[1]: session-6.scope: Deactivated successfully. Oct 28 04:46:47.793937 systemd-logind[799]: Session 6 logged out. Waiting for processes to exit. Oct 28 04:46:47.794843 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58572). Oct 28 04:46:47.795408 systemd-logind[799]: Removed session 6. Oct 28 04:46:47.832741 sshd[897]: Accepted publickey for core from 10.0.0.1 port 58572 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:47.833775 sshd[897]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:47.836231 kernel: audit: type=1006 audit(1761626807.833:49): pid=897 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Oct 28 04:46:47.837329 systemd-logind[799]: New session 7 of user core. Oct 28 04:46:47.853378 systemd[1]: Started Session 7 of User core. Oct 28 04:46:47.901937 sshd[897]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:47.925891 systemd[1]: sshd@6-10.0.0.8:22-10.0.0.1:58572.service: Deactivated successfully. Oct 28 04:46:47.926466 systemd[1]: session-7.scope: Deactivated successfully. Oct 28 04:46:47.927046 systemd-logind[799]: Session 7 logged out. Waiting for processes to exit. Oct 28 04:46:47.928002 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58588). Oct 28 04:46:47.928576 systemd-logind[799]: Removed session 7. Oct 28 04:46:47.966358 sshd[903]: Accepted publickey for core from 10.0.0.1 port 58588 ssh2: RSA SHA256:z/Rb52OeDGjQogEbwl5U/wzC2ymNhR3ZQr4S5IuaJRc Oct 28 04:46:47.967667 sshd[903]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:46:47.970233 kernel: audit: type=1006 audit(1761626807.966:50): pid=903 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Oct 28 04:46:47.970574 systemd-logind[799]: New session 8 of user core. Oct 28 04:46:47.983387 systemd[1]: Started Session 8 of User core. Oct 28 04:46:48.031787 sshd[903]: pam_unix(sshd:session): session closed for user core Oct 28 04:46:48.033905 systemd[1]: sshd@7-10.0.0.8:22-10.0.0.1:58588.service: Deactivated successfully. Oct 28 04:46:48.034587 systemd[1]: session-8.scope: Deactivated successfully. Oct 28 04:46:48.035162 systemd-logind[799]: Session 8 logged out. Waiting for processes to exit. Oct 28 04:46:48.035768 systemd-logind[799]: Removed session 8.