Oct 30 05:05:07.697241 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 30 05:05:07.697257 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 30 05:05:07.697266 kernel: efi: EFI v2.70 by EDK II Oct 30 05:05:07.697271 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 30 05:05:07.697276 kernel: efi: seeding entropy pool Oct 30 05:05:07.697281 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 30 05:05:07.697288 kernel: ACPI: Early table checksum verification disabled Oct 30 05:05:07.697293 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 30 05:05:07.697298 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 30 05:05:07.697303 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:07.697320 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:07.697326 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:07.697331 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:07.697336 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:07.697342 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:07.697348 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:07.697355 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:07.697360 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:07.697366 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 30 05:05:07.697371 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 30 05:05:07.697376 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:05:07.697382 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 30 05:05:07.697387 kernel: Zone ranges: Oct 30 05:05:07.697392 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:05:07.697397 kernel: DMA32 empty Oct 30 05:05:07.697402 kernel: Normal empty Oct 30 05:05:07.697408 kernel: Movable zone start for each node Oct 30 05:05:07.697414 kernel: Early memory node ranges Oct 30 05:05:07.697419 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 30 05:05:07.697425 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 30 05:05:07.697430 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 30 05:05:07.697435 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 30 05:05:07.697440 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 30 05:05:07.697446 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 30 05:05:07.697451 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 30 05:05:07.697456 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 30 05:05:07.697461 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 30 05:05:07.697467 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 30 05:05:07.697472 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 30 05:05:07.697478 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:05:07.697486 kernel: On node 0 totalpages: 643072 Oct 30 05:05:07.697492 kernel: DMA zone: 10048 pages used for memmap Oct 30 05:05:07.697498 kernel: DMA zone: 0 pages reserved Oct 30 05:05:07.697503 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 30 05:05:07.697509 kernel: psci: probing for conduit method from ACPI. Oct 30 05:05:07.697515 kernel: psci: PSCIv1.1 detected in firmware. Oct 30 05:05:07.697520 kernel: psci: Using standard PSCI v0.2 function IDs Oct 30 05:05:07.697526 kernel: psci: Trusted OS migration not required Oct 30 05:05:07.697535 kernel: psci: SMC Calling Convention v1.1 Oct 30 05:05:07.697541 kernel: ACPI: SRAT not present Oct 30 05:05:07.697547 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 30 05:05:07.697552 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 30 05:05:07.697569 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 30 05:05:07.697575 kernel: Detected PIPT I-cache on CPU0 Oct 30 05:05:07.697581 kernel: CPU features: detected: GIC system register CPU interface Oct 30 05:05:07.697586 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 30 05:05:07.697592 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 30 05:05:07.697598 kernel: CPU features: detected: Hardware dirty bit management Oct 30 05:05:07.697603 kernel: CPU features: detected: Spectre-v4 Oct 30 05:05:07.697612 kernel: CPU features: detected: ARM erratum 1418040 Oct 30 05:05:07.697617 kernel: CPU features: detected: Spectre-BHB Oct 30 05:05:07.697623 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 30 05:05:07.697628 kernel: Policy zone: DMA Oct 30 05:05:07.697635 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 30 05:05:07.697641 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 30 05:05:07.697647 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 30 05:05:07.697653 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 30 05:05:07.697658 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 30 05:05:07.697664 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 30 05:05:07.697670 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 30 05:05:07.697677 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 30 05:05:07.697683 kernel: rcu: RCU event tracing is enabled. Oct 30 05:05:07.697688 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 30 05:05:07.697694 kernel: Trampoline variant of Tasks RCU enabled. Oct 30 05:05:07.697700 kernel: Tracing variant of Tasks RCU enabled. Oct 30 05:05:07.697705 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 30 05:05:07.697711 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 30 05:05:07.697717 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 30 05:05:07.697722 kernel: GICv3: 256 SPIs implemented Oct 30 05:05:07.697728 kernel: GICv3: 0 Extended SPIs implemented Oct 30 05:05:07.697733 kernel: GICv3: Distributor has no Range Selector support Oct 30 05:05:07.697739 kernel: GICv3: 16 PPIs implemented Oct 30 05:05:07.697746 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 30 05:05:07.697751 kernel: ACPI: SRAT not present Oct 30 05:05:07.697757 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 30 05:05:07.697762 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 30 05:05:07.697768 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 30 05:05:07.697774 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 30 05:05:07.697780 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 30 05:05:07.697786 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:05:07.697792 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 30 05:05:07.697798 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 30 05:05:07.697804 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 30 05:05:07.697810 kernel: arm-pv: using stolen time PV Oct 30 05:05:07.697817 kernel: Console: colour dummy device 80x25 Oct 30 05:05:07.697823 kernel: ACPI: Core revision 20200925 Oct 30 05:05:07.697829 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 30 05:05:07.697835 kernel: pid_max: default: 32768 minimum: 301 Oct 30 05:05:07.697841 kernel: LSM: Security Framework initializing Oct 30 05:05:07.697847 kernel: SELinux: Initializing. Oct 30 05:05:07.697853 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 30 05:05:07.697859 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 30 05:05:07.697865 kernel: rcu: Hierarchical SRCU implementation. Oct 30 05:05:07.697872 kernel: Platform MSI: ITS@0x8080000 domain created Oct 30 05:05:07.697878 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 30 05:05:07.697883 kernel: Remapping and enabling EFI services. Oct 30 05:05:07.697889 kernel: smp: Bringing up secondary CPUs ... Oct 30 05:05:07.697895 kernel: Detected PIPT I-cache on CPU1 Oct 30 05:05:07.697901 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 30 05:05:07.697907 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 30 05:05:07.697913 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:05:07.697919 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 30 05:05:07.697924 kernel: Detected PIPT I-cache on CPU2 Oct 30 05:05:07.697932 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 30 05:05:07.697938 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 30 05:05:07.697943 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:05:07.697949 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 30 05:05:07.697955 kernel: Detected PIPT I-cache on CPU3 Oct 30 05:05:07.697965 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 30 05:05:07.697971 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 30 05:05:07.697978 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:05:07.697984 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 30 05:05:07.697990 kernel: smp: Brought up 1 node, 4 CPUs Oct 30 05:05:07.697996 kernel: SMP: Total of 4 processors activated. Oct 30 05:05:07.698002 kernel: CPU features: detected: Privileged Access Never Oct 30 05:05:07.698008 kernel: CPU features: detected: LSE atomic instructions Oct 30 05:05:07.698014 kernel: CPU features: detected: User Access Override Oct 30 05:05:07.698020 kernel: CPU features: detected: 32-bit EL0 Support Oct 30 05:05:07.698026 kernel: CPU features: detected: Common not Private translations Oct 30 05:05:07.698032 kernel: CPU features: detected: RAS Extension Support Oct 30 05:05:07.698040 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 30 05:05:07.698046 kernel: CPU features: detected: CRC32 instructions Oct 30 05:05:07.698052 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 30 05:05:07.698058 kernel: CPU: All CPU(s) started at EL1 Oct 30 05:05:07.698064 kernel: alternatives: patching kernel code Oct 30 05:05:07.698071 kernel: devtmpfs: initialized Oct 30 05:05:07.698077 kernel: KASLR enabled Oct 30 05:05:07.698083 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 30 05:05:07.698089 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 30 05:05:07.698095 kernel: pinctrl core: initialized pinctrl subsystem Oct 30 05:05:07.698101 kernel: SMBIOS 3.0.0 present. Oct 30 05:05:07.698107 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 30 05:05:07.698114 kernel: NET: Registered protocol family 16 Oct 30 05:05:07.698120 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 30 05:05:07.698126 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 30 05:05:07.698134 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 30 05:05:07.698140 kernel: audit: initializing netlink subsys (disabled) Oct 30 05:05:07.698146 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Oct 30 05:05:07.698152 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 30 05:05:07.698158 kernel: cpuidle: using governor menu Oct 30 05:05:07.698164 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 30 05:05:07.698171 kernel: ASID allocator initialised with 32768 entries Oct 30 05:05:07.698177 kernel: ACPI: bus type PCI registered Oct 30 05:05:07.698183 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 30 05:05:07.698190 kernel: Serial: AMBA PL011 UART driver Oct 30 05:05:07.698196 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 30 05:05:07.698202 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 30 05:05:07.698208 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 30 05:05:07.698214 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 30 05:05:07.698221 kernel: cryptd: max_cpu_qlen set to 1000 Oct 30 05:05:07.698227 kernel: ACPI: Added _OSI(Module Device) Oct 30 05:05:07.698232 kernel: ACPI: Added _OSI(Processor Device) Oct 30 05:05:07.698239 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 30 05:05:07.698246 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 30 05:05:07.698252 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 30 05:05:07.698258 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 30 05:05:07.698264 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 30 05:05:07.698271 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 30 05:05:07.698277 kernel: ACPI: Interpreter enabled Oct 30 05:05:07.698283 kernel: ACPI: Using GIC for interrupt routing Oct 30 05:05:07.698289 kernel: ACPI: MCFG table detected, 1 entries Oct 30 05:05:07.698295 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 30 05:05:07.698302 kernel: printk: console [ttyAMA0] enabled Oct 30 05:05:07.698314 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 30 05:05:07.698428 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 30 05:05:07.698486 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 30 05:05:07.698547 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 30 05:05:07.698614 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 30 05:05:07.698669 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 30 05:05:07.698677 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 30 05:05:07.698686 kernel: PCI host bridge to bus 0000:00 Oct 30 05:05:07.698746 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 30 05:05:07.698796 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 30 05:05:07.698846 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 30 05:05:07.698896 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 30 05:05:07.698963 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 30 05:05:07.699026 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 30 05:05:07.699088 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 30 05:05:07.699144 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 30 05:05:07.699201 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 30 05:05:07.699257 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 30 05:05:07.699320 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 30 05:05:07.699378 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 30 05:05:07.699428 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 30 05:05:07.699480 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 30 05:05:07.699531 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 30 05:05:07.699542 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 30 05:05:07.699549 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 30 05:05:07.699563 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 30 05:05:07.699569 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 30 05:05:07.699575 kernel: vgaarb: loaded Oct 30 05:05:07.699582 kernel: Registered efivars operations Oct 30 05:05:07.699588 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 30 05:05:07.699596 kernel: VFS: Disk quotas dquot_6.6.0 Oct 30 05:05:07.699603 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 30 05:05:07.699609 kernel: pnp: PnP ACPI init Oct 30 05:05:07.699678 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 30 05:05:07.699729 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 30 05:05:07.699738 kernel: pnp: PnP ACPI: found 1 devices Oct 30 05:05:07.699744 kernel: NET: Registered protocol family 2 Oct 30 05:05:07.699751 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 30 05:05:07.699759 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 30 05:05:07.699765 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 30 05:05:07.699771 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 30 05:05:07.699778 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 30 05:05:07.699784 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 30 05:05:07.699790 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 30 05:05:07.699796 kernel: NET: Registered protocol family 1 Oct 30 05:05:07.699802 kernel: PCI: CLS 0 bytes, default 64 Oct 30 05:05:07.699808 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 30 05:05:07.699816 kernel: kvm [1]: HYP mode not available Oct 30 05:05:07.699822 kernel: Initialise system trusted keyrings Oct 30 05:05:07.699828 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 30 05:05:07.699834 kernel: Key type asymmetric registered Oct 30 05:05:07.699840 kernel: Asymmetric key parser 'x509' registered Oct 30 05:05:07.699846 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 30 05:05:07.699852 kernel: io scheduler mq-deadline registered Oct 30 05:05:07.699858 kernel: io scheduler kyber registered Oct 30 05:05:07.699864 kernel: io scheduler bfq registered Oct 30 05:05:07.699872 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 30 05:05:07.699878 kernel: ACPI: Power Button [PWRB] Oct 30 05:05:07.699884 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 30 05:05:07.699941 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 30 05:05:07.699949 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 30 05:05:07.699955 kernel: msm_serial: driver initialized Oct 30 05:05:07.699962 kernel: random: fast init done Oct 30 05:05:07.699967 kernel: random: crng init done Oct 30 05:05:07.699973 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 30 05:05:07.699980 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 30 05:05:07.699988 kernel: thunder_xcv, ver 1.0 Oct 30 05:05:07.699994 kernel: thunder_bgx, ver 1.0 Oct 30 05:05:07.700000 kernel: nicpf, ver 1.0 Oct 30 05:05:07.700006 kernel: nicvf, ver 1.0 Oct 30 05:05:07.700067 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 30 05:05:07.700123 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-30T05:05:07 UTC (1761800707) Oct 30 05:05:07.700131 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 30 05:05:07.700137 kernel: NET: Registered protocol family 10 Oct 30 05:05:07.700145 kernel: Segment Routing with IPv6 Oct 30 05:05:07.700151 kernel: NET: Registered protocol family 17 Oct 30 05:05:07.700157 kernel: Key type dns_resolver registered Oct 30 05:05:07.700163 kernel: registered taskstats version 1 Oct 30 05:05:07.700169 kernel: Loading compiled-in X.509 certificates Oct 30 05:05:07.700176 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 30 05:05:07.700182 kernel: Key type ._fscrypt registered Oct 30 05:05:07.700188 kernel: Key type .fscrypt registered Oct 30 05:05:07.700194 kernel: Key type fscrypt-provisioning registered Oct 30 05:05:07.700201 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 30 05:05:07.700207 kernel: ima: Allocated hash algorithm: sha1 Oct 30 05:05:07.700213 kernel: ima: No architecture policies found Oct 30 05:05:07.700219 kernel: Freeing unused kernel memory: 34240K Oct 30 05:05:07.700225 kernel: Run /init as init process Oct 30 05:05:07.700231 kernel: with arguments: Oct 30 05:05:07.700237 kernel: /init Oct 30 05:05:07.700243 kernel: with environment: Oct 30 05:05:07.700249 kernel: HOME=/ Oct 30 05:05:07.700255 kernel: TERM=linux Oct 30 05:05:07.700262 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 30 05:05:07.700269 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 30 05:05:07.700278 systemd[1]: Detected virtualization kvm. Oct 30 05:05:07.700285 systemd[1]: Detected architecture arm64. Oct 30 05:05:07.700291 systemd[1]: Running in initial RAM disk. Oct 30 05:05:07.700297 systemd[1]: No hostname configured, using default hostname. Oct 30 05:05:07.700304 systemd[1]: Hostname set to . Oct 30 05:05:07.700318 systemd[1]: Initializing machine ID from VM UUID. Oct 30 05:05:07.700325 systemd[1]: Queued start job for default target Initrd Default Target. Oct 30 05:05:07.700332 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 30 05:05:07.700338 systemd[1]: Reached target Local Encrypted Volumes. Oct 30 05:05:07.700345 systemd[1]: Reached target Path Units. Oct 30 05:05:07.700351 systemd[1]: Reached target Slice Units. Oct 30 05:05:07.700358 systemd[1]: Reached target Swaps. Oct 30 05:05:07.700364 systemd[1]: Reached target Timer Units. Oct 30 05:05:07.700372 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 30 05:05:07.700379 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 30 05:05:07.700385 systemd[1]: Listening on Journal Audit Socket. Oct 30 05:05:07.700392 systemd[1]: Listening on Journal Socket (/dev/log). Oct 30 05:05:07.700398 systemd[1]: Listening on Journal Socket. Oct 30 05:05:07.700405 systemd[1]: Listening on Network Service Netlink Socket. Oct 30 05:05:07.700412 systemd[1]: Listening on udev Control Socket. Oct 30 05:05:07.700418 systemd[1]: Listening on udev Kernel Socket. Oct 30 05:05:07.700424 systemd[1]: Reached target Socket Units. Oct 30 05:05:07.700432 systemd[1]: Starting Create List of Static Device Nodes... Oct 30 05:05:07.700439 systemd[1]: Finished Network Cleanup. Oct 30 05:05:07.700446 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 30 05:05:07.700452 systemd[1]: Starting Journal Service... Oct 30 05:05:07.700459 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 30 05:05:07.700465 systemd[1]: Starting Apply Kernel Variables... Oct 30 05:05:07.700472 systemd[1]: Starting Setup Virtual Console... Oct 30 05:05:07.700478 systemd[1]: Finished Create List of Static Device Nodes. Oct 30 05:05:07.700485 systemd[1]: Finished Apply Kernel Variables. Oct 30 05:05:07.700492 systemd[1]: Finished Setup Virtual Console. Oct 30 05:05:07.700499 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 30 05:05:07.700505 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 30 05:05:07.700512 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 30 05:05:07.700521 systemd-journald[279]: Journal started Oct 30 05:05:07.700569 systemd-journald[279]: Runtime Journal (/run/log/journal/7562076a330c462bb5798545670cc149) is 6.0M, max 48.5M, 42.4M free. Oct 30 05:05:07.704996 systemd[1]: Started Journal Service. Oct 30 05:05:07.708340 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 30 05:05:07.710171 systemd[1]: Starting dracut cmdline hook... Oct 30 05:05:07.719109 dracut-cmdline[297]: dracut-dracut-053 Oct 30 05:05:07.722617 dracut-cmdline[297]: 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 30 05:05:07.781585 kernel: SCSI subsystem initialized Oct 30 05:05:07.785569 kernel: Loading iSCSI transport class v2.0-870. Oct 30 05:05:07.791590 kernel: iscsi: registered transport (tcp) Oct 30 05:05:07.802944 kernel: iscsi: registered transport (qla4xxx) Oct 30 05:05:07.802956 kernel: QLogic iSCSI HBA Driver Oct 30 05:05:07.812970 systemd[1]: Finished dracut cmdline hook. Oct 30 05:05:07.814545 systemd[1]: Starting dracut pre-udev hook... Oct 30 05:05:07.828205 kernel: device-mapper: uevent: version 1.0.3 Oct 30 05:05:07.828239 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 30 05:05:07.863589 kernel: raid6: neonx8 gen() 13731 MB/s Oct 30 05:05:07.880583 kernel: raid6: neonx8 xor() 10719 MB/s Oct 30 05:05:07.897587 kernel: raid6: neonx4 gen() 13524 MB/s Oct 30 05:05:07.914583 kernel: raid6: neonx4 xor() 11519 MB/s Oct 30 05:05:07.931579 kernel: raid6: neonx2 gen() 12981 MB/s Oct 30 05:05:07.948585 kernel: raid6: neonx2 xor() 9854 MB/s Oct 30 05:05:07.965583 kernel: raid6: neonx1 gen() 10853 MB/s Oct 30 05:05:07.982577 kernel: raid6: neonx1 xor() 8824 MB/s Oct 30 05:05:07.999602 kernel: raid6: int64x8 gen() 6801 MB/s Oct 30 05:05:08.016598 kernel: raid6: int64x8 xor() 3785 MB/s Oct 30 05:05:08.033596 kernel: raid6: int64x4 gen() 6900 MB/s Oct 30 05:05:08.050591 kernel: raid6: int64x4 xor() 3821 MB/s Oct 30 05:05:08.067591 kernel: raid6: int64x2 gen() 6166 MB/s Oct 30 05:05:08.084590 kernel: raid6: int64x2 xor() 3305 MB/s Oct 30 05:05:08.101590 kernel: raid6: int64x1 gen() 4989 MB/s Oct 30 05:05:08.118715 kernel: raid6: int64x1 xor() 2589 MB/s Oct 30 05:05:08.118735 kernel: raid6: using algorithm neonx8 gen() 13731 MB/s Oct 30 05:05:08.118751 kernel: raid6: .... xor() 10719 MB/s, rmw enabled Oct 30 05:05:08.119843 kernel: raid6: using neon recovery algorithm Oct 30 05:05:08.129583 kernel: xor: measuring software checksum speed Oct 30 05:05:08.130586 kernel: 8regs : 17152 MB/sec Oct 30 05:05:08.131580 kernel: 32regs : 20755 MB/sec Oct 30 05:05:08.131597 kernel: arm64_neon : 29173 MB/sec Oct 30 05:05:08.132725 kernel: xor: using function: arm64_neon (29173 MB/sec) Oct 30 05:05:08.177595 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 30 05:05:08.187957 systemd[1]: Finished dracut pre-udev hook. Oct 30 05:05:08.188000 audit: BPF prog-id=6 op=LOAD Oct 30 05:05:08.189000 audit: BPF prog-id=7 op=LOAD Oct 30 05:05:08.191870 kernel: audit: type=1334 audit(1761800708.188:2): prog-id=6 op=LOAD Oct 30 05:05:08.191902 kernel: audit: type=1334 audit(1761800708.189:3): prog-id=7 op=LOAD Oct 30 05:05:08.191912 kernel: audit: type=1334 audit(1761800708.189:4): prog-id=8 op=LOAD Oct 30 05:05:08.189000 audit: BPF prog-id=8 op=LOAD Oct 30 05:05:08.190680 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 30 05:05:08.203189 systemd-udevd[416]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 30 05:05:08.204924 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 30 05:05:08.206631 systemd[1]: Starting dracut pre-trigger hook... Oct 30 05:05:08.216206 kernel: audit: type=1334 audit(1761800708.207:5): prog-id=9 op=LOAD Oct 30 05:05:08.207000 audit: BPF prog-id=9 op=LOAD Oct 30 05:05:08.208539 systemd[1]: Starting Network Configuration... Oct 30 05:05:08.220185 dracut-pre-trigger[423]: rd.md=0: removing MD RAID activation Oct 30 05:05:08.226018 systemd-networkd[429]: lo: Link UP Oct 30 05:05:08.226025 systemd-networkd[429]: lo: Gained carrier Oct 30 05:05:08.228000 audit: BPF prog-id=10 op=LOAD Oct 30 05:05:08.226292 systemd-networkd[429]: Enumeration completed Oct 30 05:05:08.229764 kernel: audit: type=1334 audit(1761800708.228:6): prog-id=10 op=LOAD Oct 30 05:05:08.226369 systemd[1]: Started Network Configuration. Oct 30 05:05:08.229531 systemd[1]: Starting Network Name Resolution... Oct 30 05:05:08.249125 systemd[1]: Finished dracut pre-trigger hook. Oct 30 05:05:08.250640 systemd[1]: Starting Coldplug All udev Devices... Oct 30 05:05:08.260140 systemd-udevd[416]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 30 05:05:08.261856 systemd-resolved[447]: Positive Trust Anchors: Oct 30 05:05:08.261866 systemd-resolved[447]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 30 05:05:08.261894 systemd-resolved[447]: 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 30 05:05:08.262157 systemd-resolved[447]: Defaulting to hostname 'linux'. Oct 30 05:05:08.268751 systemd[1]: Started Network Name Resolution. Oct 30 05:05:08.274531 systemd[1]: Reached target Network. Oct 30 05:05:08.276662 systemd[1]: Reached target Host and Network Name Lookups. Oct 30 05:05:08.278210 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 30 05:05:08.282879 systemd[1]: Finished Coldplug All udev Devices. Oct 30 05:05:08.283930 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 30 05:05:08.285783 systemd[1]: Starting Open-iSCSI... Oct 30 05:05:08.288125 iscsid[488]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 30 05:05:08.288125 iscsid[488]: 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 30 05:05:08.288125 iscsid[488]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 30 05:05:08.288125 iscsid[488]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 30 05:05:08.288125 iscsid[488]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 30 05:05:08.288125 iscsid[488]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 30 05:05:08.291482 systemd[1]: Started Open-iSCSI. Oct 30 05:05:08.295993 systemd[1]: Starting dracut initqueue hook... Oct 30 05:05:08.312647 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 30 05:05:08.312760 kernel: vda: detected capacity change from 0 to 4756340736 Oct 30 05:05:08.329275 systemd-udevd[469]: Using default interface naming scheme 'v249'. Oct 30 05:05:08.331588 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 30 05:05:08.335640 systemd-networkd[429]: eth0: Link UP Oct 30 05:05:08.351580 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (468) Oct 30 05:05:08.354874 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 30 05:05:08.361671 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 30 05:05:08.362589 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 30 05:05:08.366196 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Oct 30 05:05:08.369020 systemd[1]: Found device /dev/disk/by-label/OEM. Oct 30 05:05:08.370100 systemd[1]: Finished dracut initqueue hook. Oct 30 05:05:08.371383 systemd[1]: Reached target Initrd Root Device. Oct 30 05:05:08.372702 systemd[1]: Reached target Preparation for Remote File Systems. Oct 30 05:05:08.374252 systemd[1]: Reached target Remote Encrypted Volumes. Oct 30 05:05:08.375901 systemd[1]: Reached target Remote File Systems. Oct 30 05:05:08.378094 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 30 05:05:08.379754 systemd[1]: Starting dracut pre-mount hook... Oct 30 05:05:08.386788 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 30 05:05:08.388129 systemd[1]: Finished dracut pre-mount hook. Oct 30 05:05:09.329598 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 30 05:05:09.329587 systemd-networkd[429]: eth0: Gained carrier Oct 30 05:05:09.335615 systemd-networkd[429]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 30 05:05:09.394331 disk-uuid[510]: The operation has completed successfully. Oct 30 05:05:09.395685 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 30 05:05:09.415532 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 30 05:05:09.416739 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 30 05:05:09.421629 systemd[1]: Starting Ignition (setup)... Oct 30 05:05:09.429583 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 30 05:05:09.429619 kernel: BTRFS info (device vda6): has skinny extents Oct 30 05:05:09.435296 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 30 05:05:09.439830 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 30 05:05:09.439938 systemd[1]: Finished Ignition (setup). Oct 30 05:05:09.442051 systemd[1]: Starting Ignition (disks)... Oct 30 05:05:09.451567 ignition[545]: Ignition v0.36.1-15-gde4e6cc9 Oct 30 05:05:09.451583 ignition[545]: Stage: disks Oct 30 05:05:09.451593 ignition[545]: reading system config file "/usr/lib/ignition/base.ign" Oct 30 05:05:09.451604 ignition[545]: no config at "/usr/lib/ignition/base.ign" Oct 30 05:05:09.451646 ignition[545]: parsed url from cmdline: "" Oct 30 05:05:09.451649 ignition[545]: no config URL provided Oct 30 05:05:09.451654 ignition[545]: reading system config file "/usr/lib/ignition/user.ign" Oct 30 05:05:09.451660 ignition[545]: no config at "/usr/lib/ignition/user.ign" Oct 30 05:05:09.451680 ignition[545]: op(1): [started] loading QEMU firmware config module Oct 30 05:05:09.451684 ignition[545]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 30 05:05:09.452688 ignition[545]: op(1): [finished] loading QEMU firmware config module Oct 30 05:05:09.466324 ignition[545]: parsing config with SHA512: da3a27b1c069530dbcfd1cefa7c5209750c18acc6ad852b2e93dde0234641ebe5e46d8898238220f83e906e7298ea303da18b30db1bc6643b8fc053a56a01bd8 Oct 30 05:05:09.468423 ignition[545]: disks: disks passed Oct 30 05:05:09.468430 ignition[545]: Ignition finished successfully Oct 30 05:05:09.469313 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 30 05:05:09.469424 systemd[1]: Finished Ignition (disks). Oct 30 05:05:09.470707 systemd[1]: Reached target Preparation for Local File Systems. Oct 30 05:05:09.472952 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 30 05:05:09.474520 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 30 05:05:09.482497 systemd-fsck[557]: ROOT: clean, 528/553792 files, 37752/553472 blocks Oct 30 05:05:09.486213 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 30 05:05:09.488275 systemd[1]: Mounting /sysroot... Oct 30 05:05:09.491576 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 30 05:05:09.508649 systemd[1]: Found device /dev/mapper/usr. Oct 30 05:05:09.510075 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 30 05:05:09.511144 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 30 05:05:09.519551 systemd-fsck[576]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 30 05:05:09.519551 systemd-fsck[576]: You must have r/w access to the filesystem or be root Oct 30 05:05:09.519959 systemd-fsck[572]: fsck failed with exit status 8. Oct 30 05:05:09.519962 systemd-fsck[572]: Ignoring error. Oct 30 05:05:09.520525 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 30 05:05:09.522473 systemd[1]: Mounting /sysusr/usr... Oct 30 05:05:09.542577 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 30 05:05:09.542613 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 30 05:05:09.543009 systemd[1]: Mounted /sysroot. Oct 30 05:05:09.543715 systemd[1]: Reached target Initrd Root File System. Oct 30 05:05:09.552572 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 30 05:05:09.552961 systemd[1]: Mounted /sysusr/usr. Oct 30 05:05:09.553688 systemd[1]: Reached target Local File Systems. Oct 30 05:05:09.554888 systemd[1]: Reached target System Initialization. Oct 30 05:05:09.556329 systemd[1]: Reached target Basic System. Oct 30 05:05:09.558970 systemd[1]: Mounting /sysroot/usr... Oct 30 05:05:09.560964 systemd[1]: Mounted /sysroot/usr. Oct 30 05:05:09.562243 systemd[1]: Starting Root filesystem setup... Oct 30 05:05:09.586640 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 30 05:05:09.586753 systemd[1]: Finished Root filesystem setup. Oct 30 05:05:09.589017 systemd[1]: Starting Ignition (files)... Oct 30 05:05:09.590240 systemd[1]: Starting /sysroot/boot... Oct 30 05:05:09.592154 ignition[592]: Ignition v0.36.1-15-gde4e6cc9 Oct 30 05:05:09.592170 ignition[592]: Stage: files Oct 30 05:05:09.592180 ignition[592]: reading system config file "/usr/lib/ignition/base.ign" Oct 30 05:05:09.592190 ignition[592]: no config at "/usr/lib/ignition/base.ign" Oct 30 05:05:09.592694 ignition[592]: files: compiled without relabeling support, skipping Oct 30 05:05:09.607599 ignition[592]: files: createUsers: op(1): [started] creating or modifying user "core" Oct 30 05:05:09.607609 ignition[592]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Oct 30 05:05:09.607972 systemd[1]: Finished /sysroot/boot. Oct 30 05:05:09.609925 ignition[592]: files: createUsers: op(1): [finished] creating or modifying user "core" Oct 30 05:05:09.609931 ignition[592]: files: createUsers: op(2): [started] adding ssh keys to user "core" Oct 30 05:05:09.611092 ignition[592]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Oct 30 05:05:09.613369 systemd[1]: ignition-files.service: Deactivated successfully. Oct 30 05:05:09.611110 ignition[592]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Oct 30 05:05:09.613474 systemd[1]: Finished Ignition (files). Oct 30 05:05:09.611380 ignition[592]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Oct 30 05:05:09.615202 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Oct 30 05:05:09.611387 ignition[592]: files: op(4): [started] processing unit "coreos-metadata.service" Oct 30 05:05:09.615815 systemd[1]: Starting Ignition (record completion)... Oct 30 05:05:09.624000 audit: BPF prog-id=9 op=UNLOAD Oct 30 05:05:09.611477 ignition[592]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 30 05:05:09.628250 kernel: audit: type=1334 audit(1761800709.624:7): prog-id=9 op=UNLOAD Oct 30 05:05:09.617278 systemd[1]: Starting Reload Configuration from the Real Root... Oct 30 05:05:09.611870 ignition[592]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 30 05:05:09.632625 kernel: audit: type=1334 audit(1761800709.628:8): prog-id=6 op=UNLOAD Oct 30 05:05:09.632644 kernel: audit: type=1334 audit(1761800709.630:9): prog-id=3 op=UNLOAD Oct 30 05:05:09.632653 kernel: audit: type=1334 audit(1761800709.630:10): prog-id=10 op=UNLOAD Oct 30 05:05:09.628000 audit: BPF prog-id=6 op=UNLOAD Oct 30 05:05:09.630000 audit: BPF prog-id=3 op=UNLOAD Oct 30 05:05:09.630000 audit: BPF prog-id=10 op=UNLOAD Oct 30 05:05:09.619931 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 30 05:05:09.611876 ignition[592]: files: op(4): [finished] processing unit "coreos-metadata.service" Oct 30 05:05:09.620042 systemd[1]: Finished Ignition (record completion). Oct 30 05:05:09.611880 ignition[592]: files: files passed Oct 30 05:05:09.623589 systemd[1]: Reloading. Oct 30 05:05:09.611884 ignition[592]: Ignition finished successfully Oct 30 05:05:09.710000 audit: BPF prog-id=11 op=LOAD Oct 30 05:05:09.710000 audit: BPF prog-id=12 op=LOAD Oct 30 05:05:09.710000 audit: BPF prog-id=13 op=LOAD Oct 30 05:05:09.710000 audit: BPF prog-id=14 op=LOAD Oct 30 05:05:09.710000 audit: BPF prog-id=7 op=UNLOAD Oct 30 05:05:09.710000 audit: BPF prog-id=8 op=UNLOAD Oct 30 05:05:09.711000 audit: BPF prog-id=15 op=LOAD Oct 30 05:05:09.711000 audit: BPF prog-id=16 op=LOAD Oct 30 05:05:09.711000 audit: BPF prog-id=17 op=LOAD Oct 30 05:05:09.711000 audit: BPF prog-id=4 op=UNLOAD Oct 30 05:05:09.711000 audit: BPF prog-id=5 op=UNLOAD Oct 30 05:05:09.711000 audit: BPF prog-id=18 op=LOAD Oct 30 05:05:09.725121 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 30 05:05:09.725242 systemd[1]: Finished Reload Configuration from the Real Root. Oct 30 05:05:09.727163 systemd[1]: Reached target Initrd File Systems. Oct 30 05:05:09.728706 systemd[1]: Reached target Initrd Default Target. Oct 30 05:05:09.730243 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 30 05:05:09.730879 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 30 05:05:09.740814 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 30 05:05:09.742327 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 30 05:05:09.747948 systemd[1]: Stopped target Host and Network Name Lookups. Oct 30 05:05:09.749015 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 30 05:05:09.750605 systemd[1]: Stopped target Timer Units. Oct 30 05:05:09.752034 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 30 05:05:09.752141 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 30 05:05:09.753540 systemd[1]: Stopped target Initrd Default Target. Oct 30 05:05:09.755164 systemd[1]: Stopped target Basic System. Oct 30 05:05:09.756575 systemd[1]: Stopped target Initrd Root Device. Oct 30 05:05:09.758049 systemd[1]: Stopped target Path Units. Oct 30 05:05:09.759363 systemd[1]: Stopped target Remote File Systems. Oct 30 05:05:09.760828 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 30 05:05:09.762331 systemd[1]: Stopped target Slice Units. Oct 30 05:05:09.763709 systemd[1]: Stopped target Socket Units. Oct 30 05:05:09.765221 systemd[1]: Stopped target System Initialization. Oct 30 05:05:09.766541 systemd[1]: Stopped target Local File Systems. Oct 30 05:05:09.767945 systemd[1]: Stopped target Preparation for Local File Systems. Oct 30 05:05:09.769568 systemd[1]: Stopped target Swaps. Oct 30 05:05:09.770852 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 30 05:05:09.770950 systemd[1]: Stopped dracut pre-mount hook. Oct 30 05:05:09.772469 systemd[1]: Stopped target Local Encrypted Volumes. Oct 30 05:05:09.773750 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 30 05:05:09.777586 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 30 05:05:09.778682 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 30 05:05:09.778779 systemd[1]: Stopped dracut initqueue hook. Oct 30 05:05:09.781967 iscsid[488]: iscsid shutting down. Oct 30 05:05:09.781670 systemd[1]: Stopping Open-iSCSI... Oct 30 05:05:09.783035 systemd[1]: Stopping /sysroot/boot... Oct 30 05:05:09.783678 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 30 05:05:09.783803 systemd[1]: Stopped Coldplug All udev Devices. Oct 30 05:05:09.785049 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 30 05:05:09.785131 systemd[1]: Stopped dracut pre-trigger hook. Oct 30 05:05:09.787279 systemd[1]: iscsid.service: Deactivated successfully. Oct 30 05:05:09.787405 systemd[1]: Stopped Open-iSCSI. Oct 30 05:05:09.789222 systemd[1]: iscsid.socket: Deactivated successfully. Oct 30 05:05:09.789267 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 30 05:05:09.790596 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 30 05:05:09.792633 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 30 05:05:09.792732 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 30 05:05:09.794283 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 30 05:05:09.794393 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 30 05:05:09.795541 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 30 05:05:09.795665 systemd[1]: Stopped /sysroot/boot. Oct 30 05:05:09.797343 systemd[1]: Stopped target Network. Oct 30 05:05:09.798095 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 30 05:05:09.798158 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 30 05:05:09.799777 systemd[1]: Stopping Network Name Resolution... Oct 30 05:05:09.803195 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 30 05:05:09.803321 systemd[1]: Stopped Network Name Resolution. Oct 30 05:05:09.804740 systemd[1]: Stopping Network Configuration... Oct 30 05:05:09.811000 audit: BPF prog-id=18 op=UNLOAD Oct 30 05:05:09.806648 systemd-networkd[429]: eth0: DHCP lease lost Oct 30 05:05:09.816593 systemd-networkd[429]: eth0: DHCPv6 lease lost Oct 30 05:05:09.817586 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 30 05:05:09.817698 systemd[1]: Stopped Network Configuration. Oct 30 05:05:09.819423 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 30 05:05:09.819454 systemd[1]: Closed Network Service Netlink Socket. Oct 30 05:05:09.821222 systemd[1]: Stopping Network Cleanup... Oct 30 05:05:09.825000 audit: BPF prog-id=11 op=UNLOAD Oct 30 05:05:09.822183 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 30 05:05:09.822254 systemd[1]: Stopped Apply Kernel Variables. Oct 30 05:05:09.825632 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 30 05:05:09.829932 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 30 05:05:09.830054 systemd[1]: Stopped Network Cleanup. Oct 30 05:05:09.832246 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 30 05:05:09.832374 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 30 05:05:09.834467 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 30 05:05:09.834503 systemd[1]: Closed udev Control Socket. Oct 30 05:05:09.835933 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 30 05:05:09.835969 systemd[1]: Closed udev Kernel Socket. Oct 30 05:05:09.837411 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 30 05:05:09.837455 systemd[1]: Stopped dracut pre-udev hook. Oct 30 05:05:09.838714 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 30 05:05:09.838754 systemd[1]: Stopped dracut cmdline hook. Oct 30 05:05:09.846000 audit: BPF prog-id=12 op=UNLOAD Oct 30 05:05:09.840251 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 30 05:05:09.840292 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 30 05:05:09.842323 systemd[1]: Starting Cleanup udev Database... Oct 30 05:05:09.843252 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 30 05:05:09.844699 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 30 05:05:09.844757 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 30 05:05:09.846469 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 30 05:05:09.846511 systemd[1]: Stopped Create List of Static Device Nodes. Oct 30 05:05:09.847940 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 30 05:05:09.847980 systemd[1]: Stopped Setup Virtual Console. Oct 30 05:05:09.849758 systemd[1]: rngd.service: Deactivated successfully. Oct 30 05:05:09.849869 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 30 05:05:09.860000 audit: BPF prog-id=15 op=UNLOAD Oct 30 05:05:09.851478 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 30 05:05:09.851590 systemd[1]: Finished Cleanup udev Database. Oct 30 05:05:09.852876 systemd[1]: Reached target Switch Root. Oct 30 05:05:09.854892 systemd[1]: Starting Switch Root... Oct 30 05:05:09.859727 systemd[1]: Switching root. Oct 30 05:05:09.873860 systemd-journald[279]: Journal stopped Oct 30 05:05:11.994387 systemd-journald[279]: Received SIGTERM from PID 1 (systemd). Oct 30 05:05:11.994443 kernel: SELinux: policy capability network_peer_controls=1 Oct 30 05:05:11.994458 kernel: SELinux: policy capability open_perms=1 Oct 30 05:05:11.994467 kernel: SELinux: policy capability extended_socket_class=1 Oct 30 05:05:11.994476 kernel: SELinux: policy capability always_check_network=0 Oct 30 05:05:11.994485 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 30 05:05:11.994494 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 30 05:05:11.994503 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 30 05:05:11.994512 systemd[1]: Successfully loaded SELinux policy in 29.393ms. Oct 30 05:05:11.994528 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.433ms. Oct 30 05:05:11.994538 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 30 05:05:11.994550 systemd[1]: Detected virtualization kvm. Oct 30 05:05:11.994577 systemd[1]: Detected architecture arm64. Oct 30 05:05:11.994588 systemd[1]: Detected first boot. Oct 30 05:05:11.994598 systemd[1]: Initializing machine ID from VM UUID. Oct 30 05:05:11.994608 systemd[1]: Populated /etc with preset unit settings. Oct 30 05:05:11.994619 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 30 05:05:11.994630 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 30 05:05:11.994641 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 30 05:05:11.994652 systemd[1]: Stopped Switch Root. Oct 30 05:05:11.994662 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 30 05:05:11.994671 systemd[1]: Created slice Slice /system/addon-config. Oct 30 05:05:11.994681 systemd[1]: Created slice Slice /system/addon-run. Oct 30 05:05:11.994690 systemd[1]: Created slice Slice /system/getty. Oct 30 05:05:11.994700 systemd[1]: Created slice Slice /system/modprobe. Oct 30 05:05:11.994710 systemd[1]: Created slice Slice /system/serial-getty. Oct 30 05:05:11.994720 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 30 05:05:11.994730 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 30 05:05:11.994740 systemd[1]: Created slice User and Session Slice. Oct 30 05:05:11.994750 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 30 05:05:11.994760 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 30 05:05:11.994769 systemd[1]: Set up automount Boot partition Automount Point. Oct 30 05:05:11.994779 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 30 05:05:11.994789 systemd[1]: Stopped target Switch Root. Oct 30 05:05:11.994798 systemd[1]: Stopped target Initrd File Systems. Oct 30 05:05:11.994808 systemd[1]: Stopped target Initrd Root File System. Oct 30 05:05:11.994818 systemd[1]: Reached target Remote Encrypted Volumes. Oct 30 05:05:11.994832 systemd[1]: Reached target Remote File Systems. Oct 30 05:05:11.994842 systemd[1]: Reached target Slice Units. Oct 30 05:05:11.994852 systemd[1]: Reached target Swaps. Oct 30 05:05:11.994861 systemd[1]: Reached target Verify torcx succeeded. Oct 30 05:05:11.994870 systemd[1]: Reached target Local Verity Protected Volumes. Oct 30 05:05:11.994880 systemd[1]: Listening on Process Core Dump Socket. Oct 30 05:05:11.994890 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 30 05:05:11.994899 systemd[1]: Listening on Network Service Netlink Socket. Oct 30 05:05:11.994909 systemd[1]: Listening on udev Control Socket. Oct 30 05:05:11.994918 systemd[1]: Listening on udev Kernel Socket. Oct 30 05:05:11.994929 systemd[1]: Mounting Huge Pages File System... Oct 30 05:05:11.994939 systemd[1]: Mounting POSIX Message Queue File System... Oct 30 05:05:11.994948 systemd[1]: Mounting External Media Directory... Oct 30 05:05:11.994958 systemd[1]: Mounting Kernel Debug File System... Oct 30 05:05:11.994967 systemd[1]: Mounting Kernel Trace File System... Oct 30 05:05:11.994977 systemd[1]: Mounting Temporary Directory /tmp... Oct 30 05:05:11.994986 systemd[1]: Starting Create missing system files... Oct 30 05:05:11.994996 systemd[1]: Starting Create List of Static Device Nodes... Oct 30 05:05:11.995005 systemd[1]: Starting Load Kernel Module configfs... Oct 30 05:05:11.995015 systemd[1]: Starting Load Kernel Module drm... Oct 30 05:05:11.995026 systemd[1]: Starting Load Kernel Module fuse... Oct 30 05:05:11.995036 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 30 05:05:11.995046 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 30 05:05:11.995055 systemd[1]: Stopped File System Check on Root Device. Oct 30 05:05:11.995064 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 30 05:05:11.995073 systemd[1]: Stopped systemd-fsck-usr.service. Oct 30 05:05:11.995083 kernel: fuse: init (API version 7.32) Oct 30 05:05:11.995092 systemd[1]: Stopped Journal Service. Oct 30 05:05:11.995101 kernel: kauditd_printk_skb: 42 callbacks suppressed Oct 30 05:05:11.995111 kernel: audit: type=1334 audit(1761800711.975:53): prog-id=30 op=LOAD Oct 30 05:05:11.995120 kernel: audit: type=1334 audit(1761800711.976:54): prog-id=31 op=LOAD Oct 30 05:05:11.995129 systemd[1]: Starting Journal Service... Oct 30 05:05:11.995138 kernel: audit: type=1334 audit(1761800711.976:55): prog-id=32 op=LOAD Oct 30 05:05:11.995147 kernel: audit: type=1334 audit(1761800711.976:56): prog-id=28 op=UNLOAD Oct 30 05:05:11.995156 kernel: audit: type=1334 audit(1761800711.976:57): prog-id=29 op=UNLOAD Oct 30 05:05:11.995165 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 30 05:05:11.995174 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 30 05:05:11.995183 systemd[1]: Starting Apply Kernel Variables... Oct 30 05:05:11.995193 systemd[1]: Starting Coldplug All udev Devices... Oct 30 05:05:11.995204 systemd[1]: verity-setup.service: Deactivated successfully. Oct 30 05:05:11.995214 systemd[1]: Stopped verity-setup.service. Oct 30 05:05:11.995224 kernel: audit: type=1305 audit(1761800711.993:58): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 30 05:05:11.995237 systemd-journald[807]: Journal started Oct 30 05:05:11.995270 systemd-journald[807]: Runtime Journal (/run/log/journal/7562076a330c462bb5798545670cc149) is 6.0M, max 48.5M, 42.4M free. Oct 30 05:05:09.934000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 30 05:05:09.964000 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 30 05:05:09.964000 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 30 05:05:09.964000 audit: BPF prog-id=19 op=LOAD Oct 30 05:05:09.964000 audit: BPF prog-id=19 op=UNLOAD Oct 30 05:05:09.964000 audit: BPF prog-id=20 op=LOAD Oct 30 05:05:09.964000 audit: BPF prog-id=20 op=UNLOAD Oct 30 05:05:09.998000 audit[757]: AVC avc: denied { associate } for pid=757 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 30 05:05:11.865000 audit: BPF prog-id=21 op=LOAD Oct 30 05:05:11.865000 audit: BPF prog-id=22 op=LOAD Oct 30 05:05:11.865000 audit: BPF prog-id=23 op=LOAD Oct 30 05:05:11.865000 audit: BPF prog-id=16 op=UNLOAD Oct 30 05:05:11.865000 audit: BPF prog-id=17 op=UNLOAD Oct 30 05:05:11.876000 audit: BPF prog-id=24 op=LOAD Oct 30 05:05:11.876000 audit: BPF prog-id=21 op=UNLOAD Oct 30 05:05:11.876000 audit: BPF prog-id=25 op=LOAD Oct 30 05:05:11.877000 audit: BPF prog-id=26 op=LOAD Oct 30 05:05:11.877000 audit: BPF prog-id=22 op=UNLOAD Oct 30 05:05:11.877000 audit: BPF prog-id=23 op=UNLOAD Oct 30 05:05:11.877000 audit: BPF prog-id=27 op=LOAD Oct 30 05:05:11.877000 audit: BPF prog-id=24 op=UNLOAD Oct 30 05:05:11.877000 audit: BPF prog-id=28 op=LOAD Oct 30 05:05:11.877000 audit: BPF prog-id=29 op=LOAD Oct 30 05:05:11.877000 audit: BPF prog-id=25 op=UNLOAD Oct 30 05:05:11.877000 audit: BPF prog-id=26 op=UNLOAD Oct 30 05:05:11.887000 audit: BPF prog-id=27 op=UNLOAD Oct 30 05:05:11.975000 audit: BPF prog-id=30 op=LOAD Oct 30 05:05:11.976000 audit: BPF prog-id=31 op=LOAD Oct 30 05:05:11.976000 audit: BPF prog-id=32 op=LOAD Oct 30 05:05:11.976000 audit: BPF prog-id=28 op=UNLOAD Oct 30 05:05:11.976000 audit: BPF prog-id=29 op=UNLOAD Oct 30 05:05:11.993000 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 30 05:05:11.865089 systemd[1]: Queued start job for default target Multi-User System. Oct 30 05:05:09.997627 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" 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 30 05:05:11.878700 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 30 05:05:09.997945 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 30 05:05:09.997965 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 30 05:05:09.998088 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 30 05:05:09.998100 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 30 05:05:09.998143 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 30 05:05:09.998158 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 30 05:05:09.998366 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 30 05:05:09.998402 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 30 05:05:09.998419 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 30 05:05:09.998841 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" 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 30 05:05:09.998872 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" 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 30 05:05:09.998893 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" 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 30 05:05:09.998908 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 30 05:05:09.998926 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" 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 30 05:05:09.998940 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:09Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 30 05:05:11.699645 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:11Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 30 05:05:11.699924 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:11Z" 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 30 05:05:11.700034 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:11Z" 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 30 05:05:11.700155 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:11Z" 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 30 05:05:11.700208 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:11Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 30 05:05:11.700264 /usr/lib/systemd/system-generators/torcx-generator[757]: time="2025-10-30T05:05:11Z" 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 30 05:05:11.998621 systemd[1]: Started Journal Service. Oct 30 05:05:11.999080 systemd[1]: Mounted Huge Pages File System. Oct 30 05:05:12.000008 systemd[1]: Mounted POSIX Message Queue File System. Oct 30 05:05:12.001022 systemd[1]: Mounted External Media Directory. Oct 30 05:05:12.001941 systemd[1]: Mounted Kernel Debug File System. Oct 30 05:05:12.002869 systemd[1]: Mounted Kernel Trace File System. Oct 30 05:05:12.003791 systemd[1]: Mounted Temporary Directory /tmp. Oct 30 05:05:12.004926 systemd[1]: Finished Create missing system files. Oct 30 05:05:12.006115 systemd[1]: Finished Create List of Static Device Nodes. Oct 30 05:05:12.007262 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 30 05:05:12.007456 systemd[1]: Finished Load Kernel Module configfs. Oct 30 05:05:12.008532 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 30 05:05:12.008726 systemd[1]: Finished Load Kernel Module drm. Oct 30 05:05:12.009749 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 30 05:05:12.009919 systemd[1]: Finished Load Kernel Module fuse. Oct 30 05:05:12.011016 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 30 05:05:12.012372 systemd[1]: Finished Apply Kernel Variables. Oct 30 05:05:12.028315 systemd[1]: Mounting FUSE Control File System... Oct 30 05:05:12.030152 systemd[1]: Mounting Kernel Configuration File System... Oct 30 05:05:12.031039 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 30 05:05:12.032462 systemd[1]: Starting Rebuild Hardware Database... Oct 30 05:05:12.034336 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 30 05:05:12.035514 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 30 05:05:12.038210 systemd-journald[807]: Time spent on flushing to /var/log/journal/7562076a330c462bb5798545670cc149 is 8.283ms for 778 entries. Oct 30 05:05:12.038210 systemd-journald[807]: System Journal (/var/log/journal/7562076a330c462bb5798545670cc149) is 8.0M, max 203.0M, 195.0M free. Oct 30 05:05:12.036647 systemd[1]: Starting Load/Save Random Seed... Oct 30 05:05:12.038503 systemd[1]: Starting Create System Users... Oct 30 05:05:12.042274 systemd[1]: Mounted FUSE Control File System. Oct 30 05:05:12.043551 systemd[1]: Mounted Kernel Configuration File System. Oct 30 05:05:12.045641 systemd[1]: Finished Load/Save Random Seed. Oct 30 05:05:12.046737 systemd[1]: Reached target First Boot Complete. Oct 30 05:05:12.048074 systemd[1]: Finished Coldplug All udev Devices. Oct 30 05:05:12.063432 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 30 05:05:12.064907 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 30 05:05:12.066679 systemd-sysusers[818]: Creating group sgx with gid 999. Oct 30 05:05:12.067472 systemd-sysusers[818]: Creating group systemd-oom with gid 998. Oct 30 05:05:12.067984 systemd-sysusers[818]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Oct 30 05:05:12.068647 systemd-sysusers[818]: Creating group systemd-timesync with gid 997. Oct 30 05:05:12.069143 systemd-sysusers[818]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Oct 30 05:05:12.069789 systemd-sysusers[818]: Creating group systemd-coredump with gid 996. Oct 30 05:05:12.070281 systemd-sysusers[818]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Oct 30 05:05:12.078811 systemd[1]: Finished Create System Users. Oct 30 05:05:12.080534 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 30 05:05:12.092838 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 30 05:05:12.299169 systemd[1]: Finished Rebuild Hardware Database. Oct 30 05:05:12.307000 audit: BPF prog-id=33 op=LOAD Oct 30 05:05:12.308000 audit: BPF prog-id=34 op=LOAD Oct 30 05:05:12.310013 kernel: audit: type=1334 audit(1761800712.307:59): prog-id=33 op=LOAD Oct 30 05:05:12.310050 kernel: audit: type=1334 audit(1761800712.308:60): prog-id=34 op=LOAD Oct 30 05:05:12.310066 kernel: audit: type=1334 audit(1761800712.309:61): prog-id=35 op=LOAD Oct 30 05:05:12.309000 audit: BPF prog-id=35 op=LOAD Oct 30 05:05:12.310636 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 30 05:05:12.309000 audit: BPF prog-id=13 op=UNLOAD Oct 30 05:05:12.309000 audit: BPF prog-id=14 op=UNLOAD Oct 30 05:05:12.311579 kernel: audit: type=1334 audit(1761800712.309:62): prog-id=13 op=UNLOAD Oct 30 05:05:12.333539 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 30 05:05:12.343000 audit: BPF prog-id=36 op=LOAD Oct 30 05:05:12.344794 systemd[1]: Starting Network Configuration... Oct 30 05:05:12.371320 systemd-networkd[843]: lo: Link UP Oct 30 05:05:12.371329 systemd-networkd[843]: lo: Gained carrier Oct 30 05:05:12.371705 systemd-networkd[843]: Enumeration completed Oct 30 05:05:12.371796 systemd[1]: Started Network Configuration. Oct 30 05:05:12.377124 systemd-udevd[831]: Using default interface naming scheme 'v249'. Oct 30 05:05:12.393472 systemd-networkd[843]: eth0: Link UP Oct 30 05:05:12.399624 systemd-networkd[843]: eth0: Gained carrier Oct 30 05:05:12.405714 systemd-networkd[843]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 30 05:05:12.415721 udevadm[822]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 30 05:05:12.438807 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 30 05:05:12.452456 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 30 05:05:12.461091 lvm[851]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 30 05:05:12.487455 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 30 05:05:12.488588 systemd[1]: Reached target Local Encrypted Volumes. Oct 30 05:05:12.502455 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 30 05:05:12.505673 lvm[852]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 30 05:05:12.535644 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 30 05:05:12.536655 systemd[1]: Reached target Preparation for Local File Systems. Oct 30 05:05:12.537667 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 30 05:05:12.537691 systemd[1]: Reached target Containers. Oct 30 05:05:12.550773 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 30 05:05:12.562927 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 30 05:05:12.565097 systemd[1]: Mounting /usr/share/oem... Oct 30 05:05:12.570934 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 30 05:05:12.570986 kernel: BTRFS info (device vda6): has skinny extents Oct 30 05:05:12.573030 systemd[1]: Mounted /usr/share/oem. Oct 30 05:05:12.573807 systemd[1]: Reached target Local File Systems. Oct 30 05:05:12.575520 systemd[1]: Starting Rebuild Dynamic Linker Cache... Oct 30 05:05:12.576875 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 30 05:05:12.577018 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 30 05:05:12.578429 systemd[1]: Starting Commit a transient machine-id on disk... Oct 30 05:05:12.580612 systemd[1]: Starting Create Volatile Files and Directories... Oct 30 05:05:12.586444 systemd-tmpfiles[877]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 30 05:05:12.587530 systemd-tmpfiles[877]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 30 05:05:12.593333 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 30 05:05:12.594060 systemd[1]: Finished Commit a transient machine-id on disk. Oct 30 05:05:12.619433 systemd-tmpfiles[877]: Detected autofs mount point /boot during canonicalization of /boot. Oct 30 05:05:12.619444 systemd-tmpfiles[877]: Skipping /boot Oct 30 05:05:12.626715 systemd-tmpfiles[877]: Detected autofs mount point /boot during canonicalization of /boot. Oct 30 05:05:12.626728 systemd-tmpfiles[877]: Skipping /boot Oct 30 05:05:12.649541 systemd[1]: Finished Rebuild Dynamic Linker Cache. Oct 30 05:05:12.664892 systemd[1]: Finished Create Volatile Files and Directories. Oct 30 05:05:12.670843 systemd[1]: Starting Load Security Auditing Rules... Oct 30 05:05:12.672615 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 30 05:05:12.674646 systemd[1]: Starting Rebuild Journal Catalog... Oct 30 05:05:12.675000 audit: BPF prog-id=37 op=LOAD Oct 30 05:05:12.676829 systemd[1]: Starting Network Name Resolution... Oct 30 05:05:12.677000 audit: BPF prog-id=38 op=LOAD Oct 30 05:05:12.679123 systemd[1]: Starting Network Time Synchronization... Oct 30 05:05:12.681506 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 30 05:05:12.683088 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 30 05:05:12.684575 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 30 05:05:12.685865 systemd[1]: Finished Rebuild Journal Catalog. Oct 30 05:05:12.689064 systemd[1]: Starting Update is Completed... Oct 30 05:05:12.691646 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 30 05:05:12.693992 systemd[1]: Finished Update is Completed. Oct 30 05:05:12.699000 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 30 05:05:12.700634 augenrules[900]: No rules Oct 30 05:05:12.701481 systemd[1]: Finished Load Security Auditing Rules. Oct 30 05:05:12.715679 systemd[1]: Started Network Time Synchronization. Oct 30 05:05:12.716393 systemd-timesyncd[889]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 30 05:05:12.716832 systemd[1]: Reached target System Initialization. Oct 30 05:05:12.717818 systemd[1]: Started Watch for update engine configuration changes. Oct 30 05:05:12.718925 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 30 05:05:12.720072 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 30 05:05:12.721051 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 30 05:05:12.721086 systemd[1]: Reached target Path Units. Oct 30 05:05:12.721815 systemd[1]: Reached target System Time Set. Oct 30 05:05:12.722770 systemd[1]: Started Daily Log Rotation. Oct 30 05:05:12.723727 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 30 05:05:12.724839 systemd[1]: Reached target Timer Units. Oct 30 05:05:12.725929 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 30 05:05:12.727582 systemd-resolved[886]: Positive Trust Anchors: Oct 30 05:05:12.727592 systemd-resolved[886]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 30 05:05:12.727619 systemd-resolved[886]: 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 30 05:05:12.728394 systemd-resolved[886]: Defaulting to hostname 'linux'. Oct 30 05:05:12.733130 systemd[1]: Starting Docker Socket for the API... Oct 30 05:05:12.736095 systemd[1]: Listening on OpenSSH Server Socket. Oct 30 05:05:12.737428 systemd[1]: Started Network Name Resolution. Oct 30 05:05:12.738400 systemd[1]: Listening on Docker Socket for the API. Oct 30 05:05:12.739372 systemd[1]: Reached target Network. Oct 30 05:05:12.740140 systemd[1]: Reached target Host and Network Name Lookups. Oct 30 05:05:12.741115 systemd[1]: Reached target Socket Units. Oct 30 05:05:12.741900 systemd[1]: Reached target Basic System. Oct 30 05:05:12.742729 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 30 05:05:12.742761 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 30 05:05:12.743764 systemd[1]: Started D-Bus System Message Bus. Oct 30 05:05:12.746859 systemd[1]: Starting Extend Filesystems... Oct 30 05:05:12.747662 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 30 05:05:12.748631 systemd[1]: Starting Generate /run/flatcar/motd... Oct 30 05:05:12.750383 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 30 05:05:12.752341 systemd[1]: Starting Generate sshd host keys... Oct 30 05:05:12.753286 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 30 05:05:12.753334 systemd[1]: Reached target Load system-provided cloud configs. Oct 30 05:05:12.756401 extend-filesystems[909]: Found vda Oct 30 05:05:12.757382 extend-filesystems[909]: Found vda1 Oct 30 05:05:12.757382 extend-filesystems[909]: Found vda2 Oct 30 05:05:12.757382 extend-filesystems[909]: Found vda3 Oct 30 05:05:12.757382 extend-filesystems[909]: Found usr Oct 30 05:05:12.757382 extend-filesystems[909]: Found vda4 Oct 30 05:05:12.757382 extend-filesystems[909]: Found vda6 Oct 30 05:05:12.757382 extend-filesystems[909]: Found vda7 Oct 30 05:05:12.757382 extend-filesystems[909]: Found vda9 Oct 30 05:05:12.757382 extend-filesystems[909]: Checking size of /dev/vda9 Oct 30 05:05:12.758131 systemd[1]: Starting User Login Management... Oct 30 05:05:12.759143 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 30 05:05:12.759756 systemd[1]: Starting Update Engine... Oct 30 05:05:12.760914 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 30 05:05:12.760939 systemd[1]: Reached target Load user-provided cloud configs. Oct 30 05:05:12.763108 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 30 05:05:12.763337 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 30 05:05:12.775005 systemd[1]: motdgen.service: Deactivated successfully. Oct 30 05:05:12.775255 systemd[1]: Finished Generate /run/flatcar/motd. Oct 30 05:05:12.777984 extend-filesystems[909]: Old size kept for /dev/vda9 Oct 30 05:05:12.779362 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 30 05:05:12.779786 systemd[1]: Finished Extend Filesystems. Oct 30 05:05:12.793620 update_engine[922]: I1030 05:05:12.792227 922 main.cc:89] Flatcar Update Engine starting Oct 30 05:05:12.794328 systemd[1]: Started Update Engine. Oct 30 05:05:12.795152 update_engine[922]: I1030 05:05:12.795115 922 update_check_scheduler.cc:74] Next update check in 3m4s Oct 30 05:05:12.796575 systemd[1]: Started Cluster reboot manager. Oct 30 05:05:12.798210 systemd-logind[921]: Watching system buttons on /dev/input/event0 (Power Button) Oct 30 05:05:12.798398 systemd-logind[921]: New seat seat0. Oct 30 05:05:12.799443 systemd[1]: Started User Login Management. Oct 30 05:05:12.826938 locksmithd[932]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 30 05:05:13.442646 sshd_keygen[923]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Oct 30 05:05:13.460435 systemd[1]: Finished Generate sshd host keys. Oct 30 05:05:13.473600 systemd[1]: Starting Generate /run/issue... Oct 30 05:05:13.477969 systemd[1]: issuegen.service: Deactivated successfully. Oct 30 05:05:13.478187 systemd[1]: Finished Generate /run/issue. Oct 30 05:05:13.480254 systemd[1]: Starting Permit User Sessions... Oct 30 05:05:13.484970 systemd[1]: Finished Permit User Sessions. Oct 30 05:05:13.486990 systemd[1]: Started Getty on tty1. Oct 30 05:05:13.488773 systemd[1]: Started Serial Getty on ttyAMA0. Oct 30 05:05:13.489736 systemd[1]: Reached target Login Prompts. Oct 30 05:05:13.490673 systemd[1]: Reached target Multi-User System. Oct 30 05:05:13.492572 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 30 05:05:13.497348 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 30 05:05:13.497732 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 30 05:05:13.498787 systemd[1]: Startup finished in 694ms (kernel) + 2.343s (initrd) + 3.595s (userspace) = 6.633s. Oct 30 05:05:13.744817 systemd-networkd[843]: eth0: Gained IPv6LL Oct 30 05:05:19.299647 systemd[1]: Created slice Slice /system/sshd. Oct 30 05:05:19.300641 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33298). Oct 30 05:05:19.335407 sshd[954]: Accepted publickey for core from 10.0.0.1 port 33298 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:19.337179 sshd[954]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:19.356104 systemd[1]: Created slice User Slice of UID 500. Oct 30 05:05:19.357104 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 30 05:05:19.358756 systemd-logind[921]: New session 1 of user core. Oct 30 05:05:19.363126 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 30 05:05:19.364270 systemd[1]: Starting User Manager for UID 500... Oct 30 05:05:19.366497 systemd[957]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:19.413175 systemd[957]: Queued start job for default target Main User Target. Oct 30 05:05:19.413340 systemd[957]: Reached target Paths. Oct 30 05:05:19.413354 systemd[957]: Reached target Sockets. Oct 30 05:05:19.413365 systemd[957]: Reached target Timers. Oct 30 05:05:19.413375 systemd[957]: Reached target Basic System. Oct 30 05:05:19.413427 systemd[957]: Reached target Main User Target. Oct 30 05:05:19.413440 systemd[957]: Startup finished in 43ms. Oct 30 05:05:19.413646 systemd[1]: Started User Manager for UID 500. Oct 30 05:05:19.432742 systemd[1]: Started Session 1 of User core. Oct 30 05:05:19.491082 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33314). Oct 30 05:05:19.522270 sshd[966]: Accepted publickey for core from 10.0.0.1 port 33314 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:19.523275 sshd[966]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:19.525902 systemd-logind[921]: New session 2 of user core. Oct 30 05:05:19.542699 systemd[1]: Started Session 2 of User core. Oct 30 05:05:19.595443 sshd[966]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:19.607079 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:33314.service: Deactivated successfully. Oct 30 05:05:19.607734 systemd[1]: session-2.scope: Deactivated successfully. Oct 30 05:05:19.608358 systemd-logind[921]: Session 2 logged out. Waiting for processes to exit. Oct 30 05:05:19.609292 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33330). Oct 30 05:05:19.609952 systemd-logind[921]: Removed session 2. Oct 30 05:05:19.641359 sshd[972]: Accepted publickey for core from 10.0.0.1 port 33330 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:19.642589 sshd[972]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:19.645173 systemd-logind[921]: New session 3 of user core. Oct 30 05:05:19.656711 systemd[1]: Started Session 3 of User core. Oct 30 05:05:19.704355 sshd[972]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:19.712420 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:33330.service: Deactivated successfully. Oct 30 05:05:19.713054 systemd[1]: session-3.scope: Deactivated successfully. Oct 30 05:05:19.713665 systemd-logind[921]: Session 3 logged out. Waiting for processes to exit. Oct 30 05:05:19.714645 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33334). Oct 30 05:05:19.715291 systemd-logind[921]: Removed session 3. Oct 30 05:05:19.744908 sshd[978]: Accepted publickey for core from 10.0.0.1 port 33334 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:19.746097 sshd[978]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:19.748530 systemd-logind[921]: New session 4 of user core. Oct 30 05:05:19.760712 systemd[1]: Started Session 4 of User core. Oct 30 05:05:19.811164 sshd[978]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:19.827365 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:33334.service: Deactivated successfully. Oct 30 05:05:19.828084 systemd[1]: session-4.scope: Deactivated successfully. Oct 30 05:05:19.828779 systemd-logind[921]: Session 4 logged out. Waiting for processes to exit. Oct 30 05:05:19.829952 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33336). Oct 30 05:05:19.830638 systemd-logind[921]: Removed session 4. Oct 30 05:05:19.860134 sshd[984]: Accepted publickey for core from 10.0.0.1 port 33336 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:19.861400 sshd[984]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:19.863808 systemd-logind[921]: New session 5 of user core. Oct 30 05:05:19.871679 systemd[1]: Started Session 5 of User core. Oct 30 05:05:19.926179 sudo[987]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 30 05:05:19.926682 sudo[987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:05:19.940045 sudo[987]: pam_unix(sudo:session): session closed for user root Oct 30 05:05:19.942112 sshd[984]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:19.956316 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33350). Oct 30 05:05:19.958506 dbus-daemon[908]: [system] Reloaded configuration Oct 30 05:05:19.961109 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:33336.service: Deactivated successfully. Oct 30 05:05:19.961739 systemd[1]: session-5.scope: Deactivated successfully. Oct 30 05:05:19.962349 systemd-logind[921]: Session 5 logged out. Waiting for processes to exit. Oct 30 05:05:19.963087 systemd-logind[921]: Removed session 5. Oct 30 05:05:19.987513 sshd[990]: Accepted publickey for core from 10.0.0.1 port 33350 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:19.988828 sshd[990]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:19.991405 systemd-logind[921]: New session 6 of user core. Oct 30 05:05:20.005688 systemd[1]: Started Session 6 of User core. Oct 30 05:05:20.056216 sudo[996]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 30 05:05:20.056439 sudo[996]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:05:20.058800 sudo[996]: pam_unix(sudo:session): session closed for user root Oct 30 05:05:20.062523 sudo[995]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 30 05:05:20.062777 sudo[995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:05:20.077416 systemd[1]: Stopping Load Security Auditing Rules... Oct 30 05:05:20.078000 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 30 05:05:20.079715 auditctl[999]: No rules Oct 30 05:05:20.079968 systemd[1]: audit-rules.service: Deactivated successfully. Oct 30 05:05:20.080199 systemd[1]: Stopped Load Security Auditing Rules. Oct 30 05:05:20.081704 kernel: kauditd_printk_skb: 5 callbacks suppressed Oct 30 05:05:20.081758 kernel: audit: type=1305 audit(1761800720.078:68): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 30 05:05:20.081522 systemd[1]: Starting Load Security Auditing Rules... Oct 30 05:05:20.098410 augenrules[1016]: No rules Oct 30 05:05:20.099083 systemd[1]: Finished Load Security Auditing Rules. Oct 30 05:05:20.099880 sudo[995]: pam_unix(sudo:session): session closed for user root Oct 30 05:05:20.101048 sshd[990]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:20.103891 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:33350.service: Deactivated successfully. Oct 30 05:05:20.104408 systemd[1]: session-6.scope: Deactivated successfully. Oct 30 05:05:20.105012 systemd-logind[921]: Session 6 logged out. Waiting for processes to exit. Oct 30 05:05:20.106011 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33362). Oct 30 05:05:20.106876 systemd-logind[921]: Removed session 6. Oct 30 05:05:20.137324 sshd[1022]: Accepted publickey for core from 10.0.0.1 port 33362 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:20.138686 sshd[1022]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:20.140565 kernel: audit: type=1006 audit(1761800720.136:69): pid=1022 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Oct 30 05:05:20.142693 systemd-logind[921]: New session 7 of user core. Oct 30 05:05:20.157730 systemd[1]: Started Session 7 of User core. Oct 30 05:05:20.207661 sudo[1025]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/bash -c cat >/etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem </etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem < Oct 30 05:05:22.860884 update_engine[1272]: Oct 30 05:05:22.860884 update_engine[1272]: Oct 30 05:05:22.860884 update_engine[1272]: Oct 30 05:05:22.860884 update_engine[1272]: Oct 30 05:05:22.860884 update_engine[1272]: Oct 30 05:05:22.860884 update_engine[1272]: Oct 30 05:05:22.860884 update_engine[1272]: Oct 30 05:05:22.860884 update_engine[1272]: Oct 30 05:05:22.860884 update_engine[1272]: I1030 05:05:22.860877 1272 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 30 05:05:22.864935 update_engine[1272]: I1030 05:05:22.864907 1272 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 30 05:05:22.865735 update_engine[1272]: I1030 05:05:22.865705 1272 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 30 05:05:22.866931 update_engine[1272]: I1030 05:05:22.866904 1272 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 30 05:05:22.867107 update_engine[1272]: I1030 05:05:22.867089 1272 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Oct 30 05:05:22.867107 update_engine[1272]: I1030 05:05:22.867103 1272 omaha_request_action.cc:619] Omaha request response: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.867107 update_engine[1272]: Oct 30 05:05:22.871947 update_engine[1272]: I1030 05:05:22.871924 1272 omaha_request_action.cc:447] Omaha Response manifest version = Oct 30 05:05:22.872064 update_engine[1272]: I1030 05:05:22.872052 1272 omaha_request_action.cc:470] Found 1 url(s) Oct 30 05:05:22.872121 update_engine[1272]: I1030 05:05:22.872112 1272 omaha_request_action.cc:506] Processing first of 1 package(s) Oct 30 05:05:22.872164 update_engine[1272]: I1030 05:05:22.872155 1272 omaha_request_action.cc:513] Omaha Response package name = update.gz Oct 30 05:05:22.872209 update_engine[1272]: I1030 05:05:22.872198 1272 omaha_request_action.cc:529] Url0: http://10.0.0.5:34567/packages/update.gz Oct 30 05:05:22.872251 update_engine[1272]: I1030 05:05:22.872242 1272 omaha_request_action.cc:541] Payload size = 439617737 bytes Oct 30 05:05:22.872302 update_engine[1272]: I1030 05:05:22.872292 1272 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Oct 30 05:05:22.872354 update_engine[1272]: I1030 05:05:22.872344 1272 payload_state.cc:51] Resetting all persisted state as this is a new response Oct 30 05:05:22.872405 update_engine[1272]: I1030 05:05:22.872395 1272 payload_state.cc:360] Current Response Signature = Oct 30 05:05:22.872405 update_engine[1272]: NumURLs = 1 Oct 30 05:05:22.872405 update_engine[1272]: Url0 = http://10.0.0.5:34567/packages/update.gz Oct 30 05:05:22.872405 update_engine[1272]: Payload Size = 439617737 Oct 30 05:05:22.872405 update_engine[1272]: Payload Sha256 Hash = hKuDazTd3yRvZZ+1GzVZ5iDGEt/oXMhd+zKPhlhnEaA= Oct 30 05:05:22.872405 update_engine[1272]: Is Delta Payload = 0 Oct 30 05:05:22.872405 update_engine[1272]: Max Failure Count Per Url = 10 Oct 30 05:05:22.872405 update_engine[1272]: Disable Payload Backoff = 1 Oct 30 05:05:22.872710 update_engine[1272]: I1030 05:05:22.872694 1272 payload_state.cc:381] Payload Attempt Number = 0 Oct 30 05:05:22.872813 update_engine[1272]: I1030 05:05:22.872802 1272 payload_state.cc:404] Current URL Index = 0 Oct 30 05:05:22.872902 update_engine[1272]: I1030 05:05:22.872890 1272 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Oct 30 05:05:22.872988 update_engine[1272]: I1030 05:05:22.872977 1272 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Oct 30 05:05:22.873051 update_engine[1272]: I1030 05:05:22.873034 1272 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 30 05:05:22.873137 update_engine[1272]: I1030 05:05:22.873126 1272 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Oct 30 05:05:22.873202 update_engine[1272]: I1030 05:05:22.873191 1272 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Oct 30 05:05:22.873245 update_engine[1272]: I1030 05:05:22.873236 1272 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Oct 30 05:05:22.873314 update_engine[1272]: I1030 05:05:22.873304 1272 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Oct 30 05:05:22.873356 update_engine[1272]: E1030 05:05:22.873347 1272 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Oct 30 05:05:22.873938 update_engine[1272]: I1030 05:05:22.873919 1272 omaha_response_handler_action.cc:85] Using this install plan: Oct 30 05:05:22.874019 update_engine[1272]: I1030 05:05:22.874006 1272 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.5:34567/packages/update.gz, payload size: 439617737, payload hash: hKuDazTd3yRvZZ+1GzVZ5iDGEt/oXMhd+zKPhlhnEaA=, 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 30 05:05:22.874142 update_engine[1272]: I1030 05:05:22.874130 1272 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Oct 30 05:05:22.875615 update_engine[1272]: I1030 05:05:22.875586 1272 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Oct 30 05:05:22.896033 sshd[1287]: Accepted publickey for core from 10.0.0.1 port 33540 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:22.897127 sshd[1287]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:22.900638 systemd-logind[921]: New session 25 of user core. Oct 30 05:05:22.906721 systemd[1]: Started Session 25 of User core. Oct 30 05:05:22.963467 sshd[1287]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:22.965407 systemd[1]: sshd@24-10.0.0.6:22-10.0.0.1:33540.service: Deactivated successfully. Oct 30 05:05:22.966038 systemd[1]: session-25.scope: Deactivated successfully. Oct 30 05:05:22.966660 systemd-logind[921]: Session 25 logged out. Waiting for processes to exit. Oct 30 05:05:22.967390 systemd-logind[921]: Removed session 25. Oct 30 05:05:24.489912 update_engine[1272]: I1030 05:05:24.489859 1272 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Oct 30 05:05:24.489912 update_engine[1272]: I1030 05:05:24.489902 1272 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Oct 30 05:05:24.545328 update_engine[1272]: E1030 05:05:24.545282 1272 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Oct 30 05:05:24.545328 update_engine[1272]: I1030 05:05:24.545328 1272 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Oct 30 05:05:24.545328 update_engine[1272]: I1030 05:05:24.545332 1272 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Oct 30 05:05:24.545328 update_engine[1272]: I1030 05:05:24.545336 1272 update_attempter.cc:302] Processing Done. Oct 30 05:05:24.545605 update_engine[1272]: E1030 05:05:24.545382 1272 update_attempter.cc:615] Update failed. Oct 30 05:05:24.545605 update_engine[1272]: I1030 05:05:24.545385 1272 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Oct 30 05:05:24.545605 update_engine[1272]: I1030 05:05:24.545389 1272 payload_state.cc:276] Incrementing the URL failure count Oct 30 05:05:24.545605 update_engine[1272]: I1030 05:05:24.545392 1272 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 30 05:05:24.545605 update_engine[1272]: I1030 05:05:24.545584 1272 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 30 05:05:24.545707 update_engine[1272]: I1030 05:05:24.545627 1272 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.5:34567/v1/update Oct 30 05:05:24.545707 update_engine[1272]: I1030 05:05:24.545634 1272 omaha_request_action.cc:269] Request: Oct 30 05:05:24.545707 update_engine[1272]: Oct 30 05:05:24.545707 update_engine[1272]: Oct 30 05:05:24.545707 update_engine[1272]: Oct 30 05:05:24.545707 update_engine[1272]: Oct 30 05:05:24.545707 update_engine[1272]: Oct 30 05:05:24.545707 update_engine[1272]: Oct 30 05:05:24.545707 update_engine[1272]: I1030 05:05:24.545639 1272 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 30 05:05:24.545707 update_engine[1272]: I1030 05:05:24.545697 1272 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 30 05:05:24.545877 update_engine[1272]: I1030 05:05:24.545825 1272 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 30 05:05:24.669704 update_engine[1272]: I1030 05:05:24.669660 1272 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 30 05:05:24.669805 update_engine[1272]: I1030 05:05:24.669742 1272 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Oct 30 05:05:24.669805 update_engine[1272]: I1030 05:05:24.669750 1272 omaha_request_action.cc:619] Omaha request response: Oct 30 05:05:24.669805 update_engine[1272]: Oct 30 05:05:24.669805 update_engine[1272]: Oct 30 05:05:24.669805 update_engine[1272]: Oct 30 05:05:24.669805 update_engine[1272]: Oct 30 05:05:24.669805 update_engine[1272]: Oct 30 05:05:24.669805 update_engine[1272]: Oct 30 05:05:24.669805 update_engine[1272]: E1030 05:05:24.669764 1272 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Oct 30 05:05:24.669805 update_engine[1272]: I1030 05:05:24.669770 1272 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 30 05:05:24.669805 update_engine[1272]: I1030 05:05:24.669772 1272 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 30 05:05:24.669805 update_engine[1272]: I1030 05:05:24.669775 1272 update_attempter.cc:302] Processing Done. Oct 30 05:05:24.669805 update_engine[1272]: I1030 05:05:24.669780 1272 update_attempter.cc:306] Error event sent. Oct 30 05:05:32.948205 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34880). Oct 30 05:05:32.981422 sshd[1306]: Accepted publickey for core from 10.0.0.1 port 34880 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:32.982960 sshd[1306]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:32.983324 kernel: kauditd_printk_skb: 287 callbacks suppressed Oct 30 05:05:32.983377 kernel: audit: type=1006 audit(1761800732.981:365): pid=1306 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 30 05:05:32.986232 systemd-logind[921]: New session 26 of user core. Oct 30 05:05:32.998757 systemd[1]: Started Session 26 of User core. Oct 30 05:05:33.054455 sshd[1306]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:33.064198 systemd[1]: sshd@25-10.0.0.6:22-10.0.0.1:34880.service: Deactivated successfully. Oct 30 05:05:33.064820 systemd[1]: session-26.scope: Deactivated successfully. Oct 30 05:05:33.065432 systemd-logind[921]: Session 26 logged out. Waiting for processes to exit. Oct 30 05:05:33.066429 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34890). Oct 30 05:05:33.067082 systemd-logind[921]: Removed session 26. Oct 30 05:05:33.098795 sshd[1313]: Accepted publickey for core from 10.0.0.1 port 34890 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:33.100878 sshd[1313]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:33.102581 kernel: audit: type=1006 audit(1761800733.099:366): pid=1313 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 30 05:05:33.103307 systemd-logind[921]: New session 27 of user core. Oct 30 05:05:33.112687 systemd[1]: Started Session 27 of User core. Oct 30 05:05:33.166095 sshd[1313]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:33.178168 systemd[1]: sshd@26-10.0.0.6:22-10.0.0.1:34890.service: Deactivated successfully. Oct 30 05:05:33.178765 systemd[1]: session-27.scope: Deactivated successfully. Oct 30 05:05:33.179362 systemd-logind[921]: Session 27 logged out. Waiting for processes to exit. Oct 30 05:05:33.180377 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34902). Oct 30 05:05:33.181036 systemd-logind[921]: Removed session 27. Oct 30 05:05:33.211697 sshd[1321]: Accepted publickey for core from 10.0.0.1 port 34902 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:33.212776 sshd[1321]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:33.214575 kernel: audit: type=1006 audit(1761800733.210:367): pid=1321 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 30 05:05:33.215426 systemd-logind[921]: New session 28 of user core. Oct 30 05:05:33.223735 systemd[1]: Started Session 28 of User core. Oct 30 05:05:33.271206 sshd[1321]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:33.282486 systemd[1]: sshd@27-10.0.0.6:22-10.0.0.1:34902.service: Deactivated successfully. Oct 30 05:05:33.283118 systemd[1]: session-28.scope: Deactivated successfully. Oct 30 05:05:33.283822 systemd-logind[921]: Session 28 logged out. Waiting for processes to exit. Oct 30 05:05:33.285005 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34908). Oct 30 05:05:33.285697 systemd-logind[921]: Removed session 28. Oct 30 05:05:33.315232 sshd[1327]: Accepted publickey for core from 10.0.0.1 port 34908 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:33.316076 sshd[1327]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:33.318539 systemd-logind[921]: New session 29 of user core. Oct 30 05:05:33.318638 kernel: audit: type=1006 audit(1761800733.314:368): pid=1327 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 30 05:05:33.331704 systemd[1]: Started Session 29 of User core. Oct 30 05:05:33.380058 sshd[1327]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:33.397186 systemd[1]: sshd@28-10.0.0.6:22-10.0.0.1:34908.service: Deactivated successfully. Oct 30 05:05:33.397707 systemd[1]: session-29.scope: Deactivated successfully. Oct 30 05:05:33.398298 systemd-logind[921]: Session 29 logged out. Waiting for processes to exit. Oct 30 05:05:33.399301 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34918). Oct 30 05:05:33.399962 systemd-logind[921]: Removed session 29. Oct 30 05:05:33.429917 sshd[1333]: Accepted publickey for core from 10.0.0.1 port 34918 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:33.431892 sshd[1333]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:33.433587 kernel: audit: type=1006 audit(1761800733.429:369): pid=1333 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 30 05:05:33.434795 systemd-logind[921]: New session 30 of user core. Oct 30 05:05:33.442725 systemd[1]: Started Session 30 of User core. Oct 30 05:05:33.493713 sudo[1337]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Oct 30 05:05:33.494785 sudo[1337]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:05:33.500243 systemd[1]: sshd.socket: Deactivated successfully. Oct 30 05:05:33.500581 systemd[1]: Closed OpenSSH Server Socket. Oct 30 05:05:33.501430 sudo[1337]: pam_unix(sudo:session): session closed for user root Oct 30 05:05:33.504954 sudo[1336]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Oct 30 05:05:33.505153 sudo[1336]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:05:33.520385 systemd[1]: Stopping Session 1 of User core... Oct 30 05:05:33.521150 sshd[954]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:33.521541 systemd[1]: Stopping Session 30 of User core... Oct 30 05:05:33.521720 sshd[1333]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:33.522327 sudo[1336]: pam_unix(sudo:session): session closed for user root Oct 30 05:05:33.523284 systemd[1]: Removed slice Slice /system/addon-config. Oct 30 05:05:33.524622 systemd[1]: Removed slice Slice /system/addon-run. Oct 30 05:05:33.525836 systemd[1]: Removed slice Slice /system/modprobe. Oct 30 05:05:33.527003 systemd[1]: Removed slice Slice /system/system-cloudinit. Oct 30 05:05:33.528179 systemd[1]: Stopped target Multi-User System. Oct 30 05:05:33.529135 systemd[1]: Stopped target Login Prompts. Oct 30 05:05:33.530087 systemd[1]: Stopped target Containers. Oct 30 05:05:33.530875 systemd[1]: Stopped target Host and Network Name Lookups. Oct 30 05:05:33.532088 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 30 05:05:33.533051 systemd[1]: Stopped target Timer Units. Oct 30 05:05:33.533804 systemd[1]: logrotate.timer: Deactivated successfully. Oct 30 05:05:33.533858 systemd[1]: Stopped Daily Log Rotation. Oct 30 05:05:33.534602 systemd[1]: mdadm.timer: Deactivated successfully. Oct 30 05:05:33.534642 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Oct 30 05:05:33.535714 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Oct 30 05:05:33.535755 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Oct 30 05:05:33.536784 systemd[1]: Stopped target System Time Set. Oct 30 05:05:33.537616 systemd[1]: Stopped target Load user-provided cloud configs. Oct 30 05:05:33.538604 systemd[1]: Stopped target Load system-provided cloud configs. Oct 30 05:05:33.539625 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 30 05:05:33.539718 systemd[1]: Closed Process Core Dump Socket. Oct 30 05:05:33.541270 systemd[1]: Unmounting Boot partition... Oct 30 05:05:33.542245 systemd[1]: Stopping Getty on tty1... Oct 30 05:05:33.543060 systemd[1]: Stopping Serial Getty on ttyAMA0... Oct 30 05:05:33.545432 systemd[1]: Stopping OpenSSH per-connection server daemon... Oct 30 05:05:33.546479 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:34918)... Oct 30 05:05:33.547538 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Oct 30 05:05:33.547698 systemd[1]: Stopped Commit a transient machine-id on disk. Oct 30 05:05:33.548764 systemd[1]: Stopped target First Boot Complete. Oct 30 05:05:33.550654 systemd[1]: Stopping Load/Save Random Seed... Oct 30 05:05:33.551644 systemd[1]: Stopping Update Engine... Oct 30 05:05:33.554768 systemd[1]: getty@tty1.service: Deactivated successfully. Oct 30 05:05:33.554983 systemd[1]: Stopped Getty on tty1. Oct 30 05:05:33.556141 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Oct 30 05:05:33.556329 systemd[1]: Stopped Serial Getty on ttyAMA0. Oct 30 05:05:33.557630 systemd[1]: sshd@0-10.0.0.6:22-10.0.0.1:33298.service: Deactivated successfully. Oct 30 05:05:33.557832 systemd[1]: Stopped OpenSSH per-connection server daemon. Oct 30 05:05:33.559211 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 30 05:05:33.559281 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 30 05:05:33.559514 systemd[1]: Stopped Update Engine. Oct 30 05:05:33.560326 systemd[1]: update-engine.service: Consumed 2.312s CPU time. Oct 30 05:05:33.560547 systemd[1]: sshd@29-10.0.0.6:22-10.0.0.1:34918.service: Deactivated successfully. Oct 30 05:05:33.560909 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:34918). Oct 30 05:05:33.573188 systemd[1]: boot.mount: Deactivated successfully. Oct 30 05:05:33.573434 systemd[1]: Unmounted Boot partition. Oct 30 05:05:33.574617 systemd[1]: systemd-random-seed.service: Deactivated successfully. Oct 30 05:05:33.574843 systemd[1]: Stopped Load/Save Random Seed. Oct 30 05:05:33.575890 systemd[1]: session-30.scope: Deactivated successfully. Oct 30 05:05:33.576117 systemd[1]: Stopped Session 30 of User core. Oct 30 05:05:33.577159 systemd[1]: session-1.scope: Deactivated successfully. Oct 30 05:05:33.577401 systemd[1]: Stopped Session 1 of User core. Oct 30 05:05:33.578823 systemd-logind[921]: Session 1 logged out. Waiting for processes to exit. Oct 30 05:05:33.579694 systemd-logind[921]: Session 30 logged out. Waiting for processes to exit. Oct 30 05:05:33.579948 systemd[1]: Removed slice Slice /system/getty. Oct 30 05:05:33.581419 systemd[1]: Removed slice Slice /system/serial-getty. Oct 30 05:05:33.582730 systemd[1]: Removed slice Slice /system/sshd. Oct 30 05:05:33.583620 systemd[1]: sshd-keygen.service: Deactivated successfully. Oct 30 05:05:33.583727 systemd[1]: Stopped Generate sshd host keys. Oct 30 05:05:33.584633 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Oct 30 05:05:33.584751 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Oct 30 05:05:33.586212 systemd[1]: Stopping User Login Management... Oct 30 05:05:33.587198 systemd[1]: Stopping User Manager for UID 500... Oct 30 05:05:33.588502 systemd[957]: Stopped target Main User Target. Oct 30 05:05:33.588522 systemd[957]: Stopped target Basic System. Oct 30 05:05:33.588531 systemd[957]: Stopped target Paths. Oct 30 05:05:33.588539 systemd[957]: Stopped target Sockets. Oct 30 05:05:33.588570 systemd[957]: Reached target Shutdown. Oct 30 05:05:33.588578 systemd[957]: Stopped target Timers. Oct 30 05:05:33.588689 systemd[957]: Finished Exit the Session. Oct 30 05:05:33.588714 systemd[957]: Reached target Exit the Session. Oct 30 05:05:33.590286 systemd-logind[921]: Removed session 30. Oct 30 05:05:33.591002 systemd[1]: user@500.service: Deactivated successfully. Oct 30 05:05:33.591170 systemd[1]: Stopped User Manager for UID 500. Oct 30 05:05:33.592913 systemd[1]: Stopping User Runtime Directory /run/user/500... Oct 30 05:05:33.597989 systemd[1]: run-user-500.mount: Deactivated successfully. Oct 30 05:05:33.598051 systemd[1]: Unmounted /run/user/500. Oct 30 05:05:33.599106 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Oct 30 05:05:33.599315 systemd[1]: Stopped User Runtime Directory /run/user/500. Oct 30 05:05:33.600803 systemd[1]: Removed slice User Slice of UID 500. Oct 30 05:05:33.602383 systemd[1]: Stopping D-Bus System Message Bus... Oct 30 05:05:33.604077 systemd[1]: Stopping Permit User Sessions... Oct 30 05:05:33.607410 systemd[1]: systemd-logind.service: Deactivated successfully. Oct 30 05:05:33.607783 systemd[1]: Stopped User Login Management. Oct 30 05:05:33.608887 systemd[1]: dbus.service: Deactivated successfully. Oct 30 05:05:33.609109 systemd[1]: Stopped D-Bus System Message Bus. Oct 30 05:05:33.610139 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Oct 30 05:05:33.610352 systemd[1]: Stopped Permit User Sessions. Oct 30 05:05:33.611269 systemd[1]: Stopped target Basic System. Oct 30 05:05:33.612052 systemd[1]: Stopped target Network. Oct 30 05:05:33.612824 systemd[1]: Stopped target Path Units. Oct 30 05:05:33.613506 systemd[1]: motdgen.path: Deactivated successfully. Oct 30 05:05:33.617619 systemd[1]: Stopped Watch for update engine configuration changes. Oct 30 05:05:33.618655 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Oct 30 05:05:33.621591 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 30 05:05:33.622615 systemd[1]: Stopped target Remote File Systems. Oct 30 05:05:33.623389 systemd[1]: Stopped target Slice Units. Oct 30 05:05:33.625000 audit: BPF prog-id=59 op=UNLOAD Oct 30 05:05:33.626582 kernel: audit: type=1334 audit(1761800733.625:370): prog-id=59 op=UNLOAD Oct 30 05:05:33.626708 systemd[1]: Removed slice User and Session Slice. Oct 30 05:05:33.627513 systemd[1]: Stopped target Socket Units. Oct 30 05:05:33.628365 systemd[1]: dbus.socket: Deactivated successfully. Oct 30 05:05:33.628417 systemd[1]: Closed D-Bus System Message Bus Socket. Oct 30 05:05:33.629421 systemd[1]: docker.socket: Deactivated successfully. Oct 30 05:05:33.629659 systemd[1]: Closed Docker Socket for the API. Oct 30 05:05:33.630451 systemd[1]: Stopped target System Initialization. Oct 30 05:05:33.631434 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Oct 30 05:05:33.631591 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Oct 30 05:05:33.632663 systemd[1]: Stopped target Local Verity Protected Volumes. Oct 30 05:05:33.634362 systemd[1]: Stopping Load Security Auditing Rules... Oct 30 05:05:33.635445 systemd[1]: Stopping Network Name Resolution... Oct 30 05:05:33.636396 systemd[1]: Stopping Network Time Synchronization... Oct 30 05:05:33.637161 auditctl[1354]: No rules Oct 30 05:05:33.637320 systemd[1]: systemd-update-done.service: Deactivated successfully. Oct 30 05:05:33.637383 systemd[1]: Stopped Update is Completed. Oct 30 05:05:33.638191 systemd[1]: ldconfig.service: Deactivated successfully. Oct 30 05:05:33.638251 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Oct 30 05:05:33.639126 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Oct 30 05:05:33.639189 systemd[1]: Stopped Rebuild Hardware Database. Oct 30 05:05:33.640030 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Oct 30 05:05:33.640089 systemd[1]: Stopped Rebuild Journal Catalog. Oct 30 05:05:33.641839 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Oct 30 05:05:33.644348 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 30 05:05:33.644607 systemd[1]: Stopped Network Name Resolution. Oct 30 05:05:33.645685 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Oct 30 05:05:33.645927 systemd[1]: Stopped Network Time Synchronization. Oct 30 05:05:33.647075 systemd[1]: audit-rules.service: Deactivated successfully. Oct 30 05:05:33.647276 systemd[1]: Stopped Load Security Auditing Rules. Oct 30 05:05:33.649619 systemd[1]: Stopping Network Configuration... Oct 30 05:05:33.650542 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Oct 30 05:05:33.658606 systemd-networkd[843]: eth0: DHCPv6 lease lost Oct 30 05:05:33.663667 kernel: audit: type=1334 audit(1761800733.662:371): prog-id=63 op=UNLOAD Oct 30 05:05:33.663691 kernel: audit: type=1334 audit(1761800733.662:372): prog-id=67 op=UNLOAD Oct 30 05:05:33.662000 audit: BPF prog-id=63 op=UNLOAD Oct 30 05:05:33.662000 audit: BPF prog-id=67 op=UNLOAD Oct 30 05:05:33.664494 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Oct 30 05:05:33.665722 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 30 05:05:33.665948 systemd[1]: Stopped Network Configuration. Oct 30 05:05:33.667433 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 30 05:05:33.667513 systemd[1]: Closed Network Service Netlink Socket. Oct 30 05:05:33.668461 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 30 05:05:33.668521 systemd[1]: Stopped Apply Kernel Variables. Oct 30 05:05:33.669363 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 30 05:05:33.669419 systemd[1]: Stopped Create Volatile Files and Directories. Oct 30 05:05:33.670509 systemd[1]: Stopped target Local File Systems. Oct 30 05:05:33.672227 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Oct 30 05:05:33.673742 systemd[1]: Unmounting External Media Directory... Oct 30 05:05:33.674000 audit: BPF prog-id=62 op=UNLOAD Oct 30 05:05:33.675510 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Oct 30 05:05:33.676654 kernel: audit: type=1334 audit(1761800733.674:373): prog-id=62 op=UNLOAD Oct 30 05:05:33.677672 systemd[1]: Unmounting /run/torcx/unpack... Oct 30 05:05:33.679048 systemd[1]: Unmounting Temporary Directory /tmp... Oct 30 05:05:33.680411 systemd[1]: Unmounting /usr/share/oem... Oct 30 05:05:33.681970 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Oct 30 05:05:33.684720 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 30 05:05:33.684951 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Oct 30 05:05:33.686215 systemd[1]: media.mount: Deactivated successfully. Oct 30 05:05:33.686455 systemd[1]: Unmounted External Media Directory. Oct 30 05:05:33.687443 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Oct 30 05:05:33.687699 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Oct 30 05:05:33.688902 systemd[1]: tmp.mount: Deactivated successfully. Oct 30 05:05:33.689146 systemd[1]: Unmounted Temporary Directory /tmp. Oct 30 05:05:33.690093 systemd[1]: usr-share-oem.mount: Deactivated successfully. Oct 30 05:05:33.690334 systemd[1]: Unmounted /usr/share/oem. Oct 30 05:05:33.703797 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 30 05:05:33.704038 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Oct 30 05:05:33.705445 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Oct 30 05:05:33.705700 systemd[1]: Unmounted /run/torcx/unpack. Oct 30 05:05:33.706759 systemd[1]: Stopped target Swaps. Oct 30 05:05:33.707419 systemd[1]: Reached target Unmount All Filesystems. Oct 30 05:05:33.708384 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Oct 30 05:05:33.708460 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Oct 30 05:05:33.709782 systemd[1]: Removed slice Slice /system/systemd-fsck. Oct 30 05:05:33.710665 systemd[1]: Stopped target Preparation for Local File Systems. Oct 30 05:05:33.711617 systemd[1]: lvm2-activation.service: Deactivated successfully. Oct 30 05:05:33.711687 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 30 05:05:33.712603 systemd[1]: Stopped target Local Encrypted Volumes. Oct 30 05:05:33.713421 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 30 05:05:33.713486 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 30 05:05:33.714736 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Oct 30 05:05:33.716620 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Oct 30 05:05:33.717707 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Oct 30 05:05:33.717772 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 30 05:05:33.718709 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 30 05:05:33.718770 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 30 05:05:33.719698 systemd[1]: systemd-sysusers.service: Deactivated successfully. Oct 30 05:05:33.719755 systemd[1]: Stopped Create System Users. Oct 30 05:05:33.720507 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Oct 30 05:05:33.720579 systemd[1]: Stopped Remount Root and Kernel File Systems. Oct 30 05:05:33.721514 systemd[1]: Reached target System Shutdown. Oct 30 05:05:33.722364 systemd[1]: Reached target Late Shutdown Services. Oct 30 05:05:33.723324 systemd[1]: systemd-reboot.service: Deactivated successfully. Oct 30 05:05:33.723365 systemd[1]: Finished System Reboot. Oct 30 05:05:33.724121 systemd[1]: Reached target System Reboot. Oct 30 05:05:33.724889 systemd[1]: Shutting down. Oct 30 05:05:33.724000 audit: BPF prog-id=58 op=UNLOAD Oct 30 05:05:33.724000 audit: BPF prog-id=57 op=UNLOAD Oct 30 05:05:33.724000 audit: BPF prog-id=56 op=UNLOAD Oct 30 05:05:33.726581 kernel: audit: type=1334 audit(1761800733.724:374): prog-id=58 op=UNLOAD Oct 30 05:05:33.726000 audit: BPF prog-id=61 op=UNLOAD Oct 30 05:05:33.726000 audit: BPF prog-id=60 op=UNLOAD Oct 30 05:05:33.728000 audit: BPF prog-id=66 op=UNLOAD Oct 30 05:05:33.728000 audit: BPF prog-id=65 op=UNLOAD Oct 30 05:05:33.728000 audit: BPF prog-id=64 op=UNLOAD Oct 30 05:05:33.761592 systemd-shutdown[1]: Syncing filesystems and block devices. Oct 30 05:05:33.767901 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Oct 30 05:05:33.767959 systemd-journald[807]: Journal stopped -- Reboot -- Oct 30 05:05:42.681294 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 30 05:05:42.681310 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 30 05:05:42.681318 kernel: efi: EFI v2.70 by EDK II Oct 30 05:05:42.681323 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 30 05:05:42.681328 kernel: efi: seeding entropy pool Oct 30 05:05:42.681333 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 30 05:05:42.681340 kernel: ACPI: Early table checksum verification disabled Oct 30 05:05:42.681345 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 30 05:05:42.681350 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 30 05:05:42.681355 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:42.681362 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:42.681367 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:42.681372 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:42.681378 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:42.681384 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:42.681389 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:42.681396 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:42.681402 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 05:05:42.681407 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 30 05:05:42.681412 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 30 05:05:42.681418 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:05:42.681423 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 30 05:05:42.681428 kernel: Zone ranges: Oct 30 05:05:42.681433 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:05:42.681438 kernel: DMA32 empty Oct 30 05:05:42.681443 kernel: Normal empty Oct 30 05:05:42.681448 kernel: Movable zone start for each node Oct 30 05:05:42.681455 kernel: Early memory node ranges Oct 30 05:05:42.681466 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 30 05:05:42.681472 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 30 05:05:42.681478 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 30 05:05:42.681483 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 30 05:05:42.681488 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 30 05:05:42.681493 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 30 05:05:42.681498 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 30 05:05:42.681504 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 30 05:05:42.681509 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 30 05:05:42.681514 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 30 05:05:42.681519 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 30 05:05:42.681525 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 30 05:05:42.681533 kernel: On node 0 totalpages: 643072 Oct 30 05:05:42.681539 kernel: DMA zone: 10048 pages used for memmap Oct 30 05:05:42.681545 kernel: DMA zone: 0 pages reserved Oct 30 05:05:42.681550 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 30 05:05:42.681556 kernel: psci: probing for conduit method from ACPI. Oct 30 05:05:42.681562 kernel: psci: PSCIv1.1 detected in firmware. Oct 30 05:05:42.681568 kernel: psci: Using standard PSCI v0.2 function IDs Oct 30 05:05:42.681574 kernel: psci: Trusted OS migration not required Oct 30 05:05:42.681581 kernel: psci: SMC Calling Convention v1.1 Oct 30 05:05:42.681586 kernel: ACPI: SRAT not present Oct 30 05:05:42.681592 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 30 05:05:42.681598 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 30 05:05:42.681603 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 30 05:05:42.681609 kernel: Detected PIPT I-cache on CPU0 Oct 30 05:05:42.681615 kernel: CPU features: detected: GIC system register CPU interface Oct 30 05:05:42.681621 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 30 05:05:42.681626 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 30 05:05:42.681632 kernel: CPU features: detected: Hardware dirty bit management Oct 30 05:05:42.681638 kernel: CPU features: detected: Spectre-v4 Oct 30 05:05:42.681645 kernel: CPU features: detected: ARM erratum 1418040 Oct 30 05:05:42.681651 kernel: CPU features: detected: Spectre-BHB Oct 30 05:05:42.681656 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 30 05:05:42.681662 kernel: Policy zone: DMA Oct 30 05:05:42.681669 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 30 05:05:42.681675 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 30 05:05:42.681681 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 30 05:05:42.681687 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 30 05:05:42.681693 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 30 05:05:42.681699 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 30 05:05:42.681705 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 30 05:05:42.681712 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 30 05:05:42.681719 kernel: rcu: RCU event tracing is enabled. Oct 30 05:05:42.681724 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 30 05:05:42.681730 kernel: Trampoline variant of Tasks RCU enabled. Oct 30 05:05:42.681736 kernel: Tracing variant of Tasks RCU enabled. Oct 30 05:05:42.681743 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 30 05:05:42.681749 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 30 05:05:42.681754 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 30 05:05:42.681760 kernel: GICv3: 256 SPIs implemented Oct 30 05:05:42.681766 kernel: GICv3: 0 Extended SPIs implemented Oct 30 05:05:42.681772 kernel: GICv3: Distributor has no Range Selector support Oct 30 05:05:42.681777 kernel: GICv3: 16 PPIs implemented Oct 30 05:05:42.681784 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 30 05:05:42.681791 kernel: ACPI: SRAT not present Oct 30 05:05:42.681796 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 30 05:05:42.681802 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 30 05:05:42.681808 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 30 05:05:42.681814 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 30 05:05:42.681819 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 30 05:05:42.681825 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:05:42.681831 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 30 05:05:42.681837 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 30 05:05:42.681843 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 30 05:05:42.681849 kernel: arm-pv: using stolen time PV Oct 30 05:05:42.681856 kernel: Console: colour dummy device 80x25 Oct 30 05:05:42.681868 kernel: ACPI: Core revision 20200925 Oct 30 05:05:42.681874 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 30 05:05:42.681880 kernel: pid_max: default: 32768 minimum: 301 Oct 30 05:05:42.681886 kernel: LSM: Security Framework initializing Oct 30 05:05:42.681892 kernel: SELinux: Initializing. Oct 30 05:05:42.681898 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 30 05:05:42.681903 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 30 05:05:42.681909 kernel: rcu: Hierarchical SRCU implementation. Oct 30 05:05:42.681917 kernel: Platform MSI: ITS@0x8080000 domain created Oct 30 05:05:42.681923 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 30 05:05:42.681928 kernel: Remapping and enabling EFI services. Oct 30 05:05:42.681935 kernel: smp: Bringing up secondary CPUs ... Oct 30 05:05:42.681940 kernel: Detected PIPT I-cache on CPU1 Oct 30 05:05:42.681946 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 30 05:05:42.681952 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 30 05:05:42.681958 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:05:42.681964 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 30 05:05:42.681970 kernel: Detected PIPT I-cache on CPU2 Oct 30 05:05:42.681978 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 30 05:05:42.681984 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 30 05:05:42.681990 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:05:42.681996 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 30 05:05:42.682002 kernel: Detected PIPT I-cache on CPU3 Oct 30 05:05:42.682013 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 30 05:05:42.682019 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 30 05:05:42.682026 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 05:05:42.682035 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 30 05:05:42.682042 kernel: smp: Brought up 1 node, 4 CPUs Oct 30 05:05:42.682048 kernel: SMP: Total of 4 processors activated. Oct 30 05:05:42.682054 kernel: CPU features: detected: Privileged Access Never Oct 30 05:05:42.682061 kernel: CPU features: detected: LSE atomic instructions Oct 30 05:05:42.682067 kernel: CPU features: detected: User Access Override Oct 30 05:05:42.682075 kernel: CPU features: detected: 32-bit EL0 Support Oct 30 05:05:42.682082 kernel: CPU features: detected: Common not Private translations Oct 30 05:05:42.682092 kernel: CPU features: detected: RAS Extension Support Oct 30 05:05:42.682102 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 30 05:05:42.682109 kernel: CPU features: detected: CRC32 instructions Oct 30 05:05:42.682117 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 30 05:05:42.682123 kernel: CPU: All CPU(s) started at EL1 Oct 30 05:05:42.682130 kernel: alternatives: patching kernel code Oct 30 05:05:42.682137 kernel: devtmpfs: initialized Oct 30 05:05:42.682144 kernel: KASLR enabled Oct 30 05:05:42.682150 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 30 05:05:42.682157 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 30 05:05:42.682163 kernel: pinctrl core: initialized pinctrl subsystem Oct 30 05:05:42.682169 kernel: SMBIOS 3.0.0 present. Oct 30 05:05:42.682175 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 30 05:05:42.682181 kernel: NET: Registered protocol family 16 Oct 30 05:05:42.682188 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 30 05:05:42.682194 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 30 05:05:42.682201 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 30 05:05:42.682208 kernel: audit: initializing netlink subsys (disabled) Oct 30 05:05:42.682214 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Oct 30 05:05:42.682220 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 30 05:05:42.682226 kernel: cpuidle: using governor menu Oct 30 05:05:42.682232 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 30 05:05:42.682238 kernel: ASID allocator initialised with 32768 entries Oct 30 05:05:42.682244 kernel: ACPI: bus type PCI registered Oct 30 05:05:42.682251 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 30 05:05:42.682258 kernel: Serial: AMBA PL011 UART driver Oct 30 05:05:42.682264 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 30 05:05:42.682271 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 30 05:05:42.682277 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 30 05:05:42.682284 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 30 05:05:42.682290 kernel: cryptd: max_cpu_qlen set to 1000 Oct 30 05:05:42.682296 kernel: ACPI: Added _OSI(Module Device) Oct 30 05:05:42.682303 kernel: ACPI: Added _OSI(Processor Device) Oct 30 05:05:42.682309 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 30 05:05:42.682316 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 30 05:05:42.682323 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 30 05:05:42.682329 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 30 05:05:42.682336 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 30 05:05:42.682342 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 30 05:05:42.682348 kernel: ACPI: Interpreter enabled Oct 30 05:05:42.682354 kernel: ACPI: Using GIC for interrupt routing Oct 30 05:05:42.682361 kernel: ACPI: MCFG table detected, 1 entries Oct 30 05:05:42.682367 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 30 05:05:42.682373 kernel: printk: console [ttyAMA0] enabled Oct 30 05:05:42.682381 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 30 05:05:42.682499 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 30 05:05:42.682559 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 30 05:05:42.682612 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 30 05:05:42.682668 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 30 05:05:42.682719 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 30 05:05:42.682727 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 30 05:05:42.682735 kernel: PCI host bridge to bus 0000:00 Oct 30 05:05:42.682793 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 30 05:05:42.682842 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 30 05:05:42.682904 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 30 05:05:42.682953 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 30 05:05:42.683023 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 30 05:05:42.683091 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 30 05:05:42.683165 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 30 05:05:42.683233 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 30 05:05:42.683288 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 30 05:05:42.683370 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 30 05:05:42.683428 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 30 05:05:42.683489 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 30 05:05:42.683538 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 30 05:05:42.683588 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 30 05:05:42.683636 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 30 05:05:42.683644 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 30 05:05:42.683650 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 30 05:05:42.683657 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 30 05:05:42.683663 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 30 05:05:42.683669 kernel: vgaarb: loaded Oct 30 05:05:42.683675 kernel: Registered efivars operations Oct 30 05:05:42.683681 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 30 05:05:42.683689 kernel: VFS: Disk quotas dquot_6.6.0 Oct 30 05:05:42.683696 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 30 05:05:42.683702 kernel: pnp: PnP ACPI init Oct 30 05:05:42.683762 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 30 05:05:42.683811 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 30 05:05:42.683819 kernel: pnp: PnP ACPI: found 1 devices Oct 30 05:05:42.683826 kernel: NET: Registered protocol family 2 Oct 30 05:05:42.683832 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 30 05:05:42.683840 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 30 05:05:42.683846 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 30 05:05:42.683852 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 30 05:05:42.683882 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 30 05:05:42.683889 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 30 05:05:42.683895 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 30 05:05:42.683904 kernel: NET: Registered protocol family 1 Oct 30 05:05:42.683910 kernel: PCI: CLS 0 bytes, default 64 Oct 30 05:05:42.683917 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 30 05:05:42.683925 kernel: kvm [1]: HYP mode not available Oct 30 05:05:42.683931 kernel: Initialise system trusted keyrings Oct 30 05:05:42.683937 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 30 05:05:42.683943 kernel: Key type asymmetric registered Oct 30 05:05:42.683949 kernel: Asymmetric key parser 'x509' registered Oct 30 05:05:42.683955 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 30 05:05:42.683961 kernel: io scheduler mq-deadline registered Oct 30 05:05:42.683968 kernel: io scheduler kyber registered Oct 30 05:05:42.683974 kernel: io scheduler bfq registered Oct 30 05:05:42.683980 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 30 05:05:42.683988 kernel: ACPI: Power Button [PWRB] Oct 30 05:05:42.683994 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 30 05:05:42.684052 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 30 05:05:42.684061 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 30 05:05:42.684067 kernel: msm_serial: driver initialized Oct 30 05:05:42.684073 kernel: random: fast init done Oct 30 05:05:42.684079 kernel: random: crng init done Oct 30 05:05:42.684085 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 30 05:05:42.684092 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 30 05:05:42.684100 kernel: thunder_xcv, ver 1.0 Oct 30 05:05:42.684106 kernel: thunder_bgx, ver 1.0 Oct 30 05:05:42.684112 kernel: nicpf, ver 1.0 Oct 30 05:05:42.684119 kernel: nicvf, ver 1.0 Oct 30 05:05:42.684185 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 30 05:05:42.684236 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-30T05:05:42 UTC (1761800742) Oct 30 05:05:42.684244 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 30 05:05:42.684251 kernel: NET: Registered protocol family 10 Oct 30 05:05:42.684259 kernel: Segment Routing with IPv6 Oct 30 05:05:42.684265 kernel: NET: Registered protocol family 17 Oct 30 05:05:42.684271 kernel: Key type dns_resolver registered Oct 30 05:05:42.684277 kernel: registered taskstats version 1 Oct 30 05:05:42.684283 kernel: Loading compiled-in X.509 certificates Oct 30 05:05:42.684289 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 30 05:05:42.684295 kernel: Key type ._fscrypt registered Oct 30 05:05:42.684301 kernel: Key type .fscrypt registered Oct 30 05:05:42.684307 kernel: Key type fscrypt-provisioning registered Oct 30 05:05:42.684314 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 30 05:05:42.684320 kernel: ima: Allocated hash algorithm: sha1 Oct 30 05:05:42.684326 kernel: ima: No architecture policies found Oct 30 05:05:42.684332 kernel: Freeing unused kernel memory: 34240K Oct 30 05:05:42.684339 kernel: Run /init as init process Oct 30 05:05:42.684345 kernel: with arguments: Oct 30 05:05:42.684351 kernel: /init Oct 30 05:05:42.684357 kernel: with environment: Oct 30 05:05:42.684363 kernel: HOME=/ Oct 30 05:05:42.684368 kernel: TERM=linux Oct 30 05:05:42.684375 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 30 05:05:42.684383 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 30 05:05:42.684391 systemd[1]: Detected virtualization kvm. Oct 30 05:05:42.684398 systemd[1]: Detected architecture arm64. Oct 30 05:05:42.684404 systemd[1]: Running in initial RAM disk. Oct 30 05:05:42.684411 systemd[1]: No hostname configured, using default hostname. Oct 30 05:05:42.684417 systemd[1]: Hostname set to . Oct 30 05:05:42.684424 systemd[1]: Initializing machine ID from VM UUID. Oct 30 05:05:42.684432 systemd[1]: Queued start job for default target Initrd Default Target. Oct 30 05:05:42.684438 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 30 05:05:42.684445 systemd[1]: Reached target Local Encrypted Volumes. Oct 30 05:05:42.684451 systemd[1]: Reached target Path Units. Oct 30 05:05:42.684458 systemd[1]: Reached target Slice Units. Oct 30 05:05:42.684471 systemd[1]: Reached target Swaps. Oct 30 05:05:42.684478 systemd[1]: Reached target Timer Units. Oct 30 05:05:42.684485 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 30 05:05:42.684492 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 30 05:05:42.684499 systemd[1]: Listening on Journal Audit Socket. Oct 30 05:05:42.684505 systemd[1]: Listening on Journal Socket (/dev/log). Oct 30 05:05:42.684512 systemd[1]: Listening on Journal Socket. Oct 30 05:05:42.684518 systemd[1]: Listening on udev Control Socket. Oct 30 05:05:42.684524 systemd[1]: Listening on udev Kernel Socket. Oct 30 05:05:42.684531 systemd[1]: Reached target Socket Units. Oct 30 05:05:42.684537 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 30 05:05:42.684545 systemd[1]: Starting Create List of Static Device Nodes... Oct 30 05:05:42.684551 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 30 05:05:42.684558 systemd[1]: Starting Journal Service... Oct 30 05:05:42.684564 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 30 05:05:42.684570 systemd[1]: Starting Apply Kernel Variables... Oct 30 05:05:42.684577 systemd[1]: Starting Setup Virtual Console... Oct 30 05:05:42.684583 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 30 05:05:42.684590 kernel: SCSI subsystem initialized Oct 30 05:05:42.684596 kernel: Loading iSCSI transport class v2.0-870. Oct 30 05:05:42.684602 systemd[1]: Finished Create List of Static Device Nodes. Oct 30 05:05:42.684612 systemd-journald[270]: Journal started Oct 30 05:05:42.684672 systemd-journald[270]: Runtime Journal (/run/log/journal/7562076a330c462bb5798545670cc149) is 6.0M, max 48.5M, 42.4M free. Oct 30 05:05:42.686199 systemd[1]: Started Journal Service. Oct 30 05:05:42.686670 systemd[1]: Finished Apply Kernel Variables. Oct 30 05:05:42.687763 systemd[1]: Finished Setup Virtual Console. Oct 30 05:05:42.689985 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 30 05:05:42.691557 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 30 05:05:42.695139 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 30 05:05:42.703385 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 30 05:05:42.705175 systemd[1]: Starting dracut cmdline hook... Oct 30 05:05:42.713780 dracut-cmdline[289]: dracut-dracut-053 Oct 30 05:05:42.715993 dracut-cmdline[289]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 30 05:05:42.773899 kernel: iscsi: registered transport (tcp) Oct 30 05:05:42.784876 kernel: iscsi: registered transport (qla4xxx) Oct 30 05:05:42.784892 kernel: QLogic iSCSI HBA Driver Oct 30 05:05:42.794732 systemd[1]: Finished dracut cmdline hook. Oct 30 05:05:42.796432 systemd[1]: Starting dracut pre-udev hook... Oct 30 05:05:42.797833 systemd[1]: Starting Open-iSCSI... Oct 30 05:05:42.800298 iscsid[374]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 30 05:05:42.800298 iscsid[374]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Oct 30 05:05:42.800298 iscsid[374]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 30 05:05:42.800298 iscsid[374]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 30 05:05:42.800298 iscsid[374]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 30 05:05:42.811944 iscsid[374]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 30 05:05:42.814269 kernel: device-mapper: uevent: version 1.0.3 Oct 30 05:05:42.814289 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 30 05:05:42.804514 systemd[1]: Started Open-iSCSI. Oct 30 05:05:42.847882 kernel: raid6: neonx8 gen() 13772 MB/s Oct 30 05:05:42.864873 kernel: raid6: neonx8 xor() 10715 MB/s Oct 30 05:05:42.881879 kernel: raid6: neonx4 gen() 13590 MB/s Oct 30 05:05:42.898880 kernel: raid6: neonx4 xor() 11529 MB/s Oct 30 05:05:42.915876 kernel: raid6: neonx2 gen() 13004 MB/s Oct 30 05:05:42.932880 kernel: raid6: neonx2 xor() 9853 MB/s Oct 30 05:05:42.949881 kernel: raid6: neonx1 gen() 10814 MB/s Oct 30 05:05:42.966886 kernel: raid6: neonx1 xor() 8812 MB/s Oct 30 05:05:42.983884 kernel: raid6: int64x8 gen() 6839 MB/s Oct 30 05:05:43.000883 kernel: raid6: int64x8 xor() 3788 MB/s Oct 30 05:05:43.017882 kernel: raid6: int64x4 gen() 6916 MB/s Oct 30 05:05:43.034876 kernel: raid6: int64x4 xor() 3830 MB/s Oct 30 05:05:43.051883 kernel: raid6: int64x2 gen() 6196 MB/s Oct 30 05:05:43.068892 kernel: raid6: int64x2 xor() 3325 MB/s Oct 30 05:05:43.085882 kernel: raid6: int64x1 gen() 5015 MB/s Oct 30 05:05:43.103078 kernel: raid6: int64x1 xor() 2598 MB/s Oct 30 05:05:43.103090 kernel: raid6: using algorithm neonx8 gen() 13772 MB/s Oct 30 05:05:43.103100 kernel: raid6: .... xor() 10715 MB/s, rmw enabled Oct 30 05:05:43.104309 kernel: raid6: using neon recovery algorithm Oct 30 05:05:43.113886 kernel: xor: measuring software checksum speed Oct 30 05:05:43.115928 kernel: 8regs : 17170 MB/sec Oct 30 05:05:43.115944 kernel: 32regs : 20765 MB/sec Oct 30 05:05:43.117516 kernel: arm64_neon : 29039 MB/sec Oct 30 05:05:43.117528 kernel: xor: using function: arm64_neon (29039 MB/sec) Oct 30 05:05:43.161882 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 30 05:05:43.171524 systemd[1]: Finished dracut pre-udev hook. Oct 30 05:05:43.172000 audit: BPF prog-id=6 op=LOAD Oct 30 05:05:43.172000 audit: BPF prog-id=7 op=LOAD Oct 30 05:05:43.174238 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 30 05:05:43.177894 kernel: audit: type=1334 audit(1761800743.172:2): prog-id=6 op=LOAD Oct 30 05:05:43.177912 kernel: audit: type=1334 audit(1761800743.172:3): prog-id=7 op=LOAD Oct 30 05:05:43.177920 kernel: audit: type=1334 audit(1761800743.172:4): prog-id=8 op=LOAD Oct 30 05:05:43.172000 audit: BPF prog-id=8 op=LOAD Oct 30 05:05:43.186659 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 30 05:05:43.188382 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 30 05:05:43.190533 systemd[1]: Starting dracut pre-trigger hook... Oct 30 05:05:43.201455 dracut-pre-trigger[416]: rd.md=0: removing MD RAID activation Oct 30 05:05:43.224795 systemd[1]: Finished dracut pre-trigger hook. Oct 30 05:05:43.226395 systemd[1]: Starting Coldplug All udev Devices... Oct 30 05:05:43.236265 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 30 05:05:43.256840 systemd[1]: Finished Coldplug All udev Devices. Oct 30 05:05:43.258488 systemd[1]: Starting dracut initqueue hook... Oct 30 05:05:43.273364 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 30 05:05:43.273530 kernel: vda: detected capacity change from 0 to 4756340736 Oct 30 05:05:43.286290 systemd-udevd[454]: Using default interface naming scheme 'v249'. Oct 30 05:05:43.287536 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 30 05:05:43.308779 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 30 05:05:43.310016 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 30 05:05:43.316841 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 30 05:05:43.318506 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (450) Oct 30 05:05:43.317777 systemd[1]: Reached target Initrd Root Device. Oct 30 05:05:43.319926 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 30 05:05:43.324747 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 30 05:05:43.324872 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 30 05:05:43.326809 systemd[1]: Reached target Preparation for Local File Systems. Oct 30 05:05:43.329265 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 30 05:05:43.331454 systemd[1]: Finished dracut initqueue hook. Oct 30 05:05:43.332430 systemd[1]: Reached target Preparation for Remote File Systems. Oct 30 05:05:43.334015 systemd[1]: Reached target Remote Encrypted Volumes. Oct 30 05:05:43.335710 systemd[1]: Reached target Remote File Systems. Oct 30 05:05:43.338045 systemd[1]: Starting dracut pre-mount hook... Oct 30 05:05:43.343881 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 30 05:05:43.346233 systemd[1]: Finished dracut pre-mount hook. Oct 30 05:05:43.347811 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 30 05:05:43.357147 systemd-fsck[502]: ROOT: clean, 640/553792 files, 39961/553472 blocks Oct 30 05:05:43.359763 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 30 05:05:43.361629 systemd[1]: Mounting /sysroot... Oct 30 05:05:43.369043 systemd[1]: Found device /dev/mapper/usr. Oct 30 05:05:43.371452 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 30 05:05:43.372690 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 30 05:05:43.382928 systemd-fsck[513]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 30 05:05:43.382928 systemd-fsck[513]: You must have r/w access to the filesystem or be root Oct 30 05:05:43.385965 systemd-fsck[509]: fsck failed with exit status 8. Oct 30 05:05:43.385972 systemd-fsck[509]: Ignoring error. Oct 30 05:05:43.386780 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 30 05:05:43.388635 systemd[1]: Mounting /sysusr/usr... Oct 30 05:05:43.402142 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 30 05:05:43.402175 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 30 05:05:43.402652 systemd[1]: Mounted /sysroot. Oct 30 05:05:43.403473 systemd[1]: Reached target Initrd Root File System. Oct 30 05:05:43.405338 systemd[1]: Starting Reload Configuration from the Real Root... Oct 30 05:05:43.410216 systemd[1]: Reloading. Oct 30 05:05:43.412000 audit: BPF prog-id=3 op=UNLOAD Oct 30 05:05:43.413876 kernel: audit: type=1334 audit(1761800743.412:5): prog-id=3 op=UNLOAD Oct 30 05:05:43.413000 audit: BPF prog-id=6 op=UNLOAD Oct 30 05:05:43.415957 kernel: audit: type=1334 audit(1761800743.413:6): prog-id=6 op=UNLOAD Oct 30 05:05:43.423645 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 30 05:05:43.494000 audit: BPF prog-id=9 op=LOAD Oct 30 05:05:43.495000 audit: BPF prog-id=10 op=LOAD Oct 30 05:05:43.497394 kernel: audit: type=1334 audit(1761800743.494:7): prog-id=9 op=LOAD Oct 30 05:05:43.497417 kernel: audit: type=1334 audit(1761800743.495:8): prog-id=10 op=LOAD Oct 30 05:05:43.497427 kernel: audit: type=1334 audit(1761800743.496:9): prog-id=11 op=LOAD Oct 30 05:05:43.496000 audit: BPF prog-id=11 op=LOAD Oct 30 05:05:43.496000 audit: BPF prog-id=4 op=UNLOAD Oct 30 05:05:43.499064 kernel: audit: type=1334 audit(1761800743.496:10): prog-id=4 op=UNLOAD Oct 30 05:05:43.496000 audit: BPF prog-id=5 op=UNLOAD Oct 30 05:05:43.497000 audit: BPF prog-id=12 op=LOAD Oct 30 05:05:43.498000 audit: BPF prog-id=13 op=LOAD Oct 30 05:05:43.498000 audit: BPF prog-id=14 op=LOAD Oct 30 05:05:43.498000 audit: BPF prog-id=7 op=UNLOAD Oct 30 05:05:43.498000 audit: BPF prog-id=8 op=UNLOAD Oct 30 05:05:43.500323 systemd[1]: Mounted /sysusr/usr. Oct 30 05:05:43.502385 systemd[1]: Reached target Local File Systems. Oct 30 05:05:43.503245 systemd[1]: Reached target System Initialization. Oct 30 05:05:43.504665 systemd[1]: Reached target Basic System. Oct 30 05:05:43.507243 systemd[1]: Mounting /sysroot/usr... Oct 30 05:05:43.509642 systemd[1]: Mounted /sysroot/usr. Oct 30 05:05:43.518336 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 30 05:05:43.518452 systemd[1]: Finished Reload Configuration from the Real Root. Oct 30 05:05:43.520415 systemd[1]: Reached target Initrd File Systems. Oct 30 05:05:43.521900 systemd[1]: Reached target Initrd Default Target. Oct 30 05:05:43.523421 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 30 05:05:43.524044 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 30 05:05:43.534097 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 30 05:05:43.535713 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 30 05:05:43.541619 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 30 05:05:43.542744 systemd[1]: Stopped target Timer Units. Oct 30 05:05:43.544260 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 30 05:05:43.544378 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 30 05:05:43.545845 systemd[1]: Stopped target Initrd Default Target. Oct 30 05:05:43.547546 systemd[1]: Stopped target Basic System. Oct 30 05:05:43.549077 systemd[1]: Stopped target Initrd Root Device. Oct 30 05:05:43.550694 systemd[1]: Stopped target Path Units. Oct 30 05:05:43.552123 systemd[1]: Stopped target Remote File Systems. Oct 30 05:05:43.553602 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 30 05:05:43.555252 systemd[1]: Stopped target Slice Units. Oct 30 05:05:43.556712 systemd[1]: Stopped target Socket Units. Oct 30 05:05:43.558342 systemd[1]: Stopped target System Initialization. Oct 30 05:05:43.559823 systemd[1]: Stopped target Local File Systems. Oct 30 05:05:43.561279 systemd[1]: Stopped target Preparation for Local File Systems. Oct 30 05:05:43.563002 systemd[1]: Stopped target Swaps. Oct 30 05:05:43.564249 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 30 05:05:43.564365 systemd[1]: Stopped dracut pre-mount hook. Oct 30 05:05:43.565816 systemd[1]: Stopped target Local Encrypted Volumes. Oct 30 05:05:43.567100 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 30 05:05:43.570919 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 30 05:05:43.572083 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 30 05:05:43.572181 systemd[1]: Stopped dracut initqueue hook. Oct 30 05:05:43.575775 iscsid[374]: iscsid shutting down. Oct 30 05:05:43.573906 systemd[1]: Stopping Open-iSCSI... Oct 30 05:05:43.575149 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 30 05:05:43.575278 systemd[1]: Stopped Apply Kernel Variables. Oct 30 05:05:43.576641 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 30 05:05:43.576728 systemd[1]: Stopped Coldplug All udev Devices. Oct 30 05:05:43.578018 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 30 05:05:43.578106 systemd[1]: Stopped dracut pre-trigger hook. Oct 30 05:05:43.579399 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 30 05:05:43.584782 systemd[1]: iscsid.service: Deactivated successfully. Oct 30 05:05:43.584910 systemd[1]: Stopped Open-iSCSI. Oct 30 05:05:43.586653 systemd[1]: iscsid.socket: Deactivated successfully. Oct 30 05:05:43.586714 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 30 05:05:43.588426 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 30 05:05:43.590904 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 30 05:05:43.591022 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 30 05:05:43.592802 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 30 05:05:43.592913 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 30 05:05:43.594161 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 30 05:05:43.594269 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 30 05:05:43.596305 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 30 05:05:43.596353 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 30 05:05:43.597212 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 30 05:05:43.597250 systemd[1]: Closed udev Control Socket. Oct 30 05:05:43.612000 audit: BPF prog-id=12 op=UNLOAD Oct 30 05:05:43.598624 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 30 05:05:43.598655 systemd[1]: Closed udev Kernel Socket. Oct 30 05:05:43.600093 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 30 05:05:43.600134 systemd[1]: Stopped dracut pre-udev hook. Oct 30 05:05:43.601659 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 30 05:05:43.601699 systemd[1]: Stopped dracut cmdline hook. Oct 30 05:05:43.603122 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 30 05:05:43.603163 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 30 05:05:43.605351 systemd[1]: Starting Cleanup udev Database... Oct 30 05:05:43.606311 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 30 05:05:43.623000 audit: BPF prog-id=9 op=UNLOAD Oct 30 05:05:43.607785 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 30 05:05:43.607843 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 30 05:05:43.609439 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 30 05:05:43.609494 systemd[1]: Stopped Create List of Static Device Nodes. Oct 30 05:05:43.610904 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 30 05:05:43.610948 systemd[1]: Stopped Setup Virtual Console. Oct 30 05:05:43.612814 systemd[1]: rngd.service: Deactivated successfully. Oct 30 05:05:43.612940 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 30 05:05:43.614244 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 30 05:05:43.614349 systemd[1]: Finished Cleanup udev Database. Oct 30 05:05:43.615745 systemd[1]: Reached target Switch Root. Oct 30 05:05:43.617478 systemd[1]: Starting Switch Root... Oct 30 05:05:43.623012 systemd[1]: Switching root. Oct 30 05:05:43.638055 systemd-journald[270]: Journal stopped Oct 30 05:05:45.661197 systemd-journald[270]: Received SIGTERM from PID 1 (systemd). Oct 30 05:05:45.661253 kernel: SELinux: policy capability network_peer_controls=1 Oct 30 05:05:45.661265 kernel: SELinux: policy capability open_perms=1 Oct 30 05:05:45.661275 kernel: SELinux: policy capability extended_socket_class=1 Oct 30 05:05:45.661289 kernel: SELinux: policy capability always_check_network=0 Oct 30 05:05:45.661299 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 30 05:05:45.661308 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 30 05:05:45.661317 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 30 05:05:45.661326 systemd[1]: Successfully loaded SELinux policy in 32.972ms. Oct 30 05:05:45.661342 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.254ms. Oct 30 05:05:45.661353 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 30 05:05:45.661363 systemd[1]: Detected virtualization kvm. Oct 30 05:05:45.661372 systemd[1]: Detected architecture arm64. Oct 30 05:05:45.661383 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 30 05:05:45.661393 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 30 05:05:45.661403 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 30 05:05:45.661413 systemd[1]: Stopped Switch Root. Oct 30 05:05:45.661424 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 30 05:05:45.661433 systemd[1]: Created slice Slice /system/addon-config. Oct 30 05:05:45.661443 systemd[1]: Created slice Slice /system/addon-run. Oct 30 05:05:45.661460 systemd[1]: Created slice Slice /system/getty. Oct 30 05:05:45.661475 systemd[1]: Created slice Slice /system/modprobe. Oct 30 05:05:45.661488 systemd[1]: Created slice Slice /system/serial-getty. Oct 30 05:05:45.661500 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 30 05:05:45.661510 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 30 05:05:45.661522 systemd[1]: Created slice User and Session Slice. Oct 30 05:05:45.661534 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 30 05:05:45.661546 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 30 05:05:45.661556 systemd[1]: Set up automount Boot partition Automount Point. Oct 30 05:05:45.661567 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 30 05:05:45.661585 systemd[1]: Stopped target Switch Root. Oct 30 05:05:45.661599 systemd[1]: Stopped target Initrd File Systems. Oct 30 05:05:45.661610 systemd[1]: Stopped target Initrd Root File System. Oct 30 05:05:45.661620 systemd[1]: Reached target Remote Encrypted Volumes. Oct 30 05:05:45.661630 systemd[1]: Reached target Remote File Systems. Oct 30 05:05:45.661640 systemd[1]: Reached target Slice Units. Oct 30 05:05:45.661651 systemd[1]: Reached target Swaps. Oct 30 05:05:45.661660 systemd[1]: Reached target Verify torcx succeeded. Oct 30 05:05:45.661670 systemd[1]: Reached target Local Verity Protected Volumes. Oct 30 05:05:45.661679 systemd[1]: Listening on Process Core Dump Socket. Oct 30 05:05:45.661689 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 30 05:05:45.661699 systemd[1]: Listening on Network Service Netlink Socket. Oct 30 05:05:45.661709 systemd[1]: Listening on udev Control Socket. Oct 30 05:05:45.661718 systemd[1]: Listening on udev Kernel Socket. Oct 30 05:05:45.661728 systemd[1]: Mounting Huge Pages File System... Oct 30 05:05:45.661739 systemd[1]: Mounting POSIX Message Queue File System... Oct 30 05:05:45.661751 systemd[1]: Mounting External Media Directory... Oct 30 05:05:45.661760 systemd[1]: Mounting Kernel Debug File System... Oct 30 05:05:45.661770 systemd[1]: Mounting Kernel Trace File System... Oct 30 05:05:45.661780 systemd[1]: Mounting Temporary Directory /tmp... Oct 30 05:05:45.661790 systemd[1]: Starting Create missing system files... Oct 30 05:05:45.661800 systemd[1]: Starting Create List of Static Device Nodes... Oct 30 05:05:45.661810 systemd[1]: Starting Load Kernel Module configfs... Oct 30 05:05:45.661820 systemd[1]: Starting Load Kernel Module drm... Oct 30 05:05:45.661829 systemd[1]: Starting Load Kernel Module fuse... Oct 30 05:05:45.661841 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 30 05:05:45.661851 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 30 05:05:45.661868 systemd[1]: Stopped File System Check on Root Device. Oct 30 05:05:45.661899 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 30 05:05:45.661909 systemd[1]: Stopped systemd-fsck-usr.service. Oct 30 05:05:45.661920 kernel: fuse: init (API version 7.32) Oct 30 05:05:45.661929 systemd[1]: Stopped Journal Service. Oct 30 05:05:45.661939 systemd[1]: Starting Journal Service... Oct 30 05:05:45.661949 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 30 05:05:45.661960 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 30 05:05:45.661970 systemd[1]: Starting Apply Kernel Variables... Oct 30 05:05:45.661981 systemd[1]: Starting Coldplug All udev Devices... Oct 30 05:05:45.662013 systemd[1]: verity-setup.service: Deactivated successfully. Oct 30 05:05:45.662029 systemd[1]: Stopped verity-setup.service. Oct 30 05:05:45.662040 systemd-journald[689]: Journal started Oct 30 05:05:45.662081 systemd-journald[689]: Runtime Journal (/run/log/journal/7562076a330c462bb5798545670cc149) is 6.0M, max 48.5M, 42.4M free. Oct 30 05:05:43.708000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 30 05:05:43.735000 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 30 05:05:43.735000 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 30 05:05:43.735000 audit: BPF prog-id=15 op=LOAD Oct 30 05:05:43.735000 audit: BPF prog-id=15 op=UNLOAD Oct 30 05:05:43.735000 audit: BPF prog-id=16 op=LOAD Oct 30 05:05:43.735000 audit: BPF prog-id=16 op=UNLOAD Oct 30 05:05:43.767000 audit[642]: AVC avc: denied { associate } for pid=642 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 30 05:05:45.548000 audit: BPF prog-id=17 op=LOAD Oct 30 05:05:45.549000 audit: BPF prog-id=18 op=LOAD Oct 30 05:05:45.549000 audit: BPF prog-id=19 op=LOAD Oct 30 05:05:45.549000 audit: BPF prog-id=10 op=UNLOAD Oct 30 05:05:45.549000 audit: BPF prog-id=11 op=UNLOAD Oct 30 05:05:45.562000 audit: BPF prog-id=17 op=UNLOAD Oct 30 05:05:45.646000 audit: BPF prog-id=20 op=LOAD Oct 30 05:05:45.646000 audit: BPF prog-id=21 op=LOAD Oct 30 05:05:45.646000 audit: BPF prog-id=22 op=LOAD Oct 30 05:05:45.646000 audit: BPF prog-id=18 op=UNLOAD Oct 30 05:05:45.646000 audit: BPF prog-id=19 op=UNLOAD Oct 30 05:05:45.659000 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 30 05:05:45.540248 systemd[1]: Queued start job for default target Multi-User System. Oct 30 05:05:43.765645 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" 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 30 05:05:45.550715 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 30 05:05:43.765941 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 30 05:05:43.765961 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 30 05:05:43.766269 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 30 05:05:43.766283 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 30 05:05:43.766318 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 30 05:05:43.766332 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 30 05:05:43.766729 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 30 05:05:43.766772 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 30 05:05:43.766788 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 30 05:05:43.767200 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" 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 30 05:05:43.767233 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" 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 30 05:05:43.767254 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" 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 30 05:05:43.767270 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 30 05:05:43.767387 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" 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 30 05:05:43.767406 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:43Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 30 05:05:45.455286 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:45Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 30 05:05:45.455561 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:45Z" 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 30 05:05:45.455663 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:45Z" 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 30 05:05:45.455783 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:45Z" 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 30 05:05:45.455892 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:45Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 30 05:05:45.455952 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-30T05:05:45Z" 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 30 05:05:45.663994 systemd[1]: Started Journal Service. Oct 30 05:05:45.664472 systemd[1]: Mounted Huge Pages File System. Oct 30 05:05:45.665378 systemd[1]: Mounted POSIX Message Queue File System. Oct 30 05:05:45.666395 systemd[1]: Mounted External Media Directory. Oct 30 05:05:45.667313 systemd[1]: Mounted Kernel Debug File System. Oct 30 05:05:45.668212 systemd[1]: Mounted Kernel Trace File System. Oct 30 05:05:45.669128 systemd[1]: Mounted Temporary Directory /tmp. Oct 30 05:05:45.670239 systemd[1]: Finished Create missing system files. Oct 30 05:05:45.671392 systemd[1]: Finished Create List of Static Device Nodes. Oct 30 05:05:45.672535 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 30 05:05:45.672709 systemd[1]: Finished Load Kernel Module configfs. Oct 30 05:05:45.673826 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 30 05:05:45.674022 systemd[1]: Finished Load Kernel Module drm. Oct 30 05:05:45.674996 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 30 05:05:45.675165 systemd[1]: Finished Load Kernel Module fuse. Oct 30 05:05:45.676242 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 30 05:05:45.677487 systemd[1]: Finished Apply Kernel Variables. Oct 30 05:05:45.687921 systemd[1]: Mounting FUSE Control File System... Oct 30 05:05:45.689637 systemd[1]: Mounting Kernel Configuration File System... Oct 30 05:05:45.690563 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 30 05:05:45.691554 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 30 05:05:45.692478 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 30 05:05:45.693546 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 30 05:05:45.694490 systemd[1]: Starting Load/Save Random Seed... Oct 30 05:05:45.697319 systemd-journald[689]: Time spent on flushing to /var/log/journal/7562076a330c462bb5798545670cc149 is 10.789ms for 654 entries. Oct 30 05:05:45.697319 systemd-journald[689]: System Journal (/var/log/journal/7562076a330c462bb5798545670cc149) is 8.0M, max 203.0M, 195.0M free. Oct 30 05:05:45.717000 audit: BPF prog-id=23 op=LOAD Oct 30 05:05:45.717000 audit: BPF prog-id=24 op=LOAD Oct 30 05:05:45.717000 audit: BPF prog-id=25 op=LOAD Oct 30 05:05:45.717000 audit: BPF prog-id=13 op=UNLOAD Oct 30 05:05:45.717000 audit: BPF prog-id=14 op=UNLOAD Oct 30 05:05:45.695384 systemd[1]: Condition check resulted in Create System Users being skipped. Oct 30 05:05:45.696321 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 30 05:05:45.698087 systemd[1]: Mounted FUSE Control File System. Oct 30 05:05:45.699790 systemd[1]: Mounted Kernel Configuration File System. Oct 30 05:05:45.702935 systemd[1]: Finished Load/Save Random Seed. Oct 30 05:05:45.704051 systemd[1]: Condition check resulted in First Boot Complete being skipped. Oct 30 05:05:45.706873 systemd[1]: Finished Coldplug All udev Devices. Oct 30 05:05:45.713758 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 30 05:05:45.716019 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 30 05:05:45.718764 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 30 05:05:45.722140 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 30 05:05:45.743385 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 30 05:05:45.744000 audit: BPF prog-id=26 op=LOAD Oct 30 05:05:45.747171 systemd[1]: Starting Network Configuration... Oct 30 05:05:45.773878 systemd-networkd[712]: lo: Link UP Oct 30 05:05:45.773885 systemd-networkd[712]: lo: Gained carrier Oct 30 05:05:45.774182 systemd-networkd[712]: Enumeration completed Oct 30 05:05:45.774266 systemd[1]: Started Network Configuration. Oct 30 05:05:45.776293 systemd-udevd[719]: Using default interface naming scheme 'v249'. Oct 30 05:05:45.798257 udevadm[702]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 30 05:05:45.805017 systemd-networkd[712]: eth0: Link UP Oct 30 05:05:45.808898 systemd-networkd[712]: eth0: Gained carrier Oct 30 05:05:45.812018 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 30 05:05:45.812962 systemd-networkd[712]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 30 05:05:45.820791 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 30 05:05:45.828917 lvm[730]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 30 05:05:45.852825 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 30 05:05:45.853927 systemd[1]: Reached target Local Encrypted Volumes. Oct 30 05:05:45.866817 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 30 05:05:45.870066 lvm[731]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 30 05:05:45.898809 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 30 05:05:45.899925 systemd[1]: Reached target Preparation for Local File Systems. Oct 30 05:05:45.900946 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 30 05:05:45.900970 systemd[1]: Reached target Containers. Oct 30 05:05:45.910086 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 30 05:05:45.921996 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 30 05:05:45.939723 systemd[1]: Mounting /usr/share/oem... Oct 30 05:05:45.945870 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 30 05:05:45.945920 kernel: BTRFS info (device vda6): has skinny extents Oct 30 05:05:45.947733 systemd[1]: Mounted /usr/share/oem. Oct 30 05:05:45.948617 systemd[1]: Reached target Local File Systems. Oct 30 05:05:45.949594 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Oct 30 05:05:45.949934 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 30 05:05:45.949971 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 30 05:05:45.949999 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 30 05:05:45.950915 systemd[1]: Starting Create Volatile Files and Directories... Oct 30 05:05:45.956728 systemd-tmpfiles[754]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 30 05:05:45.957756 systemd-tmpfiles[754]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 30 05:05:45.988131 systemd-tmpfiles[754]: Detected autofs mount point /boot during canonicalization of /boot. Oct 30 05:05:45.988142 systemd-tmpfiles[754]: Skipping /boot Oct 30 05:05:45.993814 systemd-tmpfiles[754]: Detected autofs mount point /boot during canonicalization of /boot. Oct 30 05:05:45.993829 systemd-tmpfiles[754]: Skipping /boot Oct 30 05:05:46.021849 systemd[1]: Finished Create Volatile Files and Directories. Oct 30 05:05:46.030779 systemd[1]: Starting Load Security Auditing Rules... Oct 30 05:05:46.032625 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 30 05:05:46.033766 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Oct 30 05:05:46.033000 audit: BPF prog-id=27 op=LOAD Oct 30 05:05:46.035197 systemd[1]: Starting Network Name Resolution... Oct 30 05:05:46.035000 audit: BPF prog-id=28 op=LOAD Oct 30 05:05:46.037334 systemd[1]: Starting Network Time Synchronization... Oct 30 05:05:46.039425 systemd[1]: Condition check resulted in Update is Completed being skipped. Oct 30 05:05:46.040403 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 30 05:05:46.041893 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 30 05:05:46.043202 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 30 05:05:46.049231 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 30 05:05:46.055000 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 30 05:05:46.056246 augenrules[776]: No rules Oct 30 05:05:46.057064 systemd[1]: Finished Load Security Auditing Rules. Oct 30 05:05:46.072972 systemd-resolved[758]: Positive Trust Anchors: Oct 30 05:05:46.072983 systemd-resolved[758]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 30 05:05:46.073012 systemd-resolved[758]: 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 30 05:05:46.073749 systemd-resolved[758]: Defaulting to hostname 'linux'. Oct 30 05:05:44.653987 systemd-timesyncd[765]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 30 05:05:44.654349 systemd-resolved[758]: Clock change detected. Flushing caches. Oct 30 05:05:44.658029 systemd[1]: Started Network Time Synchronization. Oct 30 05:05:44.659195 systemd[1]: Started Network Name Resolution. Oct 30 05:05:44.660215 systemd[1]: Reached target Network. Oct 30 05:05:44.660994 systemd[1]: Reached target Host and Network Name Lookups. Oct 30 05:05:44.662037 systemd[1]: Reached target System Initialization. Oct 30 05:05:44.663066 systemd[1]: Started Watch for update engine configuration changes. Oct 30 05:05:44.664288 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 30 05:05:44.665504 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 30 05:05:44.668013 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 30 05:05:44.668041 systemd[1]: Reached target Path Units. Oct 30 05:05:44.668902 systemd[1]: Reached target System Time Set. Oct 30 05:05:44.671705 systemd[1]: Started Daily Log Rotation. Oct 30 05:05:44.672674 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 30 05:05:44.673874 systemd[1]: Reached target Timer Units. Oct 30 05:05:44.675032 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 30 05:05:44.683463 systemd[1]: Starting Docker Socket for the API... Oct 30 05:05:44.686597 systemd[1]: Listening on OpenSSH Server Socket. Oct 30 05:05:44.687891 systemd[1]: Listening on Docker Socket for the API. Oct 30 05:05:44.688781 systemd[1]: Reached target Socket Units. Oct 30 05:05:44.689611 systemd[1]: Reached target Basic System. Oct 30 05:05:44.690444 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 30 05:05:44.690484 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 30 05:05:44.691370 systemd[1]: Started D-Bus System Message Bus. Oct 30 05:05:44.694716 systemd[1]: Starting Extend Filesystems... Oct 30 05:05:44.695579 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 30 05:05:44.696595 systemd[1]: Starting Generate /run/flatcar/motd... Oct 30 05:05:44.698450 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 30 05:05:44.700939 systemd[1]: Starting Generate sshd host keys... Oct 30 05:05:44.701930 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 30 05:05:44.701963 systemd[1]: Reached target Load system-provided cloud configs. Oct 30 05:05:44.705124 systemd[1]: Starting User Login Management... Oct 30 05:05:44.706435 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 30 05:05:44.707026 systemd[1]: Starting Update Engine... Oct 30 05:05:44.708236 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 30 05:05:44.708269 systemd[1]: Reached target Load user-provided cloud configs. Oct 30 05:05:44.708510 extend-filesystems[786]: Found vda Oct 30 05:05:44.710195 extend-filesystems[786]: Found vda1 Oct 30 05:05:44.710756 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 30 05:05:44.711100 extend-filesystems[786]: Found vda2 Oct 30 05:05:44.711391 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 30 05:05:44.712007 extend-filesystems[786]: Found vda3 Oct 30 05:05:44.714019 extend-filesystems[786]: Found usr Oct 30 05:05:44.714019 extend-filesystems[786]: Found vda4 Oct 30 05:05:44.714019 extend-filesystems[786]: Found vda6 Oct 30 05:05:44.714019 extend-filesystems[786]: Found vda7 Oct 30 05:05:44.714019 extend-filesystems[786]: Found vda9 Oct 30 05:05:44.714019 extend-filesystems[786]: Checking size of /dev/vda9 Oct 30 05:05:44.722161 systemd[1]: motdgen.service: Deactivated successfully. Oct 30 05:05:44.722381 systemd[1]: Finished Generate /run/flatcar/motd. Oct 30 05:05:44.730789 extend-filesystems[786]: Old size kept for /dev/vda9 Oct 30 05:05:44.734226 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 30 05:05:44.734520 systemd[1]: Finished Extend Filesystems. Oct 30 05:05:44.741036 systemd-logind[797]: Watching system buttons on /dev/input/event0 (Power Button) Oct 30 05:05:44.741543 systemd-logind[797]: New seat seat0. Oct 30 05:05:44.749110 systemd[1]: Started User Login Management. Oct 30 05:05:44.757745 update_engine[801]: I1030 05:05:44.756524 801 main.cc:89] Flatcar Update Engine starting Oct 30 05:05:44.757745 update_engine[801]: I1030 05:05:44.757350 801 payload_state.cc:360] Current Response Signature = Oct 30 05:05:44.757745 update_engine[801]: NumURLs = 1 Oct 30 05:05:44.757745 update_engine[801]: Url0 = http://10.0.0.5:34567/packages/update.gz Oct 30 05:05:44.757745 update_engine[801]: Payload Size = 439617737 Oct 30 05:05:44.757745 update_engine[801]: Payload Sha256 Hash = hKuDazTd3yRvZZ+1GzVZ5iDGEt/oXMhd+zKPhlhnEaA= Oct 30 05:05:44.757745 update_engine[801]: Is Delta Payload = 0 Oct 30 05:05:44.757745 update_engine[801]: Max Failure Count Per Url = 10 Oct 30 05:05:44.757745 update_engine[801]: Disable Payload Backoff = 1 Oct 30 05:05:44.757745 update_engine[801]: I1030 05:05:44.757550 801 payload_state.cc:381] Payload Attempt Number = 0 Oct 30 05:05:44.757745 update_engine[801]: I1030 05:05:44.757699 801 payload_state.cc:404] Current URL Index = 0 Oct 30 05:05:44.758103 update_engine[801]: I1030 05:05:44.757829 801 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 30 05:05:44.758103 update_engine[801]: I1030 05:05:44.757987 801 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 30 05:05:44.761006 systemd[1]: Started Update Engine. Oct 30 05:05:44.761914 update_engine[801]: I1030 05:05:44.761881 801 update_check_scheduler.cc:74] Next update check in 6m14s Oct 30 05:05:44.764819 systemd[1]: Finished Generate sshd host keys. Oct 30 05:05:44.784972 systemd[1]: Starting Generate /run/issue... Oct 30 05:05:44.789303 systemd[1]: issuegen.service: Deactivated successfully. Oct 30 05:05:44.789538 systemd[1]: Finished Generate /run/issue. Oct 30 05:05:44.791633 systemd[1]: Starting Permit User Sessions... Oct 30 05:05:44.796458 systemd[1]: Finished Permit User Sessions. Oct 30 05:05:44.798564 systemd[1]: Started Getty on tty1. Oct 30 05:05:44.800397 systemd[1]: Started Serial Getty on ttyAMA0. Oct 30 05:05:44.801387 systemd[1]: Reached target Login Prompts. Oct 30 05:05:44.802359 systemd[1]: Reached target Multi-User System. Oct 30 05:05:44.804217 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 30 05:05:44.809085 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 30 05:05:44.809293 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 30 05:05:44.810301 systemd[1]: Startup finished in 693ms (kernel) + 1.114s (initrd) + 2.557s (userspace) = 4.365s. Oct 30 05:05:45.660028 systemd-networkd[712]: eth0: Gained IPv6LL Oct 30 05:05:54.571781 systemd[1]: Created slice Slice /system/sshd. Oct 30 05:05:54.572799 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34738). Oct 30 05:05:54.607272 sshd[827]: Accepted publickey for core from 10.0.0.1 port 34738 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:54.609154 sshd[827]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:54.627302 systemd[1]: Created slice User Slice of UID 500. Oct 30 05:05:54.628236 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 30 05:05:54.629819 systemd-logind[797]: New session 1 of user core. Oct 30 05:05:54.634002 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 30 05:05:54.635208 systemd[1]: Starting User Manager for UID 500... Oct 30 05:05:54.637188 systemd[830]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:54.682093 systemd[830]: Queued start job for default target Main User Target. Oct 30 05:05:54.682231 systemd[830]: Reached target Paths. Oct 30 05:05:54.682244 systemd[830]: Reached target Sockets. Oct 30 05:05:54.682254 systemd[830]: Reached target Timers. Oct 30 05:05:54.682264 systemd[830]: Reached target Basic System. Oct 30 05:05:54.682301 systemd[830]: Reached target Main User Target. Oct 30 05:05:54.682313 systemd[830]: Startup finished in 41ms. Oct 30 05:05:54.682380 systemd[1]: Started User Manager for UID 500. Oct 30 05:05:54.689003 systemd[1]: Started Session 1 of User core. Oct 30 05:05:54.748733 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34744). Oct 30 05:05:54.779557 sshd[839]: Accepted publickey for core from 10.0.0.1 port 34744 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:54.780451 sshd[839]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:54.783009 systemd-logind[797]: New session 2 of user core. Oct 30 05:05:54.792004 systemd[1]: Started Session 2 of User core. Oct 30 05:05:54.843182 sshd[839]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:54.851316 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:34744.service: Deactivated successfully. Oct 30 05:05:54.851955 systemd[1]: session-2.scope: Deactivated successfully. Oct 30 05:05:54.852550 systemd-logind[797]: Session 2 logged out. Waiting for processes to exit. Oct 30 05:05:54.853511 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34752). Oct 30 05:05:54.854329 systemd-logind[797]: Removed session 2. Oct 30 05:05:54.884105 sshd[845]: Accepted publickey for core from 10.0.0.1 port 34752 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:54.885037 sshd[845]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:54.887342 systemd-logind[797]: New session 3 of user core. Oct 30 05:05:54.896001 systemd[1]: Started Session 3 of User core. Oct 30 05:05:54.944342 sshd[845]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:54.956280 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:34752.service: Deactivated successfully. Oct 30 05:05:54.956893 systemd[1]: session-3.scope: Deactivated successfully. Oct 30 05:05:54.957522 systemd-logind[797]: Session 3 logged out. Waiting for processes to exit. Oct 30 05:05:54.958445 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34760). Oct 30 05:05:54.959098 systemd-logind[797]: Removed session 3. Oct 30 05:05:54.989190 sshd[851]: Accepted publickey for core from 10.0.0.1 port 34760 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:54.990045 sshd[851]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:54.992577 systemd-logind[797]: New session 4 of user core. Oct 30 05:05:55.002011 systemd[1]: Started Session 4 of User core. Oct 30 05:05:55.052962 sshd[851]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:55.060747 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:34760.service: Deactivated successfully. Oct 30 05:05:55.061324 systemd[1]: session-4.scope: Deactivated successfully. Oct 30 05:05:55.061928 systemd-logind[797]: Session 4 logged out. Waiting for processes to exit. Oct 30 05:05:55.062825 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34766). Oct 30 05:05:55.063495 systemd-logind[797]: Removed session 4. Oct 30 05:05:55.094286 sshd[857]: Accepted publickey for core from 10.0.0.1 port 34766 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:55.094792 sshd[857]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:55.097247 systemd-logind[797]: New session 5 of user core. Oct 30 05:05:55.106001 systemd[1]: Started Session 5 of User core. Oct 30 05:05:55.162016 sudo[860]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 30 05:05:55.162212 sudo[860]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:05:55.170346 sudo[860]: pam_unix(sudo:session): session closed for user root Oct 30 05:05:55.172010 sshd[857]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:55.180291 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34778). Oct 30 05:05:55.182554 dbus-daemon[785]: [system] Reloaded configuration Oct 30 05:05:55.185002 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:34766.service: Deactivated successfully. Oct 30 05:05:55.185735 systemd[1]: session-5.scope: Deactivated successfully. Oct 30 05:05:55.186393 systemd-logind[797]: Session 5 logged out. Waiting for processes to exit. Oct 30 05:05:55.187152 systemd-logind[797]: Removed session 5. Oct 30 05:05:55.211127 sshd[863]: Accepted publickey for core from 10.0.0.1 port 34778 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:55.212225 sshd[863]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:55.214557 systemd-logind[797]: New session 6 of user core. Oct 30 05:05:55.231996 systemd[1]: Started Session 6 of User core. Oct 30 05:05:55.282459 sudo[868]: 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 30 05:05:55.282659 sudo[868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:05:55.284718 sudo[868]: pam_unix(sudo:session): session closed for user root Oct 30 05:05:55.288144 sudo[867]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 30 05:05:55.288339 sudo[867]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 30 05:05:55.299687 systemd[1]: Stopping Load Security Auditing Rules... Oct 30 05:05:55.298000 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 30 05:05:55.301065 auditctl[871]: No rules Oct 30 05:05:55.301443 systemd[1]: audit-rules.service: Deactivated successfully. Oct 30 05:05:55.301528 kernel: kauditd_printk_skb: 37 callbacks suppressed Oct 30 05:05:55.301551 kernel: audit: type=1305 audit(1761800755.298:48): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 30 05:05:55.301656 systemd[1]: Stopped Load Security Auditing Rules. Oct 30 05:05:55.302930 systemd[1]: Starting Load Security Auditing Rules... Oct 30 05:05:55.317190 augenrules[888]: No rules Oct 30 05:05:55.317839 systemd[1]: Finished Load Security Auditing Rules. Oct 30 05:05:55.318971 sudo[867]: pam_unix(sudo:session): session closed for user root Oct 30 05:05:55.320064 sshd[863]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:55.323147 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:34778.service: Deactivated successfully. Oct 30 05:05:55.323714 systemd[1]: session-6.scope: Deactivated successfully. Oct 30 05:05:55.324257 systemd-logind[797]: Session 6 logged out. Waiting for processes to exit. Oct 30 05:05:55.325237 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34780). Oct 30 05:05:55.325937 systemd-logind[797]: Removed session 6. Oct 30 05:05:55.355960 sshd[894]: Accepted publickey for core from 10.0.0.1 port 34780 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:55.358194 sshd[894]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:55.359898 kernel: audit: type=1006 audit(1761800755.355:49): pid=894 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 30 05:05:55.360579 systemd-logind[797]: New session 7 of user core. Oct 30 05:05:55.369999 systemd[1]: Started Session 7 of User core. Oct 30 05:05:55.417545 sshd[894]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:55.426374 systemd[1]: sshd@6-10.0.0.6:22-10.0.0.1:34780.service: Deactivated successfully. Oct 30 05:05:55.427021 systemd[1]: session-7.scope: Deactivated successfully. Oct 30 05:05:55.427603 systemd-logind[797]: Session 7 logged out. Waiting for processes to exit. Oct 30 05:05:55.428776 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34792). Oct 30 05:05:55.429535 systemd-logind[797]: Removed session 7. Oct 30 05:05:55.459577 sshd[900]: Accepted publickey for core from 10.0.0.1 port 34792 ssh2: RSA SHA256:hG7Ot4xBXBmnU2RPiaTNDuXp1/4ENKSH998eqEB2kuw Oct 30 05:05:55.460529 sshd[900]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 30 05:05:55.462894 kernel: audit: type=1006 audit(1761800755.458:50): pid=900 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 30 05:05:55.463184 systemd-logind[797]: New session 8 of user core. Oct 30 05:05:55.472081 systemd[1]: Started Session 8 of User core. Oct 30 05:05:55.520837 sshd[900]: pam_unix(sshd:session): session closed for user core Oct 30 05:05:55.522849 systemd[1]: sshd@7-10.0.0.6:22-10.0.0.1:34792.service: Deactivated successfully. Oct 30 05:05:55.523483 systemd[1]: session-8.scope: Deactivated successfully. Oct 30 05:05:55.524001 systemd-logind[797]: Session 8 logged out. Waiting for processes to exit. Oct 30 05:05:55.524592 systemd-logind[797]: Removed session 8.