Oct 13 04:53:56.674980 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 13 04:53:56.674999 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 13 04:53:56.675007 kernel: efi: EFI v2.70 by EDK II Oct 13 04:53:56.675013 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 13 04:53:56.675018 kernel: efi: seeding entropy pool Oct 13 04:53:56.675023 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 13 04:53:56.675029 kernel: ACPI: Early table checksum verification disabled Oct 13 04:53:56.675034 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 13 04:53:56.675039 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 13 04:53:56.675045 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:53:56.675051 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:53:56.675056 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:53:56.675061 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:53:56.675066 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:53:56.675072 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:53:56.675078 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:53:56.675084 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:53:56.675090 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:53:56.675095 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 13 04:53:56.675101 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 13 04:53:56.675106 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 13 04:53:56.675111 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 13 04:53:56.675116 kernel: Zone ranges: Oct 13 04:53:56.675122 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 13 04:53:56.675127 kernel: DMA32 empty Oct 13 04:53:56.675132 kernel: Normal empty Oct 13 04:53:56.675137 kernel: Movable zone start for each node Oct 13 04:53:56.675143 kernel: Early memory node ranges Oct 13 04:53:56.675148 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 13 04:53:56.675153 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 13 04:53:56.675158 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 13 04:53:56.675164 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 13 04:53:56.675169 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 13 04:53:56.675174 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 13 04:53:56.675179 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 13 04:53:56.675184 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 13 04:53:56.675189 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 13 04:53:56.675194 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 13 04:53:56.675200 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 13 04:53:56.675205 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 13 04:53:56.675213 kernel: On node 0 totalpages: 643072 Oct 13 04:53:56.675219 kernel: DMA zone: 10048 pages used for memmap Oct 13 04:53:56.675225 kernel: DMA zone: 0 pages reserved Oct 13 04:53:56.675230 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 13 04:53:56.675235 kernel: psci: probing for conduit method from ACPI. Oct 13 04:53:56.675241 kernel: psci: PSCIv1.1 detected in firmware. Oct 13 04:53:56.675247 kernel: psci: Using standard PSCI v0.2 function IDs Oct 13 04:53:56.675252 kernel: psci: Trusted OS migration not required Oct 13 04:53:56.675259 kernel: psci: SMC Calling Convention v1.1 Oct 13 04:53:56.675264 kernel: ACPI: SRAT not present Oct 13 04:53:56.675270 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 13 04:53:56.675275 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 13 04:53:56.675281 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 13 04:53:56.675286 kernel: Detected PIPT I-cache on CPU0 Oct 13 04:53:56.675292 kernel: CPU features: detected: GIC system register CPU interface Oct 13 04:53:56.675297 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 13 04:53:56.675303 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 13 04:53:56.675309 kernel: CPU features: detected: Hardware dirty bit management Oct 13 04:53:56.675314 kernel: CPU features: detected: Spectre-v4 Oct 13 04:53:56.675321 kernel: CPU features: detected: ARM erratum 1418040 Oct 13 04:53:56.675326 kernel: CPU features: detected: Spectre-BHB Oct 13 04:53:56.675332 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 13 04:53:56.675337 kernel: Policy zone: DMA Oct 13 04:53:56.675344 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 13 04:53:56.675350 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 13 04:53:56.675356 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 13 04:53:56.675361 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 13 04:53:56.675367 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 13 04:53:56.675373 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 13 04:53:56.675378 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 13 04:53:56.675385 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 13 04:53:56.675392 kernel: rcu: RCU event tracing is enabled. Oct 13 04:53:56.675397 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 13 04:53:56.675403 kernel: Trampoline variant of Tasks RCU enabled. Oct 13 04:53:56.675409 kernel: Tracing variant of Tasks RCU enabled. Oct 13 04:53:56.675415 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 13 04:53:56.675420 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 13 04:53:56.675426 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 13 04:53:56.675431 kernel: GICv3: 256 SPIs implemented Oct 13 04:53:56.675437 kernel: GICv3: 0 Extended SPIs implemented Oct 13 04:53:56.675442 kernel: GICv3: Distributor has no Range Selector support Oct 13 04:53:56.675448 kernel: GICv3: 16 PPIs implemented Oct 13 04:53:56.675455 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 13 04:53:56.675460 kernel: ACPI: SRAT not present Oct 13 04:53:56.675466 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 13 04:53:56.675471 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 13 04:53:56.675477 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 13 04:53:56.675483 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 13 04:53:56.675489 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 13 04:53:56.675494 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 04:53:56.675500 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 13 04:53:56.675506 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 13 04:53:56.675512 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 13 04:53:56.675518 kernel: arm-pv: using stolen time PV Oct 13 04:53:56.675525 kernel: Console: colour dummy device 80x25 Oct 13 04:53:56.675531 kernel: ACPI: Core revision 20200925 Oct 13 04:53:56.675573 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 13 04:53:56.675580 kernel: pid_max: default: 32768 minimum: 301 Oct 13 04:53:56.675586 kernel: LSM: Security Framework initializing Oct 13 04:53:56.675591 kernel: SELinux: Initializing. Oct 13 04:53:56.675597 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 13 04:53:56.675603 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 13 04:53:56.675620 kernel: rcu: Hierarchical SRCU implementation. Oct 13 04:53:56.675629 kernel: Platform MSI: ITS@0x8080000 domain created Oct 13 04:53:56.675634 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 13 04:53:56.675640 kernel: Remapping and enabling EFI services. Oct 13 04:53:56.675646 kernel: smp: Bringing up secondary CPUs ... Oct 13 04:53:56.675652 kernel: Detected PIPT I-cache on CPU1 Oct 13 04:53:56.675658 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 13 04:53:56.675664 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 13 04:53:56.675670 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 04:53:56.675676 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 13 04:53:56.675681 kernel: Detected PIPT I-cache on CPU2 Oct 13 04:53:56.675689 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 13 04:53:56.675695 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 13 04:53:56.675701 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 04:53:56.675706 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 13 04:53:56.675712 kernel: Detected PIPT I-cache on CPU3 Oct 13 04:53:56.675722 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 13 04:53:56.675728 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 13 04:53:56.675736 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 04:53:56.675742 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 13 04:53:56.675748 kernel: smp: Brought up 1 node, 4 CPUs Oct 13 04:53:56.675754 kernel: SMP: Total of 4 processors activated. Oct 13 04:53:56.675760 kernel: CPU features: detected: Privileged Access Never Oct 13 04:53:56.675766 kernel: CPU features: detected: LSE atomic instructions Oct 13 04:53:56.675772 kernel: CPU features: detected: User Access Override Oct 13 04:53:56.675778 kernel: CPU features: detected: 32-bit EL0 Support Oct 13 04:53:56.675784 kernel: CPU features: detected: Common not Private translations Oct 13 04:53:56.675790 kernel: CPU features: detected: RAS Extension Support Oct 13 04:53:56.675814 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 13 04:53:56.675822 kernel: CPU features: detected: CRC32 instructions Oct 13 04:53:56.675828 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 13 04:53:56.675835 kernel: CPU: All CPU(s) started at EL1 Oct 13 04:53:56.675841 kernel: alternatives: patching kernel code Oct 13 04:53:56.675849 kernel: devtmpfs: initialized Oct 13 04:53:56.675855 kernel: KASLR enabled Oct 13 04:53:56.675861 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 13 04:53:56.675867 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 13 04:53:56.675874 kernel: pinctrl core: initialized pinctrl subsystem Oct 13 04:53:56.675880 kernel: SMBIOS 3.0.0 present. Oct 13 04:53:56.675886 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 13 04:53:56.675892 kernel: NET: Registered protocol family 16 Oct 13 04:53:56.675898 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 13 04:53:56.675904 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 13 04:53:56.675911 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 13 04:53:56.675918 kernel: audit: initializing netlink subsys (disabled) Oct 13 04:53:56.675924 kernel: audit: type=2000 audit(0.032:1): state=initialized audit_enabled=0 res=1 Oct 13 04:53:56.675930 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 13 04:53:56.675936 kernel: cpuidle: using governor menu Oct 13 04:53:56.675942 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 13 04:53:56.675948 kernel: ASID allocator initialised with 32768 entries Oct 13 04:53:56.675954 kernel: ACPI: bus type PCI registered Oct 13 04:53:56.675960 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 13 04:53:56.675968 kernel: Serial: AMBA PL011 UART driver Oct 13 04:53:56.675974 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 13 04:53:56.675980 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 13 04:53:56.675986 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 13 04:53:56.675992 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 13 04:53:56.675998 kernel: cryptd: max_cpu_qlen set to 1000 Oct 13 04:53:56.676005 kernel: ACPI: Added _OSI(Module Device) Oct 13 04:53:56.676011 kernel: ACPI: Added _OSI(Processor Device) Oct 13 04:53:56.676017 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 13 04:53:56.676025 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 13 04:53:56.676031 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 13 04:53:56.676037 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 13 04:53:56.676043 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 13 04:53:56.676050 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 13 04:53:56.676056 kernel: ACPI: Interpreter enabled Oct 13 04:53:56.676062 kernel: ACPI: Using GIC for interrupt routing Oct 13 04:53:56.676068 kernel: ACPI: MCFG table detected, 1 entries Oct 13 04:53:56.676074 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 13 04:53:56.676080 kernel: printk: console [ttyAMA0] enabled Oct 13 04:53:56.676088 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 13 04:53:56.676219 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 13 04:53:56.676279 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 13 04:53:56.676333 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 13 04:53:56.676387 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 13 04:53:56.676447 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 13 04:53:56.676455 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 13 04:53:56.676464 kernel: PCI host bridge to bus 0000:00 Oct 13 04:53:56.676529 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 13 04:53:56.676595 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 13 04:53:56.676644 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 13 04:53:56.676692 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 13 04:53:56.676758 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 13 04:53:56.676858 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 13 04:53:56.676922 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 13 04:53:56.676979 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 13 04:53:56.677036 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 13 04:53:56.677092 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 13 04:53:56.677147 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 13 04:53:56.677203 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 13 04:53:56.677252 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 13 04:53:56.677303 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 13 04:53:56.677352 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 13 04:53:56.677360 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 13 04:53:56.677366 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 13 04:53:56.677372 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 13 04:53:56.677379 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 13 04:53:56.677385 kernel: vgaarb: loaded Oct 13 04:53:56.677391 kernel: Registered efivars operations Oct 13 04:53:56.677397 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 13 04:53:56.677405 kernel: VFS: Disk quotas dquot_6.6.0 Oct 13 04:53:56.677411 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 13 04:53:56.677417 kernel: pnp: PnP ACPI init Oct 13 04:53:56.677477 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 13 04:53:56.677527 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 13 04:53:56.677543 kernel: pnp: PnP ACPI: found 1 devices Oct 13 04:53:56.677550 kernel: NET: Registered protocol family 2 Oct 13 04:53:56.677557 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 13 04:53:56.677566 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 13 04:53:56.677573 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 13 04:53:56.677579 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 13 04:53:56.677585 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 13 04:53:56.677592 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 13 04:53:56.677598 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 13 04:53:56.677604 kernel: NET: Registered protocol family 1 Oct 13 04:53:56.677610 kernel: PCI: CLS 0 bytes, default 64 Oct 13 04:53:56.677617 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 13 04:53:56.677624 kernel: kvm [1]: HYP mode not available Oct 13 04:53:56.677631 kernel: Initialise system trusted keyrings Oct 13 04:53:56.677637 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 13 04:53:56.677643 kernel: Key type asymmetric registered Oct 13 04:53:56.677650 kernel: Asymmetric key parser 'x509' registered Oct 13 04:53:56.677656 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 13 04:53:56.677662 kernel: io scheduler mq-deadline registered Oct 13 04:53:56.677668 kernel: io scheduler kyber registered Oct 13 04:53:56.677674 kernel: io scheduler bfq registered Oct 13 04:53:56.677682 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 13 04:53:56.677689 kernel: ACPI: Power Button [PWRB] Oct 13 04:53:56.677695 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 13 04:53:56.677758 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 13 04:53:56.677766 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 13 04:53:56.677772 kernel: msm_serial: driver initialized Oct 13 04:53:56.677779 kernel: random: fast init done Oct 13 04:53:56.677785 kernel: random: crng init done Oct 13 04:53:56.677791 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 13 04:53:56.677805 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 13 04:53:56.677816 kernel: thunder_xcv, ver 1.0 Oct 13 04:53:56.677833 kernel: thunder_bgx, ver 1.0 Oct 13 04:53:56.677840 kernel: nicpf, ver 1.0 Oct 13 04:53:56.677846 kernel: nicvf, ver 1.0 Oct 13 04:53:56.677921 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 13 04:53:56.677976 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-13T04:53:56 UTC (1760331236) Oct 13 04:53:56.677984 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 13 04:53:56.677991 kernel: NET: Registered protocol family 10 Oct 13 04:53:56.677999 kernel: Segment Routing with IPv6 Oct 13 04:53:56.678005 kernel: NET: Registered protocol family 17 Oct 13 04:53:56.678012 kernel: Key type dns_resolver registered Oct 13 04:53:56.678018 kernel: registered taskstats version 1 Oct 13 04:53:56.678024 kernel: Loading compiled-in X.509 certificates Oct 13 04:53:56.678031 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 13 04:53:56.678038 kernel: Key type ._fscrypt registered Oct 13 04:53:56.678044 kernel: Key type .fscrypt registered Oct 13 04:53:56.678050 kernel: Key type fscrypt-provisioning registered Oct 13 04:53:56.678057 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 13 04:53:56.678063 kernel: ima: Allocated hash algorithm: sha1 Oct 13 04:53:56.678070 kernel: ima: No architecture policies found Oct 13 04:53:56.678076 kernel: Freeing unused kernel memory: 34240K Oct 13 04:53:56.678082 kernel: Run /init as init process Oct 13 04:53:56.678089 kernel: with arguments: Oct 13 04:53:56.678095 kernel: /init Oct 13 04:53:56.678101 kernel: with environment: Oct 13 04:53:56.678106 kernel: HOME=/ Oct 13 04:53:56.678113 kernel: TERM=linux Oct 13 04:53:56.678121 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 13 04:53:56.678129 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 13 04:53:56.678137 systemd[1]: Detected virtualization kvm. Oct 13 04:53:56.678144 systemd[1]: Detected architecture arm64. Oct 13 04:53:56.678150 systemd[1]: Running in initial RAM disk. Oct 13 04:53:56.678157 systemd[1]: No hostname configured, using default hostname. Oct 13 04:53:56.678163 systemd[1]: Hostname set to . Oct 13 04:53:56.678171 systemd[1]: Initializing machine ID from VM UUID. Oct 13 04:53:56.678178 systemd[1]: Queued start job for default target Initrd Default Target. Oct 13 04:53:56.678185 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 13 04:53:56.678192 systemd[1]: Reached target Local Encrypted Volumes. Oct 13 04:53:56.678199 systemd[1]: Reached target Path Units. Oct 13 04:53:56.678206 systemd[1]: Reached target Slice Units. Oct 13 04:53:56.678213 systemd[1]: Reached target Swaps. Oct 13 04:53:56.678220 systemd[1]: Reached target Timer Units. Oct 13 04:53:56.678228 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 13 04:53:56.678235 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 13 04:53:56.678242 systemd[1]: Listening on Journal Audit Socket. Oct 13 04:53:56.678249 systemd[1]: Listening on Journal Socket (/dev/log). Oct 13 04:53:56.678255 systemd[1]: Listening on Journal Socket. Oct 13 04:53:56.678262 systemd[1]: Listening on Network Service Netlink Socket. Oct 13 04:53:56.678269 systemd[1]: Listening on udev Control Socket. Oct 13 04:53:56.678276 systemd[1]: Listening on udev Kernel Socket. Oct 13 04:53:56.678282 systemd[1]: Reached target Socket Units. Oct 13 04:53:56.678291 systemd[1]: Starting Create List of Static Device Nodes... Oct 13 04:53:56.678298 systemd[1]: Finished Network Cleanup. Oct 13 04:53:56.678305 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 13 04:53:56.678312 systemd[1]: Starting Journal Service... Oct 13 04:53:56.678318 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 13 04:53:56.678325 systemd[1]: Starting Apply Kernel Variables... Oct 13 04:53:56.678332 systemd[1]: Starting Setup Virtual Console... Oct 13 04:53:56.678339 systemd[1]: Finished Create List of Static Device Nodes. Oct 13 04:53:56.678345 systemd[1]: Finished Apply Kernel Variables. Oct 13 04:53:56.678352 systemd[1]: Finished Setup Virtual Console. Oct 13 04:53:56.678360 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 13 04:53:56.678367 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 13 04:53:56.678377 systemd-journald[280]: Journal started Oct 13 04:53:56.678417 systemd-journald[280]: Runtime Journal (/run/log/journal/3510c0b04d2f41f4b7d3f4d99b43eec3) is 6.0M, max 48.5M, 42.4M free. Oct 13 04:53:56.680867 systemd[1]: Started Journal Service. Oct 13 04:53:56.681068 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 13 04:53:56.693171 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 13 04:53:56.694797 systemd[1]: Starting dracut cmdline hook... Oct 13 04:53:56.704107 dracut-cmdline[298]: dracut-dracut-053 Oct 13 04:53:56.706541 dracut-cmdline[298]: 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 13 04:53:56.768829 kernel: SCSI subsystem initialized Oct 13 04:53:56.772814 kernel: Loading iSCSI transport class v2.0-870. Oct 13 04:53:56.778844 kernel: iscsi: registered transport (tcp) Oct 13 04:53:56.790086 kernel: iscsi: registered transport (qla4xxx) Oct 13 04:53:56.790111 kernel: QLogic iSCSI HBA Driver Oct 13 04:53:56.800591 systemd[1]: Finished dracut cmdline hook. Oct 13 04:53:56.802024 systemd[1]: Starting dracut pre-udev hook... Oct 13 04:53:56.815561 kernel: device-mapper: uevent: version 1.0.3 Oct 13 04:53:56.815615 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 13 04:53:56.851823 kernel: raid6: neonx8 gen() 13727 MB/s Oct 13 04:53:56.868816 kernel: raid6: neonx8 xor() 10767 MB/s Oct 13 04:53:56.885815 kernel: raid6: neonx4 gen() 13596 MB/s Oct 13 04:53:56.902817 kernel: raid6: neonx4 xor() 11565 MB/s Oct 13 04:53:56.919834 kernel: raid6: neonx2 gen() 12984 MB/s Oct 13 04:53:56.936823 kernel: raid6: neonx2 xor() 9868 MB/s Oct 13 04:53:56.953818 kernel: raid6: neonx1 gen() 10954 MB/s Oct 13 04:53:56.970817 kernel: raid6: neonx1 xor() 8844 MB/s Oct 13 04:53:56.987841 kernel: raid6: int64x8 gen() 6836 MB/s Oct 13 04:53:57.004833 kernel: raid6: int64x8 xor() 3796 MB/s Oct 13 04:53:57.021838 kernel: raid6: int64x4 gen() 6919 MB/s Oct 13 04:53:57.038819 kernel: raid6: int64x4 xor() 3838 MB/s Oct 13 04:53:57.055822 kernel: raid6: int64x2 gen() 6187 MB/s Oct 13 04:53:57.072827 kernel: raid6: int64x2 xor() 3310 MB/s Oct 13 04:53:57.089828 kernel: raid6: int64x1 gen() 5017 MB/s Oct 13 04:53:57.107051 kernel: raid6: int64x1 xor() 2600 MB/s Oct 13 04:53:57.107091 kernel: raid6: using algorithm neonx8 gen() 13727 MB/s Oct 13 04:53:57.107101 kernel: raid6: .... xor() 10767 MB/s, rmw enabled Oct 13 04:53:57.107110 kernel: raid6: using neon recovery algorithm Oct 13 04:53:57.116822 kernel: xor: measuring software checksum speed Oct 13 04:53:57.117828 kernel: 8regs : 17192 MB/sec Oct 13 04:53:57.118816 kernel: 32regs : 20755 MB/sec Oct 13 04:53:57.119821 kernel: arm64_neon : 28967 MB/sec Oct 13 04:53:57.119834 kernel: xor: using function: arm64_neon (28967 MB/sec) Oct 13 04:53:57.164841 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 13 04:53:57.176686 systemd[1]: Finished dracut pre-udev hook. Oct 13 04:53:57.177000 audit: BPF prog-id=6 op=LOAD Oct 13 04:53:57.177000 audit: BPF prog-id=7 op=LOAD Oct 13 04:53:57.179173 kernel: audit: type=1334 audit(1760331237.177:2): prog-id=6 op=LOAD Oct 13 04:53:57.179195 kernel: audit: type=1334 audit(1760331237.177:3): prog-id=7 op=LOAD Oct 13 04:53:57.178000 audit: BPF prog-id=8 op=LOAD Oct 13 04:53:57.180134 kernel: audit: type=1334 audit(1760331237.178:4): prog-id=8 op=LOAD Oct 13 04:53:57.180271 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 13 04:53:57.191139 systemd-udevd[417]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 13 04:53:57.192830 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 13 04:53:57.194265 systemd[1]: Starting dracut pre-trigger hook... Oct 13 04:53:57.197896 kernel: audit: type=1334 audit(1760331237.194:5): prog-id=9 op=LOAD Oct 13 04:53:57.194000 audit: BPF prog-id=9 op=LOAD Oct 13 04:53:57.197091 systemd[1]: Starting Network Configuration... Oct 13 04:53:57.209513 dracut-pre-trigger[423]: rd.md=0: removing MD RAID activation Oct 13 04:53:57.215162 systemd-networkd[431]: lo: Link UP Oct 13 04:53:57.215168 systemd-networkd[431]: lo: Gained carrier Oct 13 04:53:57.215457 systemd-networkd[431]: Enumeration completed Oct 13 04:53:57.216838 systemd[1]: Started Network Configuration. Oct 13 04:53:57.217000 audit: BPF prog-id=10 op=LOAD Oct 13 04:53:57.220055 kernel: audit: type=1334 audit(1760331237.217:6): prog-id=10 op=LOAD Oct 13 04:53:57.218905 systemd[1]: Starting Network Name Resolution... Oct 13 04:53:57.236865 systemd[1]: Finished dracut pre-trigger hook. Oct 13 04:53:57.238247 systemd[1]: Starting Coldplug All udev Devices... Oct 13 04:53:57.248491 systemd-udevd[417]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 13 04:53:57.250470 systemd-resolved[444]: Positive Trust Anchors: Oct 13 04:53:57.251295 systemd-resolved[444]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 13 04:53:57.252357 systemd-resolved[444]: 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 13 04:53:57.256548 systemd-resolved[444]: Defaulting to hostname 'linux'. Oct 13 04:53:57.257981 systemd[1]: Started Network Name Resolution. Oct 13 04:53:57.258619 systemd[1]: Reached target Network. Oct 13 04:53:57.259623 systemd[1]: Reached target Host and Network Name Lookups. Oct 13 04:53:57.261678 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 13 04:53:57.267631 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 13 04:53:57.269029 systemd[1]: Starting Open-iSCSI... Oct 13 04:53:57.270894 systemd[1]: Finished Coldplug All udev Devices. Oct 13 04:53:57.271995 iscsid[485]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 13 04:53:57.271995 iscsid[485]: 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 13 04:53:57.271995 iscsid[485]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 13 04:53:57.271995 iscsid[485]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 13 04:53:57.271995 iscsid[485]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 13 04:53:57.271995 iscsid[485]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 13 04:53:57.275029 systemd[1]: Started Open-iSCSI. Oct 13 04:53:57.277664 systemd[1]: Starting dracut initqueue hook... Oct 13 04:53:57.305881 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 13 04:53:57.306016 kernel: vda: detected capacity change from 0 to 4756340736 Oct 13 04:53:57.318247 systemd-udevd[479]: Using default interface naming scheme 'v249'. Oct 13 04:53:57.319208 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 13 04:53:57.323316 systemd-networkd[431]: eth0: Link UP Oct 13 04:53:57.336831 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (476) Oct 13 04:53:57.336822 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Oct 13 04:53:57.343720 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 13 04:53:57.346203 systemd[1]: Found device /dev/disk/by-label/OEM. Oct 13 04:53:57.348456 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 13 04:53:57.349176 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 13 04:53:57.351243 systemd[1]: Finished dracut initqueue hook. Oct 13 04:53:57.353823 systemd[1]: Reached target Initrd Root Device. Oct 13 04:53:57.354882 systemd[1]: Reached target Preparation for Remote File Systems. Oct 13 04:53:57.355515 systemd[1]: Reached target Remote Encrypted Volumes. Oct 13 04:53:57.356654 systemd[1]: Reached target Remote File Systems. Oct 13 04:53:57.358359 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 13 04:53:57.360341 systemd[1]: Starting dracut pre-mount hook... Oct 13 04:53:57.367824 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 13 04:53:57.370258 systemd[1]: Finished dracut pre-mount hook. Oct 13 04:53:58.325626 systemd-networkd[431]: eth0: Gained carrier Oct 13 04:53:58.326582 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 13 04:53:58.335886 systemd-networkd[431]: eth0: DHCPv4 address 10.0.0.7/16 via 10.0.0.1 Oct 13 04:53:58.374818 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 13 04:53:58.374872 disk-uuid[505]: The operation has completed successfully. Oct 13 04:53:58.400837 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 13 04:53:58.400956 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 13 04:53:58.402369 systemd[1]: Starting Ignition (setup)... Oct 13 04:53:58.409810 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 13 04:53:58.409854 kernel: BTRFS info (device vda6): has skinny extents Oct 13 04:53:58.415156 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 13 04:53:58.419651 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 13 04:53:58.419758 systemd[1]: Finished Ignition (setup). Oct 13 04:53:58.421422 systemd[1]: Starting Ignition (disks)... Oct 13 04:53:58.430886 ignition[541]: Ignition v0.36.1-15-gde4e6cc9 Oct 13 04:53:58.430902 ignition[541]: Stage: disks Oct 13 04:53:58.430914 ignition[541]: reading system config file "/usr/lib/ignition/base.ign" Oct 13 04:53:58.430924 ignition[541]: no config at "/usr/lib/ignition/base.ign" Oct 13 04:53:58.430965 ignition[541]: parsed url from cmdline: "" Oct 13 04:53:58.430968 ignition[541]: no config URL provided Oct 13 04:53:58.430973 ignition[541]: reading system config file "/usr/lib/ignition/user.ign" Oct 13 04:53:58.430980 ignition[541]: no config at "/usr/lib/ignition/user.ign" Oct 13 04:53:58.430998 ignition[541]: op(1): [started] loading QEMU firmware config module Oct 13 04:53:58.431003 ignition[541]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 13 04:53:58.432051 ignition[541]: op(1): [finished] loading QEMU firmware config module Oct 13 04:53:58.443090 ignition[541]: parsing config with SHA512: 891aafa90f34bf93cafa29aa34f07ef3468231dfc31a92ec4a9ba46ca23a642fa57117bd5663d60764c9e9a57f1a03608774b418c0de475a6831ee93026ffcbc Oct 13 04:53:58.445052 ignition[541]: disks: disks passed Oct 13 04:53:58.445063 ignition[541]: Ignition finished successfully Oct 13 04:53:58.445733 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 13 04:53:58.445937 systemd[1]: Finished Ignition (disks). Oct 13 04:53:58.446675 systemd[1]: Reached target Preparation for Local File Systems. Oct 13 04:53:58.448346 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 13 04:53:58.450005 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 13 04:53:58.457583 systemd-fsck[554]: ROOT: clean, 528/553792 files, 37752/553472 blocks Oct 13 04:53:58.462828 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 13 04:53:58.462259 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 13 04:53:58.464379 systemd[1]: Mounting /sysroot... Oct 13 04:53:58.481190 systemd[1]: Found device /dev/mapper/usr. Oct 13 04:53:58.482390 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 13 04:53:58.484135 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 13 04:53:58.492002 systemd-fsck[568]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 13 04:53:58.492002 systemd-fsck[568]: You must have r/w access to the filesystem or be root Oct 13 04:53:58.492131 systemd-fsck[566]: fsck failed with exit status 8. Oct 13 04:53:58.492134 systemd-fsck[566]: Ignoring error. Oct 13 04:53:58.492706 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 13 04:53:58.494166 systemd[1]: Mounting /sysusr/usr... Oct 13 04:53:58.511674 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 13 04:53:58.511712 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 13 04:53:58.511847 systemd[1]: Mounted /sysroot. Oct 13 04:53:58.512353 systemd[1]: Reached target Initrd Root File System. Oct 13 04:53:58.521819 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 13 04:53:58.521959 systemd[1]: Mounted /sysusr/usr. Oct 13 04:53:58.522464 systemd[1]: Reached target Local File Systems. Oct 13 04:53:58.523342 systemd[1]: Reached target System Initialization. Oct 13 04:53:58.524344 systemd[1]: Reached target Basic System. Oct 13 04:53:58.526434 systemd[1]: Mounting /sysroot/usr... Oct 13 04:53:58.528426 systemd[1]: Mounted /sysroot/usr. Oct 13 04:53:58.529474 systemd[1]: Starting Root filesystem setup... Oct 13 04:53:58.553577 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 13 04:53:58.553688 systemd[1]: Finished Root filesystem setup. Oct 13 04:53:58.555438 systemd[1]: Starting Ignition (files)... Oct 13 04:53:58.556481 systemd[1]: Starting /sysroot/boot... Oct 13 04:53:58.558354 ignition[585]: Ignition v0.36.1-15-gde4e6cc9 Oct 13 04:53:58.558372 ignition[585]: Stage: files Oct 13 04:53:58.558381 ignition[585]: reading system config file "/usr/lib/ignition/base.ign" Oct 13 04:53:58.558390 ignition[585]: no config at "/usr/lib/ignition/base.ign" Oct 13 04:53:58.558882 ignition[585]: files: compiled without relabeling support, skipping Oct 13 04:53:58.573010 ignition[585]: files: createUsers: op(1): [started] creating or modifying user "core" Oct 13 04:53:58.573020 ignition[585]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Oct 13 04:53:58.574478 ignition[585]: files: createUsers: op(1): [finished] creating or modifying user "core" Oct 13 04:53:58.574487 ignition[585]: files: createUsers: op(2): [started] adding ssh keys to user "core" Oct 13 04:53:58.574710 systemd[1]: Finished /sysroot/boot. Oct 13 04:53:58.577539 ignition[585]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Oct 13 04:53:58.577573 ignition[585]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Oct 13 04:53:58.578567 ignition[585]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Oct 13 04:53:58.578575 ignition[585]: files: op(4): [started] processing unit "coreos-metadata.service" Oct 13 04:53:58.578666 ignition[585]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 13 04:53:58.581673 systemd[1]: ignition-files.service: Deactivated successfully. Oct 13 04:53:58.581071 ignition[585]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 13 04:53:58.581772 systemd[1]: Finished Ignition (files). Oct 13 04:53:58.581077 ignition[585]: files: op(4): [finished] processing unit "coreos-metadata.service" Oct 13 04:53:58.582431 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Oct 13 04:53:58.581081 ignition[585]: files: files passed Oct 13 04:53:58.583012 systemd[1]: Starting Ignition (record completion)... Oct 13 04:53:58.592781 kernel: audit: type=1334 audit(1760331238.589:7): prog-id=10 op=UNLOAD Oct 13 04:53:58.592809 kernel: audit: type=1334 audit(1760331238.589:8): prog-id=9 op=UNLOAD Oct 13 04:53:58.592819 kernel: audit: type=1334 audit(1760331238.591:9): prog-id=6 op=UNLOAD Oct 13 04:53:58.589000 audit: BPF prog-id=10 op=UNLOAD Oct 13 04:53:58.589000 audit: BPF prog-id=9 op=UNLOAD Oct 13 04:53:58.591000 audit: BPF prog-id=6 op=UNLOAD Oct 13 04:53:58.581085 ignition[585]: Ignition finished successfully Oct 13 04:53:58.584627 systemd[1]: Starting Reload Configuration from the Real Root... Oct 13 04:53:58.585950 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 13 04:53:58.586054 systemd[1]: Finished Ignition (record completion). Oct 13 04:53:58.588768 systemd[1]: Reloading. Oct 13 04:53:58.598000 audit: BPF prog-id=3 op=UNLOAD Oct 13 04:53:58.599822 kernel: audit: type=1334 audit(1760331238.598:10): prog-id=3 op=UNLOAD Oct 13 04:53:58.675000 audit: BPF prog-id=11 op=LOAD Oct 13 04:53:58.675000 audit: BPF prog-id=12 op=LOAD Oct 13 04:53:58.676000 audit: BPF prog-id=13 op=LOAD Oct 13 04:53:58.676000 audit: BPF prog-id=14 op=LOAD Oct 13 04:53:58.676000 audit: BPF prog-id=15 op=LOAD Oct 13 04:53:58.676000 audit: BPF prog-id=7 op=UNLOAD Oct 13 04:53:58.676000 audit: BPF prog-id=8 op=UNLOAD Oct 13 04:53:58.677000 audit: BPF prog-id=16 op=LOAD Oct 13 04:53:58.677000 audit: BPF prog-id=17 op=LOAD Oct 13 04:53:58.677000 audit: BPF prog-id=18 op=LOAD Oct 13 04:53:58.677000 audit: BPF prog-id=4 op=UNLOAD Oct 13 04:53:58.677000 audit: BPF prog-id=5 op=UNLOAD Oct 13 04:53:58.691832 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 13 04:53:58.691975 systemd[1]: Finished Reload Configuration from the Real Root. Oct 13 04:53:58.693395 systemd[1]: Reached target Initrd File Systems. Oct 13 04:53:58.694482 systemd[1]: Reached target Initrd Default Target. Oct 13 04:53:58.695581 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 13 04:53:58.696246 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 13 04:53:58.706379 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 13 04:53:58.707705 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 13 04:53:58.713687 systemd[1]: Stopped target Host and Network Name Lookups. Oct 13 04:53:58.714475 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 13 04:53:58.715592 systemd[1]: Stopped target Timer Units. Oct 13 04:53:58.716577 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 13 04:53:58.716679 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 13 04:53:58.717718 systemd[1]: Stopped target Initrd Default Target. Oct 13 04:53:58.718795 systemd[1]: Stopped target Basic System. Oct 13 04:53:58.719873 systemd[1]: Stopped target Initrd Root Device. Oct 13 04:53:58.720921 systemd[1]: Stopped target Path Units. Oct 13 04:53:58.721879 systemd[1]: Stopped target Remote File Systems. Oct 13 04:53:58.723056 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 13 04:53:58.724135 systemd[1]: Stopped target Slice Units. Oct 13 04:53:58.725152 systemd[1]: Stopped target Socket Units. Oct 13 04:53:58.726253 systemd[1]: Stopped target System Initialization. Oct 13 04:53:58.727231 systemd[1]: Stopped target Local File Systems. Oct 13 04:53:58.728308 systemd[1]: Stopped target Preparation for Local File Systems. Oct 13 04:53:58.729433 systemd[1]: Stopped target Swaps. Oct 13 04:53:58.730340 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 13 04:53:58.730443 systemd[1]: Stopped dracut pre-mount hook. Oct 13 04:53:58.731484 systemd[1]: Stopped target Local Encrypted Volumes. Oct 13 04:53:58.732347 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 13 04:53:58.735832 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 13 04:53:58.736617 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 13 04:53:58.736712 systemd[1]: Stopped dracut initqueue hook. Oct 13 04:53:58.739150 iscsid[485]: iscsid shutting down. Oct 13 04:53:58.737884 systemd[1]: Stopping Open-iSCSI... Oct 13 04:53:58.739383 systemd[1]: Stopping /sysroot/boot... Oct 13 04:53:58.740201 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 13 04:53:58.740311 systemd[1]: Stopped Coldplug All udev Devices. Oct 13 04:53:58.741211 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 13 04:53:58.741286 systemd[1]: Stopped dracut pre-trigger hook. Oct 13 04:53:58.743174 systemd[1]: iscsid.service: Deactivated successfully. Oct 13 04:53:58.743296 systemd[1]: Stopped Open-iSCSI. Oct 13 04:53:58.744379 systemd[1]: iscsid.socket: Deactivated successfully. Oct 13 04:53:58.744437 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 13 04:53:58.745778 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 13 04:53:58.747995 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 13 04:53:58.748107 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 13 04:53:58.750161 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 13 04:53:58.750275 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 13 04:53:58.751064 systemd[1]: Stopped target Network. Oct 13 04:53:58.751886 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 13 04:53:58.751916 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 13 04:53:58.753046 systemd[1]: Stopping Network Name Resolution... Oct 13 04:53:58.754493 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 13 04:53:58.754607 systemd[1]: Stopped /sysroot/boot. Oct 13 04:53:58.758004 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 13 04:53:58.758119 systemd[1]: Stopped Network Name Resolution. Oct 13 04:53:58.759329 systemd[1]: Stopping Network Configuration... Oct 13 04:53:58.763000 audit: BPF prog-id=11 op=UNLOAD Oct 13 04:53:58.762934 systemd-networkd[431]: eth0: DHCP lease lost Oct 13 04:53:58.771855 systemd-networkd[431]: eth0: DHCPv6 lease lost Oct 13 04:53:58.772732 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 13 04:53:58.772866 systemd[1]: Stopped Network Configuration. Oct 13 04:53:58.774157 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 13 04:53:58.774185 systemd[1]: Closed Network Service Netlink Socket. Oct 13 04:53:58.775585 systemd[1]: Stopping Network Cleanup... Oct 13 04:53:58.776620 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 13 04:53:58.778000 audit: BPF prog-id=12 op=UNLOAD Oct 13 04:53:58.776676 systemd[1]: Stopped Apply Kernel Variables. Oct 13 04:53:58.777684 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 13 04:53:58.783625 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 13 04:53:58.783741 systemd[1]: Stopped Network Cleanup. Oct 13 04:53:58.786207 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 13 04:53:58.786331 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 13 04:53:58.787645 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 13 04:53:58.787683 systemd[1]: Closed udev Control Socket. Oct 13 04:53:58.788616 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 13 04:53:58.788645 systemd[1]: Closed udev Kernel Socket. Oct 13 04:53:58.789655 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 13 04:53:58.789690 systemd[1]: Stopped dracut pre-udev hook. Oct 13 04:53:58.790545 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 13 04:53:58.790576 systemd[1]: Stopped dracut cmdline hook. Oct 13 04:53:58.791612 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 13 04:53:58.795000 audit: BPF prog-id=13 op=UNLOAD Oct 13 04:53:58.791645 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 13 04:53:58.793226 systemd[1]: Starting Cleanup udev Database... Oct 13 04:53:58.793814 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 13 04:53:58.794701 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 13 04:53:58.794755 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 13 04:53:58.796027 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 13 04:53:58.796065 systemd[1]: Stopped Create List of Static Device Nodes. Oct 13 04:53:58.797027 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 13 04:53:58.797063 systemd[1]: Stopped Setup Virtual Console. Oct 13 04:53:58.798462 systemd[1]: rngd.service: Deactivated successfully. Oct 13 04:53:58.798579 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 13 04:53:58.799671 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 13 04:53:58.799767 systemd[1]: Finished Cleanup udev Database. Oct 13 04:53:58.800628 systemd[1]: Reached target Switch Root. Oct 13 04:53:58.802209 systemd[1]: Starting Switch Root... Oct 13 04:53:58.808000 audit: BPF prog-id=16 op=UNLOAD Oct 13 04:53:58.807053 systemd[1]: Switching root. Oct 13 04:53:58.816032 systemd-journald[280]: Journal stopped Oct 13 04:54:00.942275 systemd-journald[280]: Received SIGTERM from PID 1 (systemd). Oct 13 04:54:00.942330 kernel: SELinux: policy capability network_peer_controls=1 Oct 13 04:54:00.942342 kernel: SELinux: policy capability open_perms=1 Oct 13 04:54:00.942360 kernel: SELinux: policy capability extended_socket_class=1 Oct 13 04:54:00.942386 kernel: SELinux: policy capability always_check_network=0 Oct 13 04:54:00.942395 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 13 04:54:00.942408 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 13 04:54:00.942417 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 13 04:54:00.942427 systemd[1]: Successfully loaded SELinux policy in 29.113ms. Oct 13 04:54:00.942440 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.547ms. Oct 13 04:54:00.942451 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 13 04:54:00.942462 systemd[1]: Detected virtualization kvm. Oct 13 04:54:00.942472 systemd[1]: Detected architecture arm64. Oct 13 04:54:00.942483 systemd[1]: Detected first boot. Oct 13 04:54:00.942492 systemd[1]: Initializing machine ID from VM UUID. Oct 13 04:54:00.942502 systemd[1]: Populated /etc with preset unit settings. Oct 13 04:54:00.942514 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 13 04:54:00.942538 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 13 04:54:00.942607 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 13 04:54:00.942668 systemd[1]: Stopped Switch Root. Oct 13 04:54:00.942683 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 13 04:54:00.942694 systemd[1]: Created slice Slice /system/addon-config. Oct 13 04:54:00.942705 systemd[1]: Created slice Slice /system/addon-run. Oct 13 04:54:00.942714 systemd[1]: Created slice Slice /system/getty. Oct 13 04:54:00.942724 systemd[1]: Created slice Slice /system/modprobe. Oct 13 04:54:00.942734 systemd[1]: Created slice Slice /system/serial-getty. Oct 13 04:54:00.942744 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 13 04:54:00.942754 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 13 04:54:00.942768 systemd[1]: Created slice User and Session Slice. Oct 13 04:54:00.942782 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 13 04:54:00.942792 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 13 04:54:00.942834 systemd[1]: Set up automount Boot partition Automount Point. Oct 13 04:54:00.942846 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 13 04:54:00.942857 systemd[1]: Stopped target Switch Root. Oct 13 04:54:00.942867 systemd[1]: Stopped target Initrd File Systems. Oct 13 04:54:00.942878 systemd[1]: Stopped target Initrd Root File System. Oct 13 04:54:00.942889 systemd[1]: Reached target Remote Encrypted Volumes. Oct 13 04:54:00.942900 systemd[1]: Reached target Remote File Systems. Oct 13 04:54:00.942911 systemd[1]: Reached target Slice Units. Oct 13 04:54:00.942921 systemd[1]: Reached target Swaps. Oct 13 04:54:00.942931 systemd[1]: Reached target Verify torcx succeeded. Oct 13 04:54:00.942941 systemd[1]: Reached target Local Verity Protected Volumes. Oct 13 04:54:00.942951 systemd[1]: Listening on Process Core Dump Socket. Oct 13 04:54:00.942962 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 13 04:54:00.942972 systemd[1]: Listening on Network Service Netlink Socket. Oct 13 04:54:00.942982 systemd[1]: Listening on udev Control Socket. Oct 13 04:54:00.942992 systemd[1]: Listening on udev Kernel Socket. Oct 13 04:54:00.943002 systemd[1]: Mounting Huge Pages File System... Oct 13 04:54:00.943012 systemd[1]: Mounting POSIX Message Queue File System... Oct 13 04:54:00.943022 systemd[1]: Mounting External Media Directory... Oct 13 04:54:00.943032 systemd[1]: Mounting Kernel Debug File System... Oct 13 04:54:00.943042 systemd[1]: Mounting Kernel Trace File System... Oct 13 04:54:00.943052 systemd[1]: Mounting Temporary Directory /tmp... Oct 13 04:54:00.943062 systemd[1]: Starting Create missing system files... Oct 13 04:54:00.943071 systemd[1]: Starting Create List of Static Device Nodes... Oct 13 04:54:00.943081 systemd[1]: Starting Load Kernel Module configfs... Oct 13 04:54:00.943092 systemd[1]: Starting Load Kernel Module drm... Oct 13 04:54:00.943103 systemd[1]: Starting Load Kernel Module fuse... Oct 13 04:54:00.943112 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 13 04:54:00.943122 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 13 04:54:00.943132 systemd[1]: Stopped File System Check on Root Device. Oct 13 04:54:00.943142 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 13 04:54:00.943152 systemd[1]: Stopped systemd-fsck-usr.service. Oct 13 04:54:00.943161 systemd[1]: Stopped Journal Service. Oct 13 04:54:00.943171 kernel: kauditd_printk_skb: 42 callbacks suppressed Oct 13 04:54:00.943181 kernel: audit: type=1334 audit(1760331240.908:53): prog-id=30 op=LOAD Oct 13 04:54:00.943192 kernel: audit: type=1334 audit(1760331240.914:54): prog-id=31 op=LOAD Oct 13 04:54:00.943201 systemd[1]: Starting Journal Service... Oct 13 04:54:00.943210 kernel: audit: type=1334 audit(1760331240.914:55): prog-id=32 op=LOAD Oct 13 04:54:00.943219 kernel: audit: type=1334 audit(1760331240.914:56): prog-id=28 op=UNLOAD Oct 13 04:54:00.943229 kernel: audit: type=1334 audit(1760331240.914:57): prog-id=29 op=UNLOAD Oct 13 04:54:00.943238 kernel: fuse: init (API version 7.32) Oct 13 04:54:00.943247 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 13 04:54:00.943257 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 13 04:54:00.943266 systemd[1]: Starting Apply Kernel Variables... Oct 13 04:54:00.943277 systemd[1]: Starting Coldplug All udev Devices... Oct 13 04:54:00.943287 systemd[1]: verity-setup.service: Deactivated successfully. Oct 13 04:54:00.943297 systemd[1]: Stopped verity-setup.service. Oct 13 04:54:00.943307 systemd[1]: Mounted Huge Pages File System. Oct 13 04:54:00.943317 systemd[1]: Mounted POSIX Message Queue File System. Oct 13 04:54:00.943327 systemd[1]: Mounted External Media Directory. Oct 13 04:54:00.943337 kernel: audit: type=1305 audit(1760331240.940:58): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 13 04:54:00.943351 systemd-journald[801]: Journal started Oct 13 04:54:00.943389 systemd-journald[801]: Runtime Journal (/run/log/journal/3510c0b04d2f41f4b7d3f4d99b43eec3) is 6.0M, max 48.5M, 42.4M free. Oct 13 04:53:58.876000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 13 04:53:58.903000 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 13 04:53:58.903000 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 13 04:53:58.903000 audit: BPF prog-id=19 op=LOAD Oct 13 04:53:58.903000 audit: BPF prog-id=19 op=UNLOAD Oct 13 04:53:58.903000 audit: BPF prog-id=20 op=LOAD Oct 13 04:53:58.903000 audit: BPF prog-id=20 op=UNLOAD Oct 13 04:53:58.934000 audit[750]: AVC avc: denied { associate } for pid=750 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Oct 13 04:54:00.816000 audit: BPF prog-id=21 op=LOAD Oct 13 04:54:00.816000 audit: BPF prog-id=22 op=LOAD Oct 13 04:54:00.816000 audit: BPF prog-id=23 op=LOAD Oct 13 04:54:00.816000 audit: BPF prog-id=17 op=UNLOAD Oct 13 04:54:00.816000 audit: BPF prog-id=18 op=UNLOAD Oct 13 04:54:00.824000 audit: BPF prog-id=24 op=LOAD Oct 13 04:54:00.824000 audit: BPF prog-id=21 op=UNLOAD Oct 13 04:54:00.824000 audit: BPF prog-id=25 op=LOAD Oct 13 04:54:00.824000 audit: BPF prog-id=26 op=LOAD Oct 13 04:54:00.824000 audit: BPF prog-id=22 op=UNLOAD Oct 13 04:54:00.824000 audit: BPF prog-id=23 op=UNLOAD Oct 13 04:54:00.825000 audit: BPF prog-id=27 op=LOAD Oct 13 04:54:00.825000 audit: BPF prog-id=24 op=UNLOAD Oct 13 04:54:00.825000 audit: BPF prog-id=28 op=LOAD Oct 13 04:54:00.825000 audit: BPF prog-id=29 op=LOAD Oct 13 04:54:00.825000 audit: BPF prog-id=25 op=UNLOAD Oct 13 04:54:00.825000 audit: BPF prog-id=26 op=UNLOAD Oct 13 04:54:00.834000 audit: BPF prog-id=27 op=UNLOAD Oct 13 04:54:00.908000 audit: BPF prog-id=30 op=LOAD Oct 13 04:54:00.914000 audit: BPF prog-id=31 op=LOAD Oct 13 04:54:00.914000 audit: BPF prog-id=32 op=LOAD Oct 13 04:54:00.914000 audit: BPF prog-id=28 op=UNLOAD Oct 13 04:54:00.914000 audit: BPF prog-id=29 op=UNLOAD Oct 13 04:54:00.940000 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 13 04:54:00.815987 systemd[1]: Queued start job for default target Multi-User System. Oct 13 04:53:58.933890 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" 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 13 04:54:00.827125 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 13 04:53:58.934170 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 13 04:53:58.934190 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 13 04:53:58.934310 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 13 04:53:58.934322 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 13 04:53:58.934352 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 13 04:53:58.934365 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 13 04:54:00.945070 systemd[1]: Mounted Kernel Debug File System. Oct 13 04:54:00.945088 systemd[1]: Started Journal Service. Oct 13 04:53:58.934570 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 13 04:53:58.934603 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 13 04:53:58.934624 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 13 04:53:58.934999 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" 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 13 04:53:58.935032 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" 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 13 04:53:58.935052 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" 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 13 04:53:58.935067 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 13 04:53:58.935086 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" 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 13 04:53:58.935100 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:53:58Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 13 04:54:00.638485 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:54:00Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 13 04:54:00.638860 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:54:00Z" 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 13 04:54:00.638991 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:54:00Z" 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 13 04:54:00.639122 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:54:00Z" 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 13 04:54:00.639179 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:54:00Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 13 04:54:00.639235 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-13T04:54:00Z" 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 13 04:54:00.945982 systemd[1]: Mounted Kernel Trace File System. Oct 13 04:54:00.946653 systemd[1]: Mounted Temporary Directory /tmp. Oct 13 04:54:00.947587 systemd[1]: Finished Create missing system files. Oct 13 04:54:00.948574 systemd[1]: Finished Create List of Static Device Nodes. Oct 13 04:54:00.949474 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 13 04:54:00.949679 systemd[1]: Finished Load Kernel Module configfs. Oct 13 04:54:00.950586 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 13 04:54:00.950790 systemd[1]: Finished Load Kernel Module drm. Oct 13 04:54:00.951563 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 13 04:54:00.951765 systemd[1]: Finished Load Kernel Module fuse. Oct 13 04:54:00.968254 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 13 04:54:00.969246 systemd[1]: Finished Apply Kernel Variables. Oct 13 04:54:00.971847 systemd[1]: Mounting FUSE Control File System... Oct 13 04:54:00.973375 systemd[1]: Mounting Kernel Configuration File System... Oct 13 04:54:00.974050 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 13 04:54:00.975743 systemd[1]: Starting Rebuild Hardware Database... Oct 13 04:54:00.977384 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 13 04:54:00.978066 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 13 04:54:00.979150 systemd[1]: Starting Load/Save Random Seed... Oct 13 04:54:00.981594 systemd-journald[801]: Time spent on flushing to /var/log/journal/3510c0b04d2f41f4b7d3f4d99b43eec3 is 9.261ms for 779 entries. Oct 13 04:54:00.981594 systemd-journald[801]: System Journal (/var/log/journal/3510c0b04d2f41f4b7d3f4d99b43eec3) is 8.0M, max 203.0M, 195.0M free. Oct 13 04:54:00.982962 systemd[1]: Starting Create System Users... Oct 13 04:54:00.985201 systemd[1]: Mounted FUSE Control File System. Oct 13 04:54:00.986159 systemd[1]: Mounted Kernel Configuration File System. Oct 13 04:54:00.989356 systemd[1]: Finished Load/Save Random Seed. Oct 13 04:54:00.990038 systemd[1]: Reached target First Boot Complete. Oct 13 04:54:00.992843 systemd[1]: Finished Coldplug All udev Devices. Oct 13 04:54:00.993613 systemd-sysusers[813]: Creating group sgx with gid 999. Oct 13 04:54:00.994593 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 13 04:54:00.996651 systemd-sysusers[813]: Creating group systemd-oom with gid 998. Oct 13 04:54:00.997322 systemd-sysusers[813]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Oct 13 04:54:00.998243 systemd-sysusers[813]: Creating group systemd-timesync with gid 997. Oct 13 04:54:00.998885 systemd-sysusers[813]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Oct 13 04:54:00.999690 systemd-sysusers[813]: Creating group systemd-coredump with gid 996. Oct 13 04:54:01.000360 systemd-sysusers[813]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Oct 13 04:54:01.010627 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 13 04:54:01.030229 systemd[1]: Finished Create System Users. Oct 13 04:54:01.031892 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 13 04:54:01.044758 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 13 04:54:01.258946 systemd[1]: Finished Rebuild Hardware Database. Oct 13 04:54:01.274000 audit: BPF prog-id=33 op=LOAD Oct 13 04:54:01.275000 audit: BPF prog-id=34 op=LOAD Oct 13 04:54:01.276823 kernel: audit: type=1334 audit(1760331241.274:59): prog-id=33 op=LOAD Oct 13 04:54:01.276876 kernel: audit: type=1334 audit(1760331241.275:60): prog-id=34 op=LOAD Oct 13 04:54:01.276903 kernel: audit: type=1334 audit(1760331241.276:61): prog-id=35 op=LOAD Oct 13 04:54:01.276000 audit: BPF prog-id=35 op=LOAD Oct 13 04:54:01.276000 audit: BPF prog-id=14 op=UNLOAD Oct 13 04:54:01.278019 kernel: audit: type=1334 audit(1760331241.276:62): prog-id=14 op=UNLOAD Oct 13 04:54:01.277000 audit: BPF prog-id=15 op=UNLOAD Oct 13 04:54:01.278736 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 13 04:54:01.302159 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 13 04:54:01.314147 systemd[1]: Starting Network Configuration... Oct 13 04:54:01.312000 audit: BPF prog-id=36 op=LOAD Oct 13 04:54:01.341666 systemd-networkd[839]: lo: Link UP Oct 13 04:54:01.341677 systemd-networkd[839]: lo: Gained carrier Oct 13 04:54:01.342056 systemd-networkd[839]: Enumeration completed Oct 13 04:54:01.342156 systemd[1]: Started Network Configuration. Oct 13 04:54:01.347085 systemd-udevd[821]: Using default interface naming scheme 'v249'. Oct 13 04:54:01.368519 udevadm[815]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 13 04:54:01.383358 systemd-networkd[839]: eth0: Link UP Oct 13 04:54:01.389853 systemd-networkd[839]: eth0: Gained carrier Oct 13 04:54:01.394942 systemd-networkd[839]: eth0: DHCPv4 address 10.0.0.7/16 via 10.0.0.1 Oct 13 04:54:01.397991 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 13 04:54:01.409924 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 13 04:54:01.418043 lvm[847]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 13 04:54:01.447884 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 13 04:54:01.448640 systemd[1]: Reached target Local Encrypted Volumes. Oct 13 04:54:01.457924 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 13 04:54:01.461382 lvm[848]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 13 04:54:01.489936 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 13 04:54:01.490697 systemd[1]: Reached target Preparation for Local File Systems. Oct 13 04:54:01.491463 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 13 04:54:01.491488 systemd[1]: Reached target Containers. Oct 13 04:54:01.503070 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 13 04:54:01.515267 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 13 04:54:01.517274 systemd[1]: Mounting /usr/share/oem... Oct 13 04:54:01.522987 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 13 04:54:01.523046 kernel: BTRFS info (device vda6): has skinny extents Oct 13 04:54:01.525235 systemd[1]: Mounted /usr/share/oem. Oct 13 04:54:01.525882 systemd[1]: Reached target Local File Systems. Oct 13 04:54:01.527647 systemd[1]: Starting Rebuild Dynamic Linker Cache... Oct 13 04:54:01.528696 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 13 04:54:01.528743 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 13 04:54:01.529890 systemd[1]: Starting Commit a transient machine-id on disk... Oct 13 04:54:01.531623 systemd[1]: Starting Create Volatile Files and Directories... Oct 13 04:54:01.538089 systemd-tmpfiles[873]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 13 04:54:01.539160 systemd-tmpfiles[873]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 13 04:54:01.549795 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 13 04:54:01.550622 systemd[1]: Finished Commit a transient machine-id on disk. Oct 13 04:54:01.576843 systemd-tmpfiles[873]: Detected autofs mount point /boot during canonicalization of /boot. Oct 13 04:54:01.576856 systemd-tmpfiles[873]: Skipping /boot Oct 13 04:54:01.582087 systemd-tmpfiles[873]: Detected autofs mount point /boot during canonicalization of /boot. Oct 13 04:54:01.582103 systemd-tmpfiles[873]: Skipping /boot Oct 13 04:54:01.618310 systemd[1]: Finished Create Volatile Files and Directories. Oct 13 04:54:01.619393 systemd[1]: Finished Rebuild Dynamic Linker Cache. Oct 13 04:54:01.636901 systemd[1]: Starting Load Security Auditing Rules... Oct 13 04:54:01.638602 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 13 04:54:01.640424 systemd[1]: Starting Rebuild Journal Catalog... Oct 13 04:54:01.640000 audit: BPF prog-id=37 op=LOAD Oct 13 04:54:01.642590 systemd[1]: Starting Network Name Resolution... Oct 13 04:54:01.643000 audit: BPF prog-id=38 op=LOAD Oct 13 04:54:01.644740 systemd[1]: Starting Network Time Synchronization... Oct 13 04:54:01.647000 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 13 04:54:01.648526 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 13 04:54:01.649852 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 13 04:54:01.653261 systemd[1]: Finished Rebuild Journal Catalog. Oct 13 04:54:01.655192 systemd[1]: Starting Update is Completed... Oct 13 04:54:01.661436 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 13 04:54:01.662578 systemd[1]: Finished Update is Completed. Oct 13 04:54:01.673000 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 13 04:54:01.674884 augenrules[896]: No rules Oct 13 04:54:01.675889 systemd[1]: Finished Load Security Auditing Rules. Oct 13 04:54:01.684534 systemd[1]: Started Network Time Synchronization. Oct 13 04:54:01.685312 systemd[1]: Reached target System Initialization. Oct 13 04:54:01.685938 systemd-resolved[883]: Positive Trust Anchors: Oct 13 04:54:01.685949 systemd-resolved[883]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 13 04:54:01.685976 systemd-resolved[883]: 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 13 04:54:01.686073 systemd[1]: Started Watch for update engine configuration changes. Oct 13 04:54:01.254489 systemd-timesyncd[884]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 13 04:54:01.254523 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 13 04:54:01.255328 systemd-resolved[883]: Defaulting to hostname 'linux'. Oct 13 04:54:01.255484 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 13 04:54:01.256197 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 13 04:54:01.256223 systemd[1]: Reached target Path Units. Oct 13 04:54:01.256832 systemd[1]: Reached target System Time Set. Oct 13 04:54:01.257676 systemd[1]: Started Daily Log Rotation. Oct 13 04:54:01.258699 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 13 04:54:01.260051 systemd[1]: Reached target Timer Units. Oct 13 04:54:01.261004 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 13 04:54:01.263036 systemd[1]: Starting Docker Socket for the API... Oct 13 04:54:01.266300 systemd[1]: Listening on OpenSSH Server Socket. Oct 13 04:54:01.267420 systemd[1]: Started Network Name Resolution. Oct 13 04:54:01.268092 systemd[1]: Listening on Docker Socket for the API. Oct 13 04:54:01.269020 systemd[1]: Reached target Network. Oct 13 04:54:01.269557 systemd[1]: Reached target Host and Network Name Lookups. Oct 13 04:54:01.270189 systemd[1]: Reached target Socket Units. Oct 13 04:54:01.270691 systemd[1]: Reached target Basic System. Oct 13 04:54:01.271245 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 13 04:54:01.271273 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 13 04:54:01.272399 systemd[1]: Started D-Bus System Message Bus. Oct 13 04:54:01.275470 systemd[1]: Starting Extend Filesystems... Oct 13 04:54:01.276086 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 13 04:54:01.277134 systemd[1]: Starting Generate /run/flatcar/motd... Oct 13 04:54:01.279436 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 13 04:54:01.281186 systemd[1]: Starting Generate sshd host keys... Oct 13 04:54:01.282280 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 13 04:54:01.282320 systemd[1]: Reached target Load system-provided cloud configs. Oct 13 04:54:01.285805 systemd[1]: Starting User Login Management... Oct 13 04:54:01.286730 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 13 04:54:01.287382 systemd[1]: Starting Update Engine... Oct 13 04:54:01.287969 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 13 04:54:01.288010 systemd[1]: Reached target Load user-provided cloud configs. Oct 13 04:54:01.289572 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 13 04:54:01.289821 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 13 04:54:01.291456 extend-filesystems[906]: Found vda Oct 13 04:54:01.291456 extend-filesystems[906]: Found vda1 Oct 13 04:54:01.291456 extend-filesystems[906]: Found vda2 Oct 13 04:54:01.291456 extend-filesystems[906]: Found vda3 Oct 13 04:54:01.291456 extend-filesystems[906]: Found usr Oct 13 04:54:01.295652 extend-filesystems[906]: Found vda4 Oct 13 04:54:01.295652 extend-filesystems[906]: Found vda6 Oct 13 04:54:01.295652 extend-filesystems[906]: Found vda7 Oct 13 04:54:01.295652 extend-filesystems[906]: Found vda9 Oct 13 04:54:01.295652 extend-filesystems[906]: Checking size of /dev/vda9 Oct 13 04:54:01.299361 systemd[1]: motdgen.service: Deactivated successfully. Oct 13 04:54:01.299598 systemd[1]: Finished Generate /run/flatcar/motd. Oct 13 04:54:01.311512 extend-filesystems[906]: Old size kept for /dev/vda9 Oct 13 04:54:01.312404 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 13 04:54:01.312639 systemd[1]: Finished Extend Filesystems. Oct 13 04:54:01.323717 update_engine[920]: I1013 04:54:01.323349 920 main.cc:89] Flatcar Update Engine starting Oct 13 04:54:01.326604 systemd[1]: Started Update Engine. Oct 13 04:54:01.327009 update_engine[920]: I1013 04:54:01.326853 920 update_check_scheduler.cc:74] Next update check in 5m10s Oct 13 04:54:01.328770 systemd-logind[917]: Watching system buttons on /dev/input/event0 (Power Button) Oct 13 04:54:01.330435 systemd-logind[917]: New seat seat0. Oct 13 04:54:01.334517 systemd[1]: Started Cluster reboot manager. Oct 13 04:54:01.341828 systemd[1]: Started User Login Management. Oct 13 04:54:01.362466 locksmithd[931]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 13 04:54:01.664311 sshd_keygen[924]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Oct 13 04:54:01.683571 systemd[1]: Finished Generate sshd host keys. Oct 13 04:54:01.700320 systemd[1]: Starting Generate /run/issue... Oct 13 04:54:01.704807 systemd[1]: issuegen.service: Deactivated successfully. Oct 13 04:54:01.705059 systemd[1]: Finished Generate /run/issue. Oct 13 04:54:01.707214 systemd[1]: Starting Permit User Sessions... Oct 13 04:54:01.714234 systemd[1]: Finished Permit User Sessions. Oct 13 04:54:01.716224 systemd[1]: Started Getty on tty1. Oct 13 04:54:01.717990 systemd[1]: Started Serial Getty on ttyAMA0. Oct 13 04:54:01.718782 systemd[1]: Reached target Login Prompts. Oct 13 04:54:01.719495 systemd[1]: Reached target Multi-User System. Oct 13 04:54:01.721348 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 13 04:54:01.726779 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 13 04:54:01.727031 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 13 04:54:01.727883 systemd[1]: Startup finished in 689ms (kernel) + 2.294s (initrd) + 3.314s (userspace) = 6.298s. Oct 13 04:54:01.957351 systemd[1]: Created slice Slice /system/sshd. Oct 13 04:54:01.958860 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58306). Oct 13 04:54:01.995701 sshd[952]: Accepted publickey for core from 10.0.0.1 port 58306 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:01.997542 sshd[952]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:02.012713 systemd[1]: Created slice User Slice of UID 500. Oct 13 04:54:02.014131 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 13 04:54:02.015690 systemd-logind[917]: New session 1 of user core. Oct 13 04:54:02.020455 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 13 04:54:02.021893 systemd[1]: Starting User Manager for UID 500... Oct 13 04:54:02.024413 systemd[955]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:02.073073 systemd[955]: Queued start job for default target Main User Target. Oct 13 04:54:02.073271 systemd[955]: Reached target Paths. Oct 13 04:54:02.073286 systemd[955]: Reached target Sockets. Oct 13 04:54:02.073297 systemd[955]: Reached target Timers. Oct 13 04:54:02.073307 systemd[955]: Reached target Basic System. Oct 13 04:54:02.073351 systemd[955]: Reached target Main User Target. Oct 13 04:54:02.073364 systemd[955]: Startup finished in 44ms. Oct 13 04:54:02.073442 systemd[1]: Started User Manager for UID 500. Oct 13 04:54:02.087376 systemd[1]: Started Session 1 of User core. Oct 13 04:54:02.153244 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58310). Oct 13 04:54:02.188961 sshd[964]: Accepted publickey for core from 10.0.0.1 port 58310 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:02.190335 sshd[964]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:02.193048 systemd-logind[917]: New session 2 of user core. Oct 13 04:54:02.205370 systemd[1]: Started Session 2 of User core. Oct 13 04:54:02.258640 sshd[964]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:02.272266 systemd[1]: sshd@1-10.0.0.7:22-10.0.0.1:58310.service: Deactivated successfully. Oct 13 04:54:02.272876 systemd[1]: session-2.scope: Deactivated successfully. Oct 13 04:54:02.273539 systemd-logind[917]: Session 2 logged out. Waiting for processes to exit. Oct 13 04:54:02.274586 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58318). Oct 13 04:54:02.275192 systemd-logind[917]: Removed session 2. Oct 13 04:54:02.308600 sshd[970]: Accepted publickey for core from 10.0.0.1 port 58318 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:02.309646 sshd[970]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:02.312467 systemd-logind[917]: New session 3 of user core. Oct 13 04:54:02.320380 systemd[1]: Started Session 3 of User core. Oct 13 04:54:02.368422 sshd[970]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:02.380994 systemd[1]: sshd@2-10.0.0.7:22-10.0.0.1:58318.service: Deactivated successfully. Oct 13 04:54:02.381668 systemd[1]: session-3.scope: Deactivated successfully. Oct 13 04:54:02.382303 systemd-logind[917]: Session 3 logged out. Waiting for processes to exit. Oct 13 04:54:02.383736 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58330). Oct 13 04:54:02.384508 systemd-logind[917]: Removed session 3. Oct 13 04:54:02.417206 sshd[976]: Accepted publickey for core from 10.0.0.1 port 58330 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:02.418323 sshd[976]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:02.421148 systemd-logind[917]: New session 4 of user core. Oct 13 04:54:02.430385 systemd[1]: Started Session 4 of User core. Oct 13 04:54:02.483664 sshd[976]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:02.499332 systemd[1]: sshd@3-10.0.0.7:22-10.0.0.1:58330.service: Deactivated successfully. Oct 13 04:54:02.500098 systemd[1]: session-4.scope: Deactivated successfully. Oct 13 04:54:02.500844 systemd-logind[917]: Session 4 logged out. Waiting for processes to exit. Oct 13 04:54:02.502553 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58332). Oct 13 04:54:02.503356 systemd-logind[917]: Removed session 4. Oct 13 04:54:02.535241 sshd[982]: Accepted publickey for core from 10.0.0.1 port 58332 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:02.536361 sshd[982]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:02.538996 systemd-logind[917]: New session 5 of user core. Oct 13 04:54:02.545374 systemd[1]: Started Session 5 of User core. Oct 13 04:54:02.565466 systemd-networkd[839]: eth0: Gained IPv6LL Oct 13 04:54:02.599310 sudo[985]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 13 04:54:02.599807 sudo[985]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 13 04:54:02.612737 sudo[985]: pam_unix(sudo:session): session closed for user root Oct 13 04:54:02.614963 sshd[982]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:02.629221 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58344). Oct 13 04:54:02.631489 dbus-daemon[905]: [system] Reloaded configuration Oct 13 04:54:02.634068 systemd[1]: sshd@4-10.0.0.7:22-10.0.0.1:58332.service: Deactivated successfully. Oct 13 04:54:02.634787 systemd[1]: session-5.scope: Deactivated successfully. Oct 13 04:54:02.635500 systemd-logind[917]: Session 5 logged out. Waiting for processes to exit. Oct 13 04:54:02.636190 systemd-logind[917]: Removed session 5. Oct 13 04:54:02.662510 sshd[988]: Accepted publickey for core from 10.0.0.1 port 58344 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:02.663828 sshd[988]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:02.666337 systemd-logind[917]: New session 6 of user core. Oct 13 04:54:02.675367 systemd[1]: Started Session 6 of User core. Oct 13 04:54:02.725561 sudo[994]: 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 13 04:54:02.725783 sudo[994]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 13 04:54:02.729155 sudo[994]: pam_unix(sudo:session): session closed for user root Oct 13 04:54:02.733310 sudo[993]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 13 04:54:02.733534 sudo[993]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 13 04:54:02.749238 systemd[1]: Stopping Load Security Auditing Rules... Oct 13 04:54:02.749000 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 13 04:54:02.750455 auditctl[997]: No rules Oct 13 04:54:02.750732 systemd[1]: audit-rules.service: Deactivated successfully. Oct 13 04:54:02.750980 systemd[1]: Stopped Load Security Auditing Rules. Oct 13 04:54:02.752428 systemd[1]: Starting Load Security Auditing Rules... Oct 13 04:54:02.770771 augenrules[1014]: No rules Oct 13 04:54:02.771550 systemd[1]: Finished Load Security Auditing Rules. Oct 13 04:54:02.772390 sudo[993]: pam_unix(sudo:session): session closed for user root Oct 13 04:54:02.773956 sshd[988]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:02.786493 systemd[1]: sshd@5-10.0.0.7:22-10.0.0.1:58344.service: Deactivated successfully. Oct 13 04:54:02.787116 systemd[1]: session-6.scope: Deactivated successfully. Oct 13 04:54:02.788292 systemd-logind[917]: Session 6 logged out. Waiting for processes to exit. Oct 13 04:54:02.790921 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:58348). Oct 13 04:54:02.792696 systemd-logind[917]: Removed session 6. Oct 13 04:54:02.823687 sshd[1020]: Accepted publickey for core from 10.0.0.1 port 58348 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:02.824763 sshd[1020]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:02.829112 systemd-logind[917]: New session 7 of user core. Oct 13 04:54:02.838417 systemd[1]: Started Session 7 of User core. Oct 13 04:54:02.890093 sudo[1023]: 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 13 04:54:05.536994 update_engine[1269]: Oct 13 04:54:05.536994 update_engine[1269]: Oct 13 04:54:05.536994 update_engine[1269]: Oct 13 04:54:05.536994 update_engine[1269]: Oct 13 04:54:05.536994 update_engine[1269]: Oct 13 04:54:05.536994 update_engine[1269]: Oct 13 04:54:05.536994 update_engine[1269]: Oct 13 04:54:05.536994 update_engine[1269]: Oct 13 04:54:05.537160 update_engine[1269]: I1013 04:54:05.537150 1269 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 13 04:54:05.542708 systemd-logind[917]: Removed session 24. Oct 13 04:54:05.546609 update_engine[1269]: I1013 04:54:05.546586 1269 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 13 04:54:05.546965 update_engine[1269]: I1013 04:54:05.546943 1269 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 13 04:54:05.550116 update_engine[1269]: I1013 04:54:05.548318 1269 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 13 04:54:05.550116 update_engine[1269]: I1013 04:54:05.549932 1269 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Oct 13 04:54:05.550116 update_engine[1269]: I1013 04:54:05.549940 1269 omaha_request_action.cc:619] Omaha request response: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.550116 update_engine[1269]: Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566630 1269 omaha_request_action.cc:447] Omaha Response manifest version = Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566660 1269 omaha_request_action.cc:470] Found 1 url(s) Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566674 1269 omaha_request_action.cc:506] Processing first of 1 package(s) Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566677 1269 omaha_request_action.cc:513] Omaha Response package name = update.gz Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566680 1269 omaha_request_action.cc:529] Url0: http://10.0.0.6:34567/packages/update.gz Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566689 1269 omaha_request_action.cc:541] Payload size = 440186465 bytes Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566699 1269 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566709 1269 payload_state.cc:51] Resetting all persisted state as this is a new response Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566713 1269 payload_state.cc:360] Current Response Signature = Oct 13 04:54:05.567207 update_engine[1269]: NumURLs = 1 Oct 13 04:54:05.567207 update_engine[1269]: Url0 = http://10.0.0.6:34567/packages/update.gz Oct 13 04:54:05.567207 update_engine[1269]: Payload Size = 440186465 Oct 13 04:54:05.567207 update_engine[1269]: Payload Sha256 Hash = 2rLfTjCkf4AccwOSTkVH+eSPLI9tRE2XhCZAKCB99h0= Oct 13 04:54:05.567207 update_engine[1269]: Is Delta Payload = 0 Oct 13 04:54:05.567207 update_engine[1269]: Max Failure Count Per Url = 10 Oct 13 04:54:05.567207 update_engine[1269]: Disable Payload Backoff = 1 Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566800 1269 payload_state.cc:381] Payload Attempt Number = 0 Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566838 1269 payload_state.cc:404] Current URL Index = 0 Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566865 1269 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566910 1269 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566915 1269 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566948 1269 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566967 1269 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566970 1269 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Oct 13 04:54:05.567207 update_engine[1269]: I1013 04:54:05.566984 1269 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Oct 13 04:54:05.567642 update_engine[1269]: E1013 04:54:05.566989 1269 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Oct 13 04:54:05.568055 update_engine[1269]: I1013 04:54:05.567943 1269 omaha_response_handler_action.cc:85] Using this install plan: Oct 13 04:54:05.568055 update_engine[1269]: I1013 04:54:05.567958 1269 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.6:34567/packages/update.gz, payload size: 440186465, payload hash: 2rLfTjCkf4AccwOSTkVH+eSPLI9tRE2XhCZAKCB99h0=, 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 13 04:54:05.568055 update_engine[1269]: I1013 04:54:05.568030 1269 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Oct 13 04:54:05.570597 update_engine[1269]: I1013 04:54:05.570533 1269 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Oct 13 04:54:05.588880 sshd[1289]: Accepted publickey for core from 10.0.0.1 port 34420 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:05.590886 kernel: kauditd_printk_skb: 301 callbacks suppressed Oct 13 04:54:05.590935 kernel: audit: type=1006 audit(1760331245.588:364): pid=1289 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=25 res=1 Oct 13 04:54:05.590221 sshd[1289]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:05.595265 systemd-logind[917]: New session 25 of user core. Oct 13 04:54:05.600982 systemd[1]: Started Session 25 of User core. Oct 13 04:54:05.668502 sshd[1289]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:05.670408 systemd[1]: sshd@24-10.0.0.7:22-10.0.0.1:34420.service: Deactivated successfully. Oct 13 04:54:05.671053 systemd[1]: session-25.scope: Deactivated successfully. Oct 13 04:54:05.671747 systemd-logind[917]: Session 25 logged out. Waiting for processes to exit. Oct 13 04:54:05.672628 systemd-logind[917]: Removed session 25. Oct 13 04:54:07.424226 update_engine[1269]: I1013 04:54:07.424171 1269 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Oct 13 04:54:07.424226 update_engine[1269]: I1013 04:54:07.424226 1269 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Oct 13 04:54:07.489810 update_engine[1269]: E1013 04:54:07.489768 1269 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Oct 13 04:54:07.489810 update_engine[1269]: I1013 04:54:07.489807 1269 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Oct 13 04:54:07.489810 update_engine[1269]: I1013 04:54:07.489811 1269 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Oct 13 04:54:07.489810 update_engine[1269]: I1013 04:54:07.489814 1269 update_attempter.cc:302] Processing Done. Oct 13 04:54:07.489942 update_engine[1269]: E1013 04:54:07.489871 1269 update_attempter.cc:615] Update failed. Oct 13 04:54:07.489942 update_engine[1269]: I1013 04:54:07.489876 1269 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Oct 13 04:54:07.489942 update_engine[1269]: I1013 04:54:07.489881 1269 payload_state.cc:276] Incrementing the URL failure count Oct 13 04:54:07.489942 update_engine[1269]: I1013 04:54:07.489884 1269 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 13 04:54:07.490216 update_engine[1269]: I1013 04:54:07.490171 1269 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 13 04:54:07.490246 update_engine[1269]: I1013 04:54:07.490219 1269 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.6:34567/v1/update Oct 13 04:54:07.490246 update_engine[1269]: I1013 04:54:07.490224 1269 omaha_request_action.cc:269] Request: Oct 13 04:54:07.490246 update_engine[1269]: Oct 13 04:54:07.490246 update_engine[1269]: Oct 13 04:54:07.490246 update_engine[1269]: Oct 13 04:54:07.490246 update_engine[1269]: Oct 13 04:54:07.490246 update_engine[1269]: Oct 13 04:54:07.490246 update_engine[1269]: Oct 13 04:54:07.490246 update_engine[1269]: I1013 04:54:07.490229 1269 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 13 04:54:07.490404 update_engine[1269]: I1013 04:54:07.490286 1269 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 13 04:54:07.490404 update_engine[1269]: I1013 04:54:07.490394 1269 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 13 04:54:07.684505 update_engine[1269]: I1013 04:54:07.684406 1269 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 13 04:54:07.685246 update_engine[1269]: I1013 04:54:07.685216 1269 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Oct 13 04:54:07.685246 update_engine[1269]: I1013 04:54:07.685235 1269 omaha_request_action.cc:619] Omaha request response: Oct 13 04:54:07.685246 update_engine[1269]: Oct 13 04:54:07.685246 update_engine[1269]: Oct 13 04:54:07.685246 update_engine[1269]: Oct 13 04:54:07.685246 update_engine[1269]: Oct 13 04:54:07.685246 update_engine[1269]: Oct 13 04:54:07.685246 update_engine[1269]: Oct 13 04:54:07.685246 update_engine[1269]: E1013 04:54:07.685248 1269 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Oct 13 04:54:07.685433 update_engine[1269]: I1013 04:54:07.685254 1269 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 13 04:54:07.685433 update_engine[1269]: I1013 04:54:07.685257 1269 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 13 04:54:07.685433 update_engine[1269]: I1013 04:54:07.685259 1269 update_attempter.cc:302] Processing Done. Oct 13 04:54:07.685433 update_engine[1269]: I1013 04:54:07.685266 1269 update_attempter.cc:306] Error event sent. Oct 13 04:54:15.677811 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38544). Oct 13 04:54:15.713723 sshd[1303]: Accepted publickey for core from 10.0.0.1 port 38544 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:15.717420 kernel: audit: type=1006 audit(1760331255.714:365): pid=1303 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 13 04:54:15.717387 sshd[1303]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:15.722001 systemd-logind[917]: New session 26 of user core. Oct 13 04:54:15.728339 systemd[1]: Started Session 26 of User core. Oct 13 04:54:15.785737 sshd[1303]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:15.798966 systemd[1]: sshd@25-10.0.0.7:22-10.0.0.1:38544.service: Deactivated successfully. Oct 13 04:54:15.799564 systemd[1]: session-26.scope: Deactivated successfully. Oct 13 04:54:15.800294 systemd-logind[917]: Session 26 logged out. Waiting for processes to exit. Oct 13 04:54:15.801223 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38550). Oct 13 04:54:15.802276 systemd-logind[917]: Removed session 26. Oct 13 04:54:15.834196 sshd[1310]: Accepted publickey for core from 10.0.0.1 port 38550 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:15.835611 sshd[1310]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:15.837668 kernel: audit: type=1006 audit(1760331255.834:366): pid=1310 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 13 04:54:15.840462 systemd-logind[917]: New session 27 of user core. Oct 13 04:54:15.847365 systemd[1]: Started Session 27 of User core. Oct 13 04:54:15.905255 sshd[1310]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:15.916369 systemd[1]: sshd@26-10.0.0.7:22-10.0.0.1:38550.service: Deactivated successfully. Oct 13 04:54:15.917095 systemd[1]: session-27.scope: Deactivated successfully. Oct 13 04:54:15.917958 systemd-logind[917]: Session 27 logged out. Waiting for processes to exit. Oct 13 04:54:15.919204 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38566). Oct 13 04:54:15.920461 systemd-logind[917]: Removed session 27. Oct 13 04:54:15.951658 sshd[1318]: Accepted publickey for core from 10.0.0.1 port 38566 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:15.953107 sshd[1318]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:15.955198 kernel: audit: type=1006 audit(1760331255.951:367): pid=1318 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 13 04:54:15.956600 systemd-logind[917]: New session 28 of user core. Oct 13 04:54:15.966369 systemd[1]: Started Session 28 of User core. Oct 13 04:54:16.017300 sshd[1318]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:16.024042 systemd[1]: sshd@27-10.0.0.7:22-10.0.0.1:38566.service: Deactivated successfully. Oct 13 04:54:16.024742 systemd[1]: session-28.scope: Deactivated successfully. Oct 13 04:54:16.025536 systemd-logind[917]: Session 28 logged out. Waiting for processes to exit. Oct 13 04:54:16.026775 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38578). Oct 13 04:54:16.027919 systemd-logind[917]: Removed session 28. Oct 13 04:54:16.059222 sshd[1324]: Accepted publickey for core from 10.0.0.1 port 38578 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:16.061910 sshd[1324]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:16.062200 kernel: audit: type=1006 audit(1760331256.059:368): pid=1324 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 13 04:54:16.065953 systemd-logind[917]: New session 29 of user core. Oct 13 04:54:16.078352 systemd[1]: Started Session 29 of User core. Oct 13 04:54:16.134593 sshd[1324]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:16.144067 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38592). Oct 13 04:54:16.146415 systemd[1]: sshd@28-10.0.0.7:22-10.0.0.1:38578.service: Deactivated successfully. Oct 13 04:54:16.147014 systemd[1]: session-29.scope: Deactivated successfully. Oct 13 04:54:16.148838 systemd-logind[917]: Session 29 logged out. Waiting for processes to exit. Oct 13 04:54:16.150096 systemd-logind[917]: Removed session 29. Oct 13 04:54:16.177162 sshd[1329]: Accepted publickey for core from 10.0.0.1 port 38592 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:16.178254 sshd[1329]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:16.180207 kernel: audit: type=1006 audit(1760331256.176:369): pid=1329 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=30 res=1 Oct 13 04:54:16.183777 systemd-logind[917]: New session 30 of user core. Oct 13 04:54:16.192636 systemd[1]: Started Session 30 of User core. Oct 13 04:54:16.247535 sudo[1334]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Oct 13 04:54:16.247743 sudo[1334]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 13 04:54:16.254083 systemd[1]: sshd.socket: Deactivated successfully. Oct 13 04:54:16.254434 systemd[1]: Closed OpenSSH Server Socket. Oct 13 04:54:16.255807 sudo[1334]: pam_unix(sudo:session): session closed for user root Oct 13 04:54:16.259444 sudo[1333]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Oct 13 04:54:16.259685 sudo[1333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 13 04:54:16.278351 sshd[952]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:16.284112 systemd[1]: Stopping Session 1 of User core... Oct 13 04:54:16.285252 sshd[1329]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:16.286141 systemd[1]: Stopping Session 30 of User core... Oct 13 04:54:16.286774 sudo[1333]: pam_unix(sudo:session): session closed for user root Oct 13 04:54:16.288453 systemd[1]: Removed slice Slice /system/addon-config. Oct 13 04:54:16.290441 systemd[1]: Removed slice Slice /system/addon-run. Oct 13 04:54:16.292486 systemd[1]: Removed slice Slice /system/modprobe. Oct 13 04:54:16.293386 systemd[1]: Removed slice Slice /system/system-cloudinit. Oct 13 04:54:16.294140 systemd[1]: Stopped target Multi-User System. Oct 13 04:54:16.294869 systemd[1]: Stopped target Login Prompts. Oct 13 04:54:16.295444 systemd[1]: Stopped target Containers. Oct 13 04:54:16.295979 systemd[1]: Stopped target Host and Network Name Lookups. Oct 13 04:54:16.296693 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 13 04:54:16.297357 systemd[1]: Stopped target Timer Units. Oct 13 04:54:16.297877 systemd[1]: logrotate.timer: Deactivated successfully. Oct 13 04:54:16.297920 systemd[1]: Stopped Daily Log Rotation. Oct 13 04:54:16.298558 systemd[1]: mdadm.timer: Deactivated successfully. Oct 13 04:54:16.298593 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Oct 13 04:54:16.299348 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Oct 13 04:54:16.299386 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Oct 13 04:54:16.300067 systemd[1]: Stopped target System Time Set. Oct 13 04:54:16.300680 systemd[1]: Stopped target Load user-provided cloud configs. Oct 13 04:54:16.301616 systemd[1]: Stopped target Load system-provided cloud configs. Oct 13 04:54:16.302519 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 13 04:54:16.302605 systemd[1]: Closed Process Core Dump Socket. Oct 13 04:54:16.303893 systemd[1]: Unmounting Boot partition... Oct 13 04:54:16.304787 systemd[1]: Stopping Getty on tty1... Oct 13 04:54:16.305426 systemd[1]: Stopping Serial Getty on ttyAMA0... Oct 13 04:54:16.306431 systemd[1]: Stopping OpenSSH per-connection server daemon... Oct 13 04:54:16.307064 sshd[1329]: pam_systemd(sshd:session): Failed to release session: Interrupted system call Oct 13 04:54:16.307120 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:38592)... Oct 13 04:54:16.307898 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Oct 13 04:54:16.308021 systemd[1]: Stopped Commit a transient machine-id on disk. Oct 13 04:54:16.308804 systemd[1]: Stopped target First Boot Complete. Oct 13 04:54:16.318608 systemd[1]: Stopping Load/Save Random Seed... Oct 13 04:54:16.319455 systemd[1]: Stopping Update Engine... Oct 13 04:54:16.323575 systemd[1]: getty@tty1.service: Deactivated successfully. Oct 13 04:54:16.323763 systemd[1]: Stopped Getty on tty1. Oct 13 04:54:16.325311 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Oct 13 04:54:16.325484 systemd[1]: Stopped Serial Getty on ttyAMA0. Oct 13 04:54:16.327973 systemd[1]: sshd@0-10.0.0.7:22-10.0.0.1:58306.service: Deactivated successfully. Oct 13 04:54:16.328186 systemd[1]: Stopped OpenSSH per-connection server daemon. Oct 13 04:54:16.329368 systemd[1]: sshd@29-10.0.0.7:22-10.0.0.1:38592.service: Deactivated successfully. Oct 13 04:54:16.329542 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:38592). Oct 13 04:54:16.331117 systemd[1]: session-30.scope: Deactivated successfully. Oct 13 04:54:16.331341 systemd[1]: Stopped Session 30 of User core. Oct 13 04:54:16.332423 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 13 04:54:16.332492 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 13 04:54:16.332733 systemd[1]: Stopped Update Engine. Oct 13 04:54:16.333335 systemd[1]: update-engine.service: Consumed 2.418s CPU time. Oct 13 04:54:16.333601 systemd[1]: systemd-random-seed.service: Deactivated successfully. Oct 13 04:54:16.333791 systemd[1]: Stopped Load/Save Random Seed. Oct 13 04:54:16.334781 systemd[1]: session-1.scope: Deactivated successfully. Oct 13 04:54:16.335004 systemd[1]: Stopped Session 1 of User core. Oct 13 04:54:16.336354 systemd-logind[917]: Session 1 logged out. Waiting for processes to exit. Oct 13 04:54:16.337669 systemd-logind[917]: Session 30 logged out. Waiting for processes to exit. Oct 13 04:54:16.341544 systemd[1]: Removed slice Slice /system/getty. Oct 13 04:54:16.342530 systemd[1]: Removed slice Slice /system/serial-getty. Oct 13 04:54:16.343523 systemd[1]: Removed slice Slice /system/sshd. Oct 13 04:54:16.344153 systemd[1]: sshd-keygen.service: Deactivated successfully. Oct 13 04:54:16.344330 systemd[1]: Stopped Generate sshd host keys. Oct 13 04:54:16.345277 systemd[1]: Stopping User Login Management... Oct 13 04:54:16.345913 systemd[1]: Stopping User Manager for UID 500... Oct 13 04:54:16.347388 systemd-logind[917]: Removed session 1. Oct 13 04:54:16.348551 systemd[955]: Stopped target Main User Target. Oct 13 04:54:16.348572 systemd[955]: Stopped target Basic System. Oct 13 04:54:16.348583 systemd[955]: Stopped target Paths. Oct 13 04:54:16.348592 systemd[955]: Stopped target Sockets. Oct 13 04:54:16.348609 systemd[955]: Reached target Shutdown. Oct 13 04:54:16.348617 systemd[955]: Stopped target Timers. Oct 13 04:54:16.348729 systemd[955]: Finished Exit the Session. Oct 13 04:54:16.348754 systemd[955]: Reached target Exit the Session. Oct 13 04:54:16.351894 systemd[1]: user@500.service: Deactivated successfully. Oct 13 04:54:16.352067 systemd[1]: Stopped User Manager for UID 500. Oct 13 04:54:16.353266 systemd[1]: boot.mount: Deactivated successfully. Oct 13 04:54:16.353497 systemd[1]: Unmounted Boot partition. Oct 13 04:54:16.354299 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Oct 13 04:54:16.354355 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Oct 13 04:54:16.355807 systemd[1]: Stopping User Runtime Directory /run/user/500... Oct 13 04:54:16.359089 systemd[1]: systemd-logind.service: Deactivated successfully. Oct 13 04:54:16.359409 systemd[1]: Stopped User Login Management. Oct 13 04:54:16.361506 systemd[1]: run-user-500.mount: Deactivated successfully. Oct 13 04:54:16.361563 systemd[1]: Unmounted /run/user/500. Oct 13 04:54:16.362454 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Oct 13 04:54:16.362653 systemd[1]: Stopped User Runtime Directory /run/user/500. Oct 13 04:54:16.364035 systemd[1]: Removed slice User Slice of UID 500. Oct 13 04:54:16.365453 systemd[1]: Stopping D-Bus System Message Bus... Oct 13 04:54:16.365000 audit: BPF prog-id=56 op=UNLOAD Oct 13 04:54:16.367359 kernel: audit: type=1334 audit(1760331256.365:370): prog-id=56 op=UNLOAD Oct 13 04:54:16.367022 systemd[1]: Stopping Permit User Sessions... Oct 13 04:54:16.370525 systemd[1]: dbus.service: Deactivated successfully. Oct 13 04:54:16.370785 systemd[1]: Stopped D-Bus System Message Bus. Oct 13 04:54:16.371666 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Oct 13 04:54:16.371886 systemd[1]: Stopped Permit User Sessions. Oct 13 04:54:16.372577 systemd[1]: Stopped target Basic System. Oct 13 04:54:16.373102 systemd[1]: Stopped target Network. Oct 13 04:54:16.373630 systemd[1]: Stopped target Path Units. Oct 13 04:54:16.374115 systemd[1]: motdgen.path: Deactivated successfully. Oct 13 04:54:16.377223 systemd[1]: Stopped Watch for update engine configuration changes. Oct 13 04:54:16.377964 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Oct 13 04:54:16.381242 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 13 04:54:16.382011 systemd[1]: Stopped target Remote File Systems. Oct 13 04:54:16.382621 systemd[1]: Stopped target Slice Units. Oct 13 04:54:16.383411 systemd[1]: Removed slice User and Session Slice. Oct 13 04:54:16.384009 systemd[1]: Stopped target Socket Units. Oct 13 04:54:16.384602 systemd[1]: dbus.socket: Deactivated successfully. Oct 13 04:54:16.384654 systemd[1]: Closed D-Bus System Message Bus Socket. Oct 13 04:54:16.385371 systemd[1]: docker.socket: Deactivated successfully. Oct 13 04:54:16.385600 systemd[1]: Closed Docker Socket for the API. Oct 13 04:54:16.386194 systemd[1]: Stopped target System Initialization. Oct 13 04:54:16.386774 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Oct 13 04:54:16.386901 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Oct 13 04:54:16.387712 systemd[1]: Stopped target Local Verity Protected Volumes. Oct 13 04:54:16.389230 systemd[1]: Stopping Load Security Auditing Rules... Oct 13 04:54:16.389919 systemd[1]: Stopping Network Name Resolution... Oct 13 04:54:16.390653 systemd[1]: Stopping Network Time Synchronization... Oct 13 04:54:16.391413 systemd[1]: systemd-update-done.service: Deactivated successfully. Oct 13 04:54:16.391480 systemd[1]: Stopped Update is Completed. Oct 13 04:54:16.392097 systemd[1]: ldconfig.service: Deactivated successfully. Oct 13 04:54:16.392148 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Oct 13 04:54:16.392202 auditctl[1350]: No rules Oct 13 04:54:16.392847 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Oct 13 04:54:16.392908 systemd[1]: Stopped Rebuild Hardware Database. Oct 13 04:54:16.393638 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Oct 13 04:54:16.393694 systemd[1]: Stopped Rebuild Journal Catalog. Oct 13 04:54:16.395070 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Oct 13 04:54:16.398513 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 13 04:54:16.398776 systemd[1]: Stopped Network Name Resolution. Oct 13 04:54:16.399687 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Oct 13 04:54:16.399923 systemd[1]: Stopped Network Time Synchronization. Oct 13 04:54:16.400876 systemd[1]: audit-rules.service: Deactivated successfully. Oct 13 04:54:16.401075 systemd[1]: Stopped Load Security Auditing Rules. Oct 13 04:54:16.403169 systemd[1]: Stopping Network Configuration... Oct 13 04:54:16.403928 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Oct 13 04:54:16.404147 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Oct 13 04:54:16.405457 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 13 04:54:16.405555 systemd[1]: Stopped Create Volatile Files and Directories. Oct 13 04:54:16.406612 systemd[1]: Stopped target Local File Systems. Oct 13 04:54:16.407239 systemd-networkd[839]: eth0: DHCPv6 lease lost Oct 13 04:54:16.421000 audit: BPF prog-id=63 op=UNLOAD Oct 13 04:54:16.421000 audit: BPF prog-id=59 op=UNLOAD Oct 13 04:54:16.423143 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Oct 13 04:54:16.423472 kernel: audit: type=1334 audit(1760331256.421:371): prog-id=63 op=UNLOAD Oct 13 04:54:16.423526 kernel: audit: type=1334 audit(1760331256.421:372): prog-id=59 op=UNLOAD Oct 13 04:54:16.424711 systemd[1]: Unmounting External Media Directory... Oct 13 04:54:16.426230 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Oct 13 04:54:16.427720 systemd[1]: Unmounting /run/torcx/unpack... Oct 13 04:54:16.428810 systemd[1]: Unmounting Temporary Directory /tmp... Oct 13 04:54:16.429964 systemd[1]: Unmounting /usr/share/oem... Oct 13 04:54:16.431464 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Oct 13 04:54:16.433864 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 13 04:54:16.434116 systemd[1]: Stopped Network Configuration. Oct 13 04:54:16.435002 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 13 04:54:16.435276 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Oct 13 04:54:16.436297 systemd[1]: media.mount: Deactivated successfully. Oct 13 04:54:16.436530 systemd[1]: Unmounted External Media Directory. Oct 13 04:54:16.437438 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Oct 13 04:54:16.437653 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Oct 13 04:54:16.438689 systemd[1]: tmp.mount: Deactivated successfully. Oct 13 04:54:16.438955 systemd[1]: Unmounted Temporary Directory /tmp. Oct 13 04:54:16.439701 systemd[1]: usr-share-oem.mount: Deactivated successfully. Oct 13 04:54:16.439959 systemd[1]: Unmounted /usr/share/oem. Oct 13 04:54:16.440657 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 13 04:54:16.440890 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Oct 13 04:54:16.440000 audit: BPF prog-id=64 op=UNLOAD Oct 13 04:54:16.442143 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 13 04:54:16.442221 systemd[1]: Closed Network Service Netlink Socket. Oct 13 04:54:16.443323 kernel: audit: type=1334 audit(1760331256.440:373): prog-id=64 op=UNLOAD Oct 13 04:54:16.443482 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Oct 13 04:54:16.443612 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Oct 13 04:54:16.444643 systemd[1]: Removed slice Slice /system/systemd-fsck. Oct 13 04:54:16.445391 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 13 04:54:16.445511 systemd[1]: Stopped Apply Kernel Variables. Oct 13 04:54:16.449030 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Oct 13 04:54:16.449378 systemd[1]: Unmounted /run/torcx/unpack. Oct 13 04:54:16.450166 systemd[1]: Stopped target Preparation for Local File Systems. Oct 13 04:54:16.450956 systemd[1]: Stopped target Swaps. Oct 13 04:54:16.451649 systemd[1]: Reached target Unmount All Filesystems. Oct 13 04:54:16.452347 systemd[1]: lvm2-activation.service: Deactivated successfully. Oct 13 04:54:16.452475 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 13 04:54:16.453207 systemd[1]: Stopped target Local Encrypted Volumes. Oct 13 04:54:16.453918 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 13 04:54:16.454074 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 13 04:54:16.455213 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Oct 13 04:54:16.459452 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Oct 13 04:54:16.460335 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Oct 13 04:54:16.460489 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 13 04:54:16.461227 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 13 04:54:16.461347 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 13 04:54:16.462077 systemd[1]: systemd-sysusers.service: Deactivated successfully. Oct 13 04:54:16.462296 systemd[1]: Stopped Create System Users. Oct 13 04:54:16.462977 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Oct 13 04:54:16.463099 systemd[1]: Stopped Remount Root and Kernel File Systems. Oct 13 04:54:16.463867 systemd[1]: Reached target System Shutdown. Oct 13 04:54:16.464541 systemd[1]: Reached target Late Shutdown Services. Oct 13 04:54:16.465278 systemd[1]: systemd-reboot.service: Deactivated successfully. Oct 13 04:54:16.465382 systemd[1]: Finished System Reboot. Oct 13 04:54:16.465966 systemd[1]: Reached target System Reboot. Oct 13 04:54:16.467331 systemd[1]: Shutting down. Oct 13 04:54:16.467000 audit: BPF prog-id=58 op=UNLOAD Oct 13 04:54:16.467000 audit: BPF prog-id=57 op=UNLOAD Oct 13 04:54:16.469197 kernel: audit: type=1334 audit(1760331256.467:374): prog-id=58 op=UNLOAD Oct 13 04:54:16.469000 audit: BPF prog-id=62 op=UNLOAD Oct 13 04:54:16.469000 audit: BPF prog-id=61 op=UNLOAD Oct 13 04:54:16.469000 audit: BPF prog-id=60 op=UNLOAD Oct 13 04:54:16.470000 audit: BPF prog-id=67 op=UNLOAD Oct 13 04:54:16.470000 audit: BPF prog-id=66 op=UNLOAD Oct 13 04:54:16.470000 audit: BPF prog-id=65 op=UNLOAD Oct 13 04:54:16.514204 systemd-shutdown[1]: Syncing filesystems and block devices. Oct 13 04:54:16.519701 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Oct 13 04:54:16.519766 systemd-journald[801]: Journal stopped -- Reboot -- Oct 13 04:54:23.672323 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 13 04:54:23.672340 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 13 04:54:23.672357 kernel: efi: EFI v2.70 by EDK II Oct 13 04:54:23.672363 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 13 04:54:23.672368 kernel: efi: seeding entropy pool Oct 13 04:54:23.672374 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 13 04:54:23.672380 kernel: ACPI: Early table checksum verification disabled Oct 13 04:54:23.672385 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 13 04:54:23.672390 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 13 04:54:23.672395 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:54:23.672402 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:54:23.672406 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:54:23.672411 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:54:23.672416 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:54:23.672423 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:54:23.672428 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:54:23.672435 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:54:23.672441 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 04:54:23.672446 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 13 04:54:23.672451 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 13 04:54:23.672457 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 13 04:54:23.672462 kernel: NUMA: NODE_DATA [mem 0xdc959900-0xdc95efff] Oct 13 04:54:23.672468 kernel: Zone ranges: Oct 13 04:54:23.672473 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 13 04:54:23.672478 kernel: DMA32 empty Oct 13 04:54:23.672483 kernel: Normal empty Oct 13 04:54:23.672489 kernel: Movable zone start for each node Oct 13 04:54:23.672495 kernel: Early memory node ranges Oct 13 04:54:23.672500 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 13 04:54:23.672505 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 13 04:54:23.672511 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 13 04:54:23.672516 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 13 04:54:23.672521 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 13 04:54:23.672526 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 13 04:54:23.672531 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 13 04:54:23.672537 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 13 04:54:23.672542 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 13 04:54:23.672547 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 13 04:54:23.672552 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 13 04:54:23.672557 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 13 04:54:23.672566 kernel: On node 0 totalpages: 643072 Oct 13 04:54:23.672572 kernel: DMA zone: 10048 pages used for memmap Oct 13 04:54:23.672577 kernel: DMA zone: 0 pages reserved Oct 13 04:54:23.672583 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 13 04:54:23.672588 kernel: psci: probing for conduit method from ACPI. Oct 13 04:54:23.672594 kernel: psci: PSCIv1.1 detected in firmware. Oct 13 04:54:23.672599 kernel: psci: Using standard PSCI v0.2 function IDs Oct 13 04:54:23.672605 kernel: psci: Trusted OS migration not required Oct 13 04:54:23.672611 kernel: psci: SMC Calling Convention v1.1 Oct 13 04:54:23.672617 kernel: ACPI: SRAT not present Oct 13 04:54:23.672623 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 13 04:54:23.672628 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 13 04:54:23.672634 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 13 04:54:23.672639 kernel: Detected PIPT I-cache on CPU0 Oct 13 04:54:23.672645 kernel: CPU features: detected: GIC system register CPU interface Oct 13 04:54:23.672650 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 13 04:54:23.672656 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 13 04:54:23.672661 kernel: CPU features: detected: Hardware dirty bit management Oct 13 04:54:23.672667 kernel: CPU features: detected: Spectre-v4 Oct 13 04:54:23.672674 kernel: CPU features: detected: ARM erratum 1418040 Oct 13 04:54:23.672679 kernel: CPU features: detected: Spectre-BHB Oct 13 04:54:23.672685 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 13 04:54:23.672690 kernel: Policy zone: DMA Oct 13 04:54:23.672697 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 13 04:54:23.672703 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 13 04:54:23.672708 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 13 04:54:23.672714 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 13 04:54:23.672720 kernel: Memory: 2452096K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120192K reserved, 0K cma-reserved) Oct 13 04:54:23.672726 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 13 04:54:23.672731 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 13 04:54:23.672738 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 13 04:54:23.672744 kernel: rcu: RCU event tracing is enabled. Oct 13 04:54:23.672750 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 13 04:54:23.672756 kernel: Trampoline variant of Tasks RCU enabled. Oct 13 04:54:23.672761 kernel: Tracing variant of Tasks RCU enabled. Oct 13 04:54:23.672767 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 13 04:54:23.672773 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 13 04:54:23.672778 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 13 04:54:23.672784 kernel: GICv3: 256 SPIs implemented Oct 13 04:54:23.672789 kernel: GICv3: 0 Extended SPIs implemented Oct 13 04:54:23.672795 kernel: GICv3: Distributor has no Range Selector support Oct 13 04:54:23.672800 kernel: GICv3: 16 PPIs implemented Oct 13 04:54:23.672807 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 13 04:54:23.672812 kernel: ACPI: SRAT not present Oct 13 04:54:23.672818 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 13 04:54:23.672823 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 13 04:54:23.672829 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 13 04:54:23.672835 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 13 04:54:23.672840 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 13 04:54:23.672846 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 04:54:23.672852 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 13 04:54:23.672858 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 13 04:54:23.672863 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 13 04:54:23.672869 kernel: arm-pv: using stolen time PV Oct 13 04:54:23.672876 kernel: Console: colour dummy device 80x25 Oct 13 04:54:23.672882 kernel: ACPI: Core revision 20200925 Oct 13 04:54:23.672888 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 13 04:54:23.672893 kernel: pid_max: default: 32768 minimum: 301 Oct 13 04:54:23.672899 kernel: LSM: Security Framework initializing Oct 13 04:54:23.672905 kernel: SELinux: Initializing. Oct 13 04:54:23.672911 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 13 04:54:23.672917 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 13 04:54:23.672922 kernel: rcu: Hierarchical SRCU implementation. Oct 13 04:54:23.672929 kernel: Platform MSI: ITS@0x8080000 domain created Oct 13 04:54:23.672935 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 13 04:54:23.672940 kernel: Remapping and enabling EFI services. Oct 13 04:54:23.672946 kernel: smp: Bringing up secondary CPUs ... Oct 13 04:54:23.672952 kernel: Detected PIPT I-cache on CPU1 Oct 13 04:54:23.672958 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 13 04:54:23.672964 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 13 04:54:23.672969 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 04:54:23.672975 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 13 04:54:23.672981 kernel: Detected PIPT I-cache on CPU2 Oct 13 04:54:23.672988 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 13 04:54:23.672994 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 13 04:54:23.673000 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 04:54:23.673006 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 13 04:54:23.673012 kernel: Detected PIPT I-cache on CPU3 Oct 13 04:54:23.673022 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 13 04:54:23.673028 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 13 04:54:23.673035 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 04:54:23.673041 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 13 04:54:23.673047 kernel: smp: Brought up 1 node, 4 CPUs Oct 13 04:54:23.673053 kernel: SMP: Total of 4 processors activated. Oct 13 04:54:23.673059 kernel: CPU features: detected: Privileged Access Never Oct 13 04:54:23.673065 kernel: CPU features: detected: LSE atomic instructions Oct 13 04:54:23.673071 kernel: CPU features: detected: User Access Override Oct 13 04:54:23.673077 kernel: CPU features: detected: 32-bit EL0 Support Oct 13 04:54:23.673083 kernel: CPU features: detected: Common not Private translations Oct 13 04:54:23.673089 kernel: CPU features: detected: RAS Extension Support Oct 13 04:54:23.673097 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 13 04:54:23.673103 kernel: CPU features: detected: CRC32 instructions Oct 13 04:54:23.673109 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 13 04:54:23.673115 kernel: CPU: All CPU(s) started at EL1 Oct 13 04:54:23.673121 kernel: alternatives: patching kernel code Oct 13 04:54:23.673128 kernel: devtmpfs: initialized Oct 13 04:54:23.673134 kernel: KASLR enabled Oct 13 04:54:23.673140 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 13 04:54:23.673147 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 13 04:54:23.673152 kernel: pinctrl core: initialized pinctrl subsystem Oct 13 04:54:23.673159 kernel: SMBIOS 3.0.0 present. Oct 13 04:54:23.673165 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 13 04:54:23.673171 kernel: NET: Registered protocol family 16 Oct 13 04:54:23.673177 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 13 04:54:23.673184 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 13 04:54:23.673191 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 13 04:54:23.673222 kernel: audit: initializing netlink subsys (disabled) Oct 13 04:54:23.673229 kernel: audit: type=2000 audit(0.029:1): state=initialized audit_enabled=0 res=1 Oct 13 04:54:23.673235 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 13 04:54:23.673241 kernel: cpuidle: using governor menu Oct 13 04:54:23.673247 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 13 04:54:23.673253 kernel: ASID allocator initialised with 32768 entries Oct 13 04:54:23.673259 kernel: ACPI: bus type PCI registered Oct 13 04:54:23.673265 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 13 04:54:23.673273 kernel: Serial: AMBA PL011 UART driver Oct 13 04:54:23.673279 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 13 04:54:23.673286 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 13 04:54:23.673292 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 13 04:54:23.673298 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 13 04:54:23.673304 kernel: cryptd: max_cpu_qlen set to 1000 Oct 13 04:54:23.673310 kernel: ACPI: Added _OSI(Module Device) Oct 13 04:54:23.673316 kernel: ACPI: Added _OSI(Processor Device) Oct 13 04:54:23.673322 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 13 04:54:23.673329 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 13 04:54:23.673335 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 13 04:54:23.673341 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 13 04:54:23.673351 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 13 04:54:23.673358 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 13 04:54:23.673365 kernel: ACPI: Interpreter enabled Oct 13 04:54:23.673371 kernel: ACPI: Using GIC for interrupt routing Oct 13 04:54:23.673377 kernel: ACPI: MCFG table detected, 1 entries Oct 13 04:54:23.673383 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 13 04:54:23.673389 kernel: printk: console [ttyAMA0] enabled Oct 13 04:54:23.673397 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 13 04:54:23.673505 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 13 04:54:23.673563 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 13 04:54:23.673616 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 13 04:54:23.673668 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 13 04:54:23.673720 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 13 04:54:23.673728 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 13 04:54:23.673735 kernel: PCI host bridge to bus 0000:00 Oct 13 04:54:23.673792 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 13 04:54:23.673840 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 13 04:54:23.673888 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 13 04:54:23.673935 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 13 04:54:23.674000 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 13 04:54:23.674068 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 13 04:54:23.674127 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 13 04:54:23.674182 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 13 04:54:23.674245 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 13 04:54:23.674300 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 13 04:54:23.674361 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 13 04:54:23.674424 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 13 04:54:23.674478 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 13 04:54:23.674530 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 13 04:54:23.674579 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 13 04:54:23.674587 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 13 04:54:23.674593 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 13 04:54:23.674599 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 13 04:54:23.674606 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 13 04:54:23.674612 kernel: vgaarb: loaded Oct 13 04:54:23.674618 kernel: Registered efivars operations Oct 13 04:54:23.674625 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 13 04:54:23.674632 kernel: VFS: Disk quotas dquot_6.6.0 Oct 13 04:54:23.674639 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 13 04:54:23.674645 kernel: pnp: PnP ACPI init Oct 13 04:54:23.674707 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 13 04:54:23.674756 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 13 04:54:23.674764 kernel: pnp: PnP ACPI: found 1 devices Oct 13 04:54:23.674770 kernel: NET: Registered protocol family 2 Oct 13 04:54:23.674776 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 13 04:54:23.674784 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 13 04:54:23.674790 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 13 04:54:23.674797 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 13 04:54:23.674803 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 13 04:54:23.674809 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 13 04:54:23.674815 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 13 04:54:23.674821 kernel: NET: Registered protocol family 1 Oct 13 04:54:23.674827 kernel: PCI: CLS 0 bytes, default 64 Oct 13 04:54:23.674833 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 13 04:54:23.674840 kernel: kvm [1]: HYP mode not available Oct 13 04:54:23.674847 kernel: Initialise system trusted keyrings Oct 13 04:54:23.674853 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 13 04:54:23.674859 kernel: Key type asymmetric registered Oct 13 04:54:23.674864 kernel: Asymmetric key parser 'x509' registered Oct 13 04:54:23.674871 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 13 04:54:23.674877 kernel: io scheduler mq-deadline registered Oct 13 04:54:23.674883 kernel: io scheduler kyber registered Oct 13 04:54:23.674889 kernel: io scheduler bfq registered Oct 13 04:54:23.674896 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 13 04:54:23.674902 kernel: ACPI: Power Button [PWRB] Oct 13 04:54:23.674908 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 13 04:54:23.674960 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 13 04:54:23.674968 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 13 04:54:23.674974 kernel: msm_serial: driver initialized Oct 13 04:54:23.674980 kernel: random: fast init done Oct 13 04:54:23.674986 kernel: random: crng init done Oct 13 04:54:23.674992 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 13 04:54:23.674999 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 13 04:54:23.675006 kernel: thunder_xcv, ver 1.0 Oct 13 04:54:23.675012 kernel: thunder_bgx, ver 1.0 Oct 13 04:54:23.675019 kernel: nicpf, ver 1.0 Oct 13 04:54:23.675024 kernel: nicvf, ver 1.0 Oct 13 04:54:23.675084 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 13 04:54:23.675135 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-13T04:54:23 UTC (1760331263) Oct 13 04:54:23.675143 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 13 04:54:23.675149 kernel: NET: Registered protocol family 10 Oct 13 04:54:23.675156 kernel: Segment Routing with IPv6 Oct 13 04:54:23.675162 kernel: NET: Registered protocol family 17 Oct 13 04:54:23.675169 kernel: Key type dns_resolver registered Oct 13 04:54:23.675175 kernel: registered taskstats version 1 Oct 13 04:54:23.675181 kernel: Loading compiled-in X.509 certificates Oct 13 04:54:23.675188 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 13 04:54:23.675204 kernel: Key type ._fscrypt registered Oct 13 04:54:23.675210 kernel: Key type .fscrypt registered Oct 13 04:54:23.675216 kernel: Key type fscrypt-provisioning registered Oct 13 04:54:23.675225 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 13 04:54:23.675231 kernel: ima: Allocated hash algorithm: sha1 Oct 13 04:54:23.675237 kernel: ima: No architecture policies found Oct 13 04:54:23.675243 kernel: Freeing unused kernel memory: 34240K Oct 13 04:54:23.675249 kernel: Run /init as init process Oct 13 04:54:23.675255 kernel: with arguments: Oct 13 04:54:23.675261 kernel: /init Oct 13 04:54:23.675267 kernel: with environment: Oct 13 04:54:23.675273 kernel: HOME=/ Oct 13 04:54:23.675278 kernel: TERM=linux Oct 13 04:54:23.675286 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 13 04:54:23.675294 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 13 04:54:23.675302 systemd[1]: Detected virtualization kvm. Oct 13 04:54:23.675309 systemd[1]: Detected architecture arm64. Oct 13 04:54:23.675315 systemd[1]: Running in initial RAM disk. Oct 13 04:54:23.675321 systemd[1]: No hostname configured, using default hostname. Oct 13 04:54:23.675327 systemd[1]: Hostname set to . Oct 13 04:54:23.675335 systemd[1]: Initializing machine ID from VM UUID. Oct 13 04:54:23.675342 systemd[1]: Queued start job for default target Initrd Default Target. Oct 13 04:54:23.675353 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 13 04:54:23.675360 systemd[1]: Reached target Local Encrypted Volumes. Oct 13 04:54:23.675366 systemd[1]: Reached target Path Units. Oct 13 04:54:23.675372 systemd[1]: Reached target Slice Units. Oct 13 04:54:23.675378 systemd[1]: Reached target Swaps. Oct 13 04:54:23.675385 systemd[1]: Reached target Timer Units. Oct 13 04:54:23.675393 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 13 04:54:23.675399 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 13 04:54:23.675406 systemd[1]: Listening on Journal Audit Socket. Oct 13 04:54:23.675412 systemd[1]: Listening on Journal Socket (/dev/log). Oct 13 04:54:23.675419 systemd[1]: Listening on Journal Socket. Oct 13 04:54:23.675426 systemd[1]: Listening on udev Control Socket. Oct 13 04:54:23.675433 systemd[1]: Listening on udev Kernel Socket. Oct 13 04:54:23.675440 systemd[1]: Reached target Socket Units. Oct 13 04:54:23.675446 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 13 04:54:23.675455 systemd[1]: Starting Create List of Static Device Nodes... Oct 13 04:54:23.675461 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 13 04:54:23.675468 systemd[1]: Starting Journal Service... Oct 13 04:54:23.675475 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 13 04:54:23.675485 systemd[1]: Starting Apply Kernel Variables... Oct 13 04:54:23.675493 systemd[1]: Starting Setup Virtual Console... Oct 13 04:54:23.675500 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 13 04:54:23.675506 systemd[1]: Finished Create List of Static Device Nodes. Oct 13 04:54:23.675513 kernel: SCSI subsystem initialized Oct 13 04:54:23.675519 systemd[1]: Finished Apply Kernel Variables. Oct 13 04:54:23.675528 systemd[1]: Finished Setup Virtual Console. Oct 13 04:54:23.675537 systemd-journald[269]: Journal started Oct 13 04:54:23.675580 systemd-journald[269]: Runtime Journal (/run/log/journal/3510c0b04d2f41f4b7d3f4d99b43eec3) is 6.0M, max 48.5M, 42.4M free. Oct 13 04:54:23.676384 kernel: Loading iSCSI transport class v2.0-870. Oct 13 04:54:23.676407 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 13 04:54:23.679476 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 13 04:54:23.680572 systemd[1]: Started Journal Service. Oct 13 04:54:23.683826 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 13 04:54:23.691573 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 13 04:54:23.693876 systemd[1]: Starting dracut cmdline hook... Oct 13 04:54:23.702702 dracut-cmdline[290]: dracut-dracut-053 Oct 13 04:54:23.704977 dracut-cmdline[290]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 13 04:54:23.762234 kernel: iscsi: registered transport (tcp) Oct 13 04:54:23.773212 kernel: iscsi: registered transport (qla4xxx) Oct 13 04:54:23.773255 kernel: QLogic iSCSI HBA Driver Oct 13 04:54:23.784338 systemd[1]: Finished dracut cmdline hook. Oct 13 04:54:23.785668 systemd[1]: Starting dracut pre-udev hook... Oct 13 04:54:23.786730 systemd[1]: Starting Open-iSCSI... Oct 13 04:54:23.789107 iscsid[375]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 13 04:54:23.789107 iscsid[375]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Oct 13 04:54:23.789107 iscsid[375]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 13 04:54:23.789107 iscsid[375]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 13 04:54:23.789107 iscsid[375]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 13 04:54:23.796790 iscsid[375]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 13 04:54:23.792643 systemd[1]: Started Open-iSCSI. Oct 13 04:54:23.802918 kernel: device-mapper: uevent: version 1.0.3 Oct 13 04:54:23.802943 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 13 04:54:23.838222 kernel: raid6: neonx8 gen() 13716 MB/s Oct 13 04:54:23.855211 kernel: raid6: neonx8 xor() 10639 MB/s Oct 13 04:54:23.872214 kernel: raid6: neonx4 gen() 13595 MB/s Oct 13 04:54:23.889212 kernel: raid6: neonx4 xor() 11553 MB/s Oct 13 04:54:23.906211 kernel: raid6: neonx2 gen() 13026 MB/s Oct 13 04:54:23.923219 kernel: raid6: neonx2 xor() 9890 MB/s Oct 13 04:54:23.940210 kernel: raid6: neonx1 gen() 11003 MB/s Oct 13 04:54:23.957210 kernel: raid6: neonx1 xor() 8846 MB/s Oct 13 04:54:23.974218 kernel: raid6: int64x8 gen() 6842 MB/s Oct 13 04:54:23.991212 kernel: raid6: int64x8 xor() 3781 MB/s Oct 13 04:54:24.008210 kernel: raid6: int64x4 gen() 6922 MB/s Oct 13 04:54:24.025210 kernel: raid6: int64x4 xor() 3834 MB/s Oct 13 04:54:24.042212 kernel: raid6: int64x2 gen() 6164 MB/s Oct 13 04:54:24.059210 kernel: raid6: int64x2 xor() 3315 MB/s Oct 13 04:54:24.076210 kernel: raid6: int64x1 gen() 5011 MB/s Oct 13 04:54:24.093434 kernel: raid6: int64x1 xor() 2589 MB/s Oct 13 04:54:24.093445 kernel: raid6: using algorithm neonx8 gen() 13716 MB/s Oct 13 04:54:24.093457 kernel: raid6: .... xor() 10639 MB/s, rmw enabled Oct 13 04:54:24.093465 kernel: raid6: using neon recovery algorithm Oct 13 04:54:24.103215 kernel: xor: measuring software checksum speed Oct 13 04:54:24.104210 kernel: 8regs : 17152 MB/sec Oct 13 04:54:24.105529 kernel: 32regs : 20744 MB/sec Oct 13 04:54:24.105540 kernel: arm64_neon : 29049 MB/sec Oct 13 04:54:24.105548 kernel: xor: using function: arm64_neon (29049 MB/sec) Oct 13 04:54:24.152222 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 13 04:54:24.161655 systemd[1]: Finished dracut pre-udev hook. Oct 13 04:54:24.162000 audit: BPF prog-id=6 op=LOAD Oct 13 04:54:24.163000 audit: BPF prog-id=7 op=LOAD Oct 13 04:54:24.163000 audit: BPF prog-id=8 op=LOAD Oct 13 04:54:24.164396 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 13 04:54:24.165959 kernel: audit: type=1334 audit(1760331264.162:2): prog-id=6 op=LOAD Oct 13 04:54:24.165978 kernel: audit: type=1334 audit(1760331264.163:3): prog-id=7 op=LOAD Oct 13 04:54:24.165986 kernel: audit: type=1334 audit(1760331264.163:4): prog-id=8 op=LOAD Oct 13 04:54:24.175577 systemd-udevd[407]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 13 04:54:24.177280 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 13 04:54:24.179220 systemd[1]: Starting dracut pre-trigger hook... Oct 13 04:54:24.189584 dracut-pre-trigger[415]: rd.md=0: removing MD RAID activation Oct 13 04:54:24.211426 systemd[1]: Finished dracut pre-trigger hook. Oct 13 04:54:24.212633 systemd[1]: Starting Coldplug All udev Devices... Oct 13 04:54:24.222117 systemd-udevd[407]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 13 04:54:24.248148 systemd[1]: Finished Coldplug All udev Devices. Oct 13 04:54:24.249611 systemd[1]: Starting dracut initqueue hook... Oct 13 04:54:24.261413 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 13 04:54:24.261560 kernel: vda: detected capacity change from 0 to 4756340736 Oct 13 04:54:24.271217 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 13 04:54:24.277818 systemd-udevd[455]: Using default interface naming scheme 'v249'. Oct 13 04:54:24.290222 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (459) Oct 13 04:54:24.290278 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 13 04:54:24.290957 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 13 04:54:24.295949 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 13 04:54:24.302898 systemd[1]: Reached target Initrd Root Device. Oct 13 04:54:24.304178 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 13 04:54:24.305081 systemd[1]: Finished dracut initqueue hook. Oct 13 04:54:24.306105 systemd[1]: Reached target Preparation for Remote File Systems. Oct 13 04:54:24.307234 systemd[1]: Reached target Remote Encrypted Volumes. Oct 13 04:54:24.308575 systemd[1]: Reached target Remote File Systems. Oct 13 04:54:24.310447 systemd[1]: Starting dracut pre-mount hook... Oct 13 04:54:24.311259 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 13 04:54:24.311374 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 13 04:54:24.312257 systemd[1]: Reached target Preparation for Local File Systems. Oct 13 04:54:24.313946 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 13 04:54:24.318563 systemd[1]: Finished dracut pre-mount hook. Oct 13 04:54:24.319735 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 13 04:54:24.325212 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 13 04:54:24.329793 systemd-fsck[502]: ROOT: clean, 641/553792 files, 42011/553472 blocks Oct 13 04:54:24.333006 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 13 04:54:24.334889 systemd[1]: Mounting /sysroot... Oct 13 04:54:24.348992 systemd[1]: Found device /dev/mapper/usr. Oct 13 04:54:24.350795 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 13 04:54:24.353602 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 13 04:54:24.362379 systemd-fsck[515]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 13 04:54:24.362379 systemd-fsck[515]: You must have r/w access to the filesystem or be root Oct 13 04:54:24.362792 systemd-fsck[512]: fsck failed with exit status 8. Oct 13 04:54:24.362796 systemd-fsck[512]: Ignoring error. Oct 13 04:54:24.363411 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 13 04:54:24.364733 systemd[1]: Mounting /sysusr/usr... Oct 13 04:54:24.373314 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 13 04:54:24.373371 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 13 04:54:24.373645 systemd[1]: Mounted /sysroot. Oct 13 04:54:24.375658 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 13 04:54:24.374184 systemd[1]: Reached target Initrd Root File System. Oct 13 04:54:24.376760 systemd[1]: Starting Reload Configuration from the Real Root... Oct 13 04:54:24.377965 systemd[1]: Mounted /sysusr/usr. Oct 13 04:54:24.378774 systemd[1]: Reached target Local File Systems. Oct 13 04:54:24.379546 systemd[1]: Reached target System Initialization. Oct 13 04:54:24.380630 systemd[1]: Reached target Basic System. Oct 13 04:54:24.382576 systemd[1]: Mounting /sysroot/usr... Oct 13 04:54:24.384899 systemd[1]: Mounted /sysroot/usr. Oct 13 04:54:24.385566 systemd[1]: Reloading. Oct 13 04:54:24.393000 audit: BPF prog-id=3 op=UNLOAD Oct 13 04:54:24.393000 audit: BPF prog-id=6 op=UNLOAD Oct 13 04:54:24.397119 kernel: audit: type=1334 audit(1760331264.393:5): prog-id=3 op=UNLOAD Oct 13 04:54:24.397157 kernel: audit: type=1334 audit(1760331264.393:6): prog-id=6 op=UNLOAD Oct 13 04:54:24.467000 audit: BPF prog-id=9 op=LOAD Oct 13 04:54:24.468000 audit: BPF prog-id=10 op=LOAD Oct 13 04:54:24.469574 kernel: audit: type=1334 audit(1760331264.467:7): prog-id=9 op=LOAD Oct 13 04:54:24.469596 kernel: audit: type=1334 audit(1760331264.468:8): prog-id=10 op=LOAD Oct 13 04:54:24.469606 kernel: audit: type=1334 audit(1760331264.469:9): prog-id=11 op=LOAD Oct 13 04:54:24.469000 audit: BPF prog-id=11 op=LOAD Oct 13 04:54:24.469000 audit: BPF prog-id=4 op=UNLOAD Oct 13 04:54:24.470992 kernel: audit: type=1334 audit(1760331264.469:10): prog-id=4 op=UNLOAD Oct 13 04:54:24.469000 audit: BPF prog-id=5 op=UNLOAD Oct 13 04:54:24.469000 audit: BPF prog-id=12 op=LOAD Oct 13 04:54:24.470000 audit: BPF prog-id=13 op=LOAD Oct 13 04:54:24.470000 audit: BPF prog-id=14 op=LOAD Oct 13 04:54:24.470000 audit: BPF prog-id=7 op=UNLOAD Oct 13 04:54:24.470000 audit: BPF prog-id=8 op=UNLOAD Oct 13 04:54:24.484030 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 13 04:54:24.484150 systemd[1]: Finished Reload Configuration from the Real Root. Oct 13 04:54:24.485606 systemd[1]: Reached target Initrd File Systems. Oct 13 04:54:24.486796 systemd[1]: Reached target Initrd Default Target. Oct 13 04:54:24.487903 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 13 04:54:24.488582 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 13 04:54:24.498800 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 13 04:54:24.500149 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 13 04:54:24.505908 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 13 04:54:24.506663 systemd[1]: Stopped target Timer Units. Oct 13 04:54:24.507648 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 13 04:54:24.507759 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 13 04:54:24.508916 systemd[1]: Stopped target Initrd Default Target. Oct 13 04:54:24.510008 systemd[1]: Stopped target Basic System. Oct 13 04:54:24.511150 systemd[1]: Stopped target Initrd Root Device. Oct 13 04:54:24.512274 systemd[1]: Stopped target Path Units. Oct 13 04:54:24.513302 systemd[1]: Stopped target Remote File Systems. Oct 13 04:54:24.514411 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 13 04:54:24.515515 systemd[1]: Stopped target Slice Units. Oct 13 04:54:24.516561 systemd[1]: Stopped target Socket Units. Oct 13 04:54:24.517725 systemd[1]: Stopped target System Initialization. Oct 13 04:54:24.518835 systemd[1]: Stopped target Local File Systems. Oct 13 04:54:24.519834 systemd[1]: Stopped target Preparation for Local File Systems. Oct 13 04:54:24.520973 systemd[1]: Stopped target Swaps. Oct 13 04:54:24.521947 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 13 04:54:24.522054 systemd[1]: Stopped dracut pre-mount hook. Oct 13 04:54:24.523145 systemd[1]: Stopped target Local Encrypted Volumes. Oct 13 04:54:24.523998 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 13 04:54:24.526475 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 13 04:54:24.527300 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 13 04:54:24.527410 systemd[1]: Stopped dracut initqueue hook. Oct 13 04:54:24.530038 iscsid[375]: iscsid shutting down. Oct 13 04:54:24.528645 systemd[1]: Stopping Open-iSCSI... Oct 13 04:54:24.529576 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 13 04:54:24.529673 systemd[1]: Stopped Apply Kernel Variables. Oct 13 04:54:24.530751 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 13 04:54:24.530852 systemd[1]: Stopped Coldplug All udev Devices. Oct 13 04:54:24.531750 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 13 04:54:24.531833 systemd[1]: Stopped dracut pre-trigger hook. Oct 13 04:54:24.532778 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 13 04:54:24.537090 systemd[1]: iscsid.service: Deactivated successfully. Oct 13 04:54:24.537228 systemd[1]: Stopped Open-iSCSI. Oct 13 04:54:24.538265 systemd[1]: iscsid.socket: Deactivated successfully. Oct 13 04:54:24.538311 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 13 04:54:24.538957 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 13 04:54:24.541427 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 13 04:54:24.541546 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 13 04:54:24.542513 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 13 04:54:24.542631 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 13 04:54:24.544004 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 13 04:54:24.544052 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 13 04:54:24.545155 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 13 04:54:24.553000 audit: BPF prog-id=12 op=UNLOAD Oct 13 04:54:24.545355 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 13 04:54:24.546534 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 13 04:54:24.546569 systemd[1]: Closed udev Control Socket. Oct 13 04:54:24.547616 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 13 04:54:24.547647 systemd[1]: Closed udev Kernel Socket. Oct 13 04:54:24.548663 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 13 04:54:24.548699 systemd[1]: Stopped dracut pre-udev hook. Oct 13 04:54:24.549797 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 13 04:54:24.549835 systemd[1]: Stopped dracut cmdline hook. Oct 13 04:54:24.550928 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 13 04:54:24.550962 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 13 04:54:24.552890 systemd[1]: Starting Cleanup udev Database... Oct 13 04:54:24.554278 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 13 04:54:24.555663 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 13 04:54:24.555715 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 13 04:54:24.556977 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 13 04:54:24.557020 systemd[1]: Stopped Create List of Static Device Nodes. Oct 13 04:54:24.558151 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 13 04:54:24.558189 systemd[1]: Stopped Setup Virtual Console. Oct 13 04:54:24.559658 systemd[1]: rngd.service: Deactivated successfully. Oct 13 04:54:24.559769 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 13 04:54:24.560705 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 13 04:54:24.572000 audit: BPF prog-id=9 op=UNLOAD Oct 13 04:54:24.560810 systemd[1]: Finished Cleanup udev Database. Oct 13 04:54:24.561893 systemd[1]: Reached target Switch Root. Oct 13 04:54:24.563507 systemd[1]: Starting Switch Root... Oct 13 04:54:24.570491 systemd[1]: Switching root. Oct 13 04:54:24.587520 systemd-journald[269]: Journal stopped Oct 13 04:54:26.621487 systemd-journald[269]: Received SIGTERM from PID 1 (systemd). Oct 13 04:54:26.621535 kernel: SELinux: policy capability network_peer_controls=1 Oct 13 04:54:26.621572 kernel: SELinux: policy capability open_perms=1 Oct 13 04:54:26.621588 kernel: SELinux: policy capability extended_socket_class=1 Oct 13 04:54:26.621602 kernel: SELinux: policy capability always_check_network=0 Oct 13 04:54:26.621612 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 13 04:54:26.621638 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 13 04:54:26.621653 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 13 04:54:26.621665 systemd[1]: Successfully loaded SELinux policy in 30.580ms. Oct 13 04:54:26.621679 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.335ms. Oct 13 04:54:26.621695 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 13 04:54:26.621727 systemd[1]: Detected virtualization kvm. Oct 13 04:54:26.621739 systemd[1]: Detected architecture arm64. Oct 13 04:54:26.621750 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 13 04:54:26.621764 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 13 04:54:26.621776 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 13 04:54:26.621786 systemd[1]: Stopped Switch Root. Oct 13 04:54:26.621796 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 13 04:54:26.621806 systemd[1]: Created slice Slice /system/addon-config. Oct 13 04:54:26.621816 systemd[1]: Created slice Slice /system/addon-run. Oct 13 04:54:26.621825 systemd[1]: Created slice Slice /system/getty. Oct 13 04:54:26.621836 systemd[1]: Created slice Slice /system/modprobe. Oct 13 04:54:26.621845 systemd[1]: Created slice Slice /system/serial-getty. Oct 13 04:54:26.621855 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 13 04:54:26.621865 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 13 04:54:26.621875 systemd[1]: Created slice User and Session Slice. Oct 13 04:54:26.621885 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 13 04:54:26.621895 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 13 04:54:26.621904 systemd[1]: Set up automount Boot partition Automount Point. Oct 13 04:54:26.621914 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 13 04:54:26.621924 systemd[1]: Stopped target Switch Root. Oct 13 04:54:26.621933 systemd[1]: Stopped target Initrd File Systems. Oct 13 04:54:26.621942 systemd[1]: Stopped target Initrd Root File System. Oct 13 04:54:26.621953 systemd[1]: Reached target Remote Encrypted Volumes. Oct 13 04:54:26.621963 systemd[1]: Reached target Remote File Systems. Oct 13 04:54:26.621973 systemd[1]: Reached target Slice Units. Oct 13 04:54:26.621983 systemd[1]: Reached target Swaps. Oct 13 04:54:26.621993 systemd[1]: Reached target Verify torcx succeeded. Oct 13 04:54:26.622003 systemd[1]: Reached target Local Verity Protected Volumes. Oct 13 04:54:26.622012 systemd[1]: Listening on Process Core Dump Socket. Oct 13 04:54:26.622021 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 13 04:54:26.622031 systemd[1]: Listening on Network Service Netlink Socket. Oct 13 04:54:26.622041 systemd[1]: Listening on udev Control Socket. Oct 13 04:54:26.622051 systemd[1]: Listening on udev Kernel Socket. Oct 13 04:54:26.622060 systemd[1]: Mounting Huge Pages File System... Oct 13 04:54:26.622070 systemd[1]: Mounting POSIX Message Queue File System... Oct 13 04:54:26.622081 systemd[1]: Mounting External Media Directory... Oct 13 04:54:26.622091 systemd[1]: Mounting Kernel Debug File System... Oct 13 04:54:26.622100 systemd[1]: Mounting Kernel Trace File System... Oct 13 04:54:26.622109 systemd[1]: Mounting Temporary Directory /tmp... Oct 13 04:54:26.622119 systemd[1]: Starting Create missing system files... Oct 13 04:54:26.622129 systemd[1]: Starting Create List of Static Device Nodes... Oct 13 04:54:26.622139 systemd[1]: Starting Load Kernel Module configfs... Oct 13 04:54:26.622150 systemd[1]: Starting Load Kernel Module drm... Oct 13 04:54:26.622160 systemd[1]: Starting Load Kernel Module fuse... Oct 13 04:54:26.622170 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 13 04:54:26.622181 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 13 04:54:26.622190 systemd[1]: Stopped File System Check on Root Device. Oct 13 04:54:26.622210 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 13 04:54:26.622220 systemd[1]: Stopped systemd-fsck-usr.service. Oct 13 04:54:26.622229 systemd[1]: Stopped Journal Service. Oct 13 04:54:26.622238 kernel: fuse: init (API version 7.32) Oct 13 04:54:26.622249 systemd[1]: Starting Journal Service... Oct 13 04:54:26.622260 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 13 04:54:26.622270 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 13 04:54:26.622279 systemd[1]: Starting Apply Kernel Variables... Oct 13 04:54:26.622289 systemd[1]: Starting Coldplug All udev Devices... Oct 13 04:54:26.622298 systemd[1]: verity-setup.service: Deactivated successfully. Oct 13 04:54:26.622307 systemd[1]: Stopped verity-setup.service. Oct 13 04:54:26.622319 systemd-journald[691]: Journal started Oct 13 04:54:26.622366 systemd-journald[691]: Runtime Journal (/run/log/journal/3510c0b04d2f41f4b7d3f4d99b43eec3) is 6.0M, max 48.5M, 42.4M free. Oct 13 04:54:24.656000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 13 04:54:24.682000 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 13 04:54:24.682000 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 13 04:54:24.682000 audit: BPF prog-id=15 op=LOAD Oct 13 04:54:24.682000 audit: BPF prog-id=15 op=UNLOAD Oct 13 04:54:24.682000 audit: BPF prog-id=16 op=LOAD Oct 13 04:54:24.682000 audit: BPF prog-id=16 op=UNLOAD Oct 13 04:54:24.716000 audit[643]: AVC avc: denied { associate } for pid=643 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 13 04:54:26.500000 audit: BPF prog-id=17 op=LOAD Oct 13 04:54:26.500000 audit: BPF prog-id=18 op=LOAD Oct 13 04:54:26.500000 audit: BPF prog-id=19 op=LOAD Oct 13 04:54:26.500000 audit: BPF prog-id=10 op=UNLOAD Oct 13 04:54:26.500000 audit: BPF prog-id=11 op=UNLOAD Oct 13 04:54:26.513000 audit: BPF prog-id=20 op=LOAD Oct 13 04:54:26.513000 audit: BPF prog-id=17 op=UNLOAD Oct 13 04:54:26.513000 audit: BPF prog-id=21 op=LOAD Oct 13 04:54:26.513000 audit: BPF prog-id=22 op=LOAD Oct 13 04:54:26.513000 audit: BPF prog-id=18 op=UNLOAD Oct 13 04:54:26.513000 audit: BPF prog-id=19 op=UNLOAD Oct 13 04:54:26.514000 audit: BPF prog-id=23 op=LOAD Oct 13 04:54:26.514000 audit: BPF prog-id=20 op=UNLOAD Oct 13 04:54:26.514000 audit: BPF prog-id=24 op=LOAD Oct 13 04:54:26.514000 audit: BPF prog-id=25 op=LOAD Oct 13 04:54:26.514000 audit: BPF prog-id=21 op=UNLOAD Oct 13 04:54:26.514000 audit: BPF prog-id=22 op=UNLOAD Oct 13 04:54:26.524000 audit: BPF prog-id=23 op=UNLOAD Oct 13 04:54:26.607000 audit: BPF prog-id=26 op=LOAD Oct 13 04:54:26.607000 audit: BPF prog-id=27 op=LOAD Oct 13 04:54:26.607000 audit: BPF prog-id=28 op=LOAD Oct 13 04:54:26.607000 audit: BPF prog-id=24 op=UNLOAD Oct 13 04:54:26.607000 audit: BPF prog-id=25 op=UNLOAD Oct 13 04:54:26.620000 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 13 04:54:26.499623 systemd[1]: Queued start job for default target Multi-User System. Oct 13 04:54:24.714736 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" 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 13 04:54:26.514880 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 13 04:54:24.715033 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 13 04:54:24.715053 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 13 04:54:24.715378 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 13 04:54:24.715392 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 13 04:54:26.623556 systemd[1]: Started Journal Service. Oct 13 04:54:24.715430 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 13 04:54:24.715444 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 13 04:54:24.715778 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 13 04:54:24.715819 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 13 04:54:24.715835 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 13 04:54:24.716211 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" 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 13 04:54:24.716256 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" 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 13 04:54:26.623938 systemd[1]: Mounted Huge Pages File System. Oct 13 04:54:24.716277 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" 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 13 04:54:24.716293 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 13 04:54:24.716393 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" 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 13 04:54:24.716409 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:24Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 13 04:54:26.413372 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:26Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 13 04:54:26.413649 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:26Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 13 04:54:26.413746 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:26Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 13 04:54:26.413878 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:26Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 13 04:54:26.413970 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:26Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 13 04:54:26.414026 /usr/lib/systemd/system-generators/torcx-generator[643]: time="2025-10-13T04:54:26Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Oct 13 04:54:26.625111 systemd[1]: Mounted POSIX Message Queue File System. Oct 13 04:54:26.626008 systemd[1]: Mounted External Media Directory. Oct 13 04:54:26.626766 systemd[1]: Mounted Kernel Debug File System. Oct 13 04:54:26.627654 systemd[1]: Mounted Kernel Trace File System. Oct 13 04:54:26.628376 systemd[1]: Mounted Temporary Directory /tmp. Oct 13 04:54:26.629309 systemd[1]: Finished Create missing system files. Oct 13 04:54:26.630625 systemd[1]: Finished Create List of Static Device Nodes. Oct 13 04:54:26.631732 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 13 04:54:26.631911 systemd[1]: Finished Load Kernel Module configfs. Oct 13 04:54:26.632776 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 13 04:54:26.632952 systemd[1]: Finished Load Kernel Module drm. Oct 13 04:54:26.633781 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 13 04:54:26.633962 systemd[1]: Finished Load Kernel Module fuse. Oct 13 04:54:26.634889 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 13 04:54:26.643757 systemd[1]: Finished Apply Kernel Variables. Oct 13 04:54:26.646559 systemd[1]: Mounting FUSE Control File System... Oct 13 04:54:26.648164 systemd[1]: Mounting Kernel Configuration File System... Oct 13 04:54:26.648912 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 13 04:54:26.650228 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 13 04:54:26.651257 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 13 04:54:26.652074 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 13 04:54:26.653307 systemd[1]: Starting Load/Save Random Seed... Oct 13 04:54:26.654030 systemd[1]: Condition check resulted in Create System Users being skipped. Oct 13 04:54:26.655698 systemd-journald[691]: Time spent on flushing to /var/log/journal/3510c0b04d2f41f4b7d3f4d99b43eec3 is 9.759ms for 667 entries. Oct 13 04:54:26.655698 systemd-journald[691]: System Journal (/var/log/journal/3510c0b04d2f41f4b7d3f4d99b43eec3) is 16.0M, max 203.0M, 187.0M free. Oct 13 04:54:26.675000 audit: BPF prog-id=29 op=LOAD Oct 13 04:54:26.675000 audit: BPF prog-id=30 op=LOAD Oct 13 04:54:26.675000 audit: BPF prog-id=31 op=LOAD Oct 13 04:54:26.675000 audit: BPF prog-id=13 op=UNLOAD Oct 13 04:54:26.675000 audit: BPF prog-id=14 op=UNLOAD Oct 13 04:54:26.655059 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 13 04:54:26.657618 systemd[1]: Mounted FUSE Control File System. Oct 13 04:54:26.658634 systemd[1]: Mounted Kernel Configuration File System. Oct 13 04:54:26.659727 systemd[1]: Finished Load/Save Random Seed. Oct 13 04:54:26.660567 systemd[1]: Condition check resulted in First Boot Complete being skipped. Oct 13 04:54:26.669014 systemd[1]: Finished Coldplug All udev Devices. Oct 13 04:54:26.670140 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 13 04:54:26.672174 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 13 04:54:26.676033 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 13 04:54:26.679733 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 13 04:54:26.700879 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 13 04:54:26.709000 audit: BPF prog-id=32 op=LOAD Oct 13 04:54:26.710525 systemd[1]: Starting Network Configuration... Oct 13 04:54:26.738927 systemd-networkd[725]: lo: Link UP Oct 13 04:54:26.738935 systemd-networkd[725]: lo: Gained carrier Oct 13 04:54:26.739794 systemd-networkd[725]: Enumeration completed Oct 13 04:54:26.739897 systemd[1]: Started Network Configuration. Oct 13 04:54:26.742758 systemd-udevd[723]: Using default interface naming scheme 'v249'. Oct 13 04:54:26.759668 udevadm[705]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 13 04:54:26.769554 systemd-networkd[725]: eth0: Link UP Oct 13 04:54:26.776239 systemd-networkd[725]: eth0: Gained carrier Oct 13 04:54:26.783411 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 13 04:54:26.787332 systemd-networkd[725]: eth0: DHCPv4 address 10.0.0.7/16 via 10.0.0.1 Oct 13 04:54:26.792142 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 13 04:54:26.800622 lvm[733]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 13 04:54:26.826227 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 13 04:54:26.827004 systemd[1]: Reached target Local Encrypted Volumes. Oct 13 04:54:26.837172 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 13 04:54:26.840614 lvm[734]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 13 04:54:26.868182 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 13 04:54:26.868941 systemd[1]: Reached target Preparation for Local File Systems. Oct 13 04:54:26.869750 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 13 04:54:26.869773 systemd[1]: Reached target Containers. Oct 13 04:54:26.881434 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 13 04:54:26.893261 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 13 04:54:26.904063 systemd[1]: Mounting /usr/share/oem... Oct 13 04:54:26.909582 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 13 04:54:26.909659 kernel: BTRFS info (device vda6): has skinny extents Oct 13 04:54:26.911683 systemd[1]: Mounted /usr/share/oem. Oct 13 04:54:26.912282 systemd[1]: Reached target Local File Systems. Oct 13 04:54:26.912896 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Oct 13 04:54:26.913258 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 13 04:54:26.913293 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 13 04:54:26.913321 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 13 04:54:26.914238 systemd[1]: Starting Create Volatile Files and Directories... Oct 13 04:54:26.920125 systemd-tmpfiles[757]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 13 04:54:26.921137 systemd-tmpfiles[757]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 13 04:54:26.947446 systemd-tmpfiles[757]: Detected autofs mount point /boot during canonicalization of /boot. Oct 13 04:54:26.947459 systemd-tmpfiles[757]: Skipping /boot Oct 13 04:54:26.952906 systemd-tmpfiles[757]: Detected autofs mount point /boot during canonicalization of /boot. Oct 13 04:54:26.952925 systemd-tmpfiles[757]: Skipping /boot Oct 13 04:54:26.981785 systemd[1]: Finished Create Volatile Files and Directories. Oct 13 04:54:26.991296 systemd[1]: Starting Load Security Auditing Rules... Oct 13 04:54:26.993467 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 13 04:54:26.994920 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Oct 13 04:54:26.995000 audit: BPF prog-id=33 op=LOAD Oct 13 04:54:26.996715 systemd[1]: Starting Network Name Resolution... Oct 13 04:54:26.998000 audit: BPF prog-id=34 op=LOAD Oct 13 04:54:26.999062 systemd[1]: Starting Network Time Synchronization... Oct 13 04:54:26.999955 systemd[1]: Condition check resulted in Update is Completed being skipped. Oct 13 04:54:27.000969 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 13 04:54:27.002236 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 13 04:54:27.003269 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 13 04:54:27.007297 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 13 04:54:27.017000 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 13 04:54:27.017764 augenrules[778]: No rules Oct 13 04:54:27.018620 systemd[1]: Finished Load Security Auditing Rules. Oct 13 04:54:27.034521 systemd[1]: Started Network Time Synchronization. Oct 13 04:54:27.035209 systemd-timesyncd[767]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 13 04:54:27.035370 systemd-resolved[763]: Positive Trust Anchors: Oct 13 04:54:27.035377 systemd-resolved[763]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 13 04:54:27.035404 systemd-resolved[763]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Oct 13 04:54:27.035544 systemd[1]: Reached target System Initialization. Oct 13 04:54:27.036292 systemd-resolved[763]: Defaulting to hostname 'linux'. Oct 13 04:54:27.036490 systemd[1]: Started Watch for update engine configuration changes. Oct 13 04:54:27.037277 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 13 04:54:27.038155 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 13 04:54:27.038927 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 13 04:54:27.038952 systemd[1]: Reached target Path Units. Oct 13 04:54:27.039479 systemd[1]: Reached target System Time Set. Oct 13 04:54:27.040244 systemd[1]: Started Daily Log Rotation. Oct 13 04:54:27.040891 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 13 04:54:27.041752 systemd[1]: Reached target Timer Units. Oct 13 04:54:27.042651 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 13 04:54:27.052827 systemd[1]: Starting Docker Socket for the API... Oct 13 04:54:27.055873 systemd[1]: Listening on OpenSSH Server Socket. Oct 13 04:54:27.057086 systemd[1]: Started Network Name Resolution. Oct 13 04:54:27.057886 systemd[1]: Listening on Docker Socket for the API. Oct 13 04:54:27.060786 systemd[1]: Created slice Slice /system/sshd. Oct 13 04:54:27.061474 systemd[1]: Reached target Network. Oct 13 04:54:27.061996 systemd[1]: Reached target Host and Network Name Lookups. Oct 13 04:54:27.062732 systemd[1]: Reached target Socket Units. Oct 13 04:54:27.063316 systemd[1]: Reached target Basic System. Oct 13 04:54:27.063932 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 13 04:54:27.063960 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 13 04:54:27.064951 systemd[1]: Started D-Bus System Message Bus. Oct 13 04:54:27.067978 systemd[1]: Starting Extend Filesystems... Oct 13 04:54:27.068694 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 13 04:54:27.069683 systemd[1]: Starting Generate /run/flatcar/motd... Oct 13 04:54:27.071621 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 13 04:54:27.073378 systemd[1]: Starting Generate sshd host keys... Oct 13 04:54:27.074088 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 13 04:54:27.074128 systemd[1]: Reached target Load system-provided cloud configs. Oct 13 04:54:27.077426 systemd[1]: Starting User Login Management... Oct 13 04:54:27.079490 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 13 04:54:27.079790 extend-filesystems[788]: Found vda Oct 13 04:54:27.079790 extend-filesystems[788]: Found vda1 Oct 13 04:54:27.080924 extend-filesystems[788]: Found vda2 Oct 13 04:54:27.080924 extend-filesystems[788]: Found vda3 Oct 13 04:54:27.080924 extend-filesystems[788]: Found usr Oct 13 04:54:27.080924 extend-filesystems[788]: Found vda4 Oct 13 04:54:27.080924 extend-filesystems[788]: Found vda6 Oct 13 04:54:27.080924 extend-filesystems[788]: Found vda7 Oct 13 04:54:27.080924 extend-filesystems[788]: Found vda9 Oct 13 04:54:27.080924 extend-filesystems[788]: Checking size of /dev/vda9 Oct 13 04:54:27.092777 extend-filesystems[788]: Old size kept for /dev/vda9 Oct 13 04:54:27.081488 systemd[1]: Starting Update Engine... Oct 13 04:54:27.082615 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 13 04:54:27.082643 systemd[1]: Reached target Load user-provided cloud configs. Oct 13 04:54:27.084710 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 13 04:54:27.085303 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 13 04:54:27.089073 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 13 04:54:27.089353 systemd[1]: Finished Extend Filesystems. Oct 13 04:54:27.090887 systemd[1]: motdgen.service: Deactivated successfully. Oct 13 04:54:27.091087 systemd[1]: Finished Generate /run/flatcar/motd. Oct 13 04:54:27.118807 systemd-logind[797]: Watching system buttons on /dev/input/event0 (Power Button) Oct 13 04:54:27.119018 systemd-logind[797]: New seat seat0. Oct 13 04:54:27.121128 systemd[1]: Started User Login Management. Oct 13 04:54:27.129635 systemd[1]: Finished Generate sshd host keys. Oct 13 04:54:27.133266 update_engine[803]: I1013 04:54:27.132972 803 main.cc:89] Flatcar Update Engine starting Oct 13 04:54:27.142488 update_engine[803]: I1013 04:54:27.133777 803 payload_state.cc:360] Current Response Signature = Oct 13 04:54:27.142488 update_engine[803]: NumURLs = 1 Oct 13 04:54:27.142488 update_engine[803]: Url0 = http://10.0.0.6:34567/packages/update.gz Oct 13 04:54:27.142488 update_engine[803]: Payload Size = 440186465 Oct 13 04:54:27.142488 update_engine[803]: Payload Sha256 Hash = 2rLfTjCkf4AccwOSTkVH+eSPLI9tRE2XhCZAKCB99h0= Oct 13 04:54:27.142488 update_engine[803]: Is Delta Payload = 0 Oct 13 04:54:27.142488 update_engine[803]: Max Failure Count Per Url = 10 Oct 13 04:54:27.142488 update_engine[803]: Disable Payload Backoff = 1 Oct 13 04:54:27.142488 update_engine[803]: I1013 04:54:27.133985 803 payload_state.cc:381] Payload Attempt Number = 0 Oct 13 04:54:27.142488 update_engine[803]: I1013 04:54:27.134178 803 payload_state.cc:404] Current URL Index = 0 Oct 13 04:54:27.142488 update_engine[803]: I1013 04:54:27.134349 803 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 13 04:54:27.142488 update_engine[803]: I1013 04:54:27.134523 803 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 13 04:54:27.142488 update_engine[803]: I1013 04:54:27.136485 803 update_check_scheduler.cc:74] Next update check in 10m42s Oct 13 04:54:27.143308 systemd[1]: Starting Generate /run/issue... Oct 13 04:54:27.144849 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:60680). Oct 13 04:54:27.146350 systemd[1]: Started Update Engine. Oct 13 04:54:27.147763 systemd[1]: issuegen.service: Deactivated successfully. Oct 13 04:54:27.147985 systemd[1]: Finished Generate /run/issue. Oct 13 04:54:27.149960 systemd[1]: Starting Permit User Sessions... Oct 13 04:54:27.154564 systemd[1]: Finished Permit User Sessions. Oct 13 04:54:27.156372 systemd[1]: Started Getty on tty1. Oct 13 04:54:27.157982 systemd[1]: Started Serial Getty on ttyAMA0. Oct 13 04:54:27.158769 systemd[1]: Reached target Login Prompts. Oct 13 04:54:27.159536 systemd[1]: Reached target Multi-User System. Oct 13 04:54:27.161161 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 13 04:54:27.166250 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 13 04:54:27.166477 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 13 04:54:27.167435 systemd[1]: Startup finished in 688ms (kernel) + 1.069s (initrd) + 2.543s (userspace) = 4.301s. Oct 13 04:54:27.183276 sshd[822]: Accepted publickey for core from 10.0.0.1 port 60680 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:27.185253 sshd[822]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:27.200681 systemd[1]: Created slice User Slice of UID 500. Oct 13 04:54:27.201695 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 13 04:54:27.203114 systemd-logind[797]: New session 1 of user core. Oct 13 04:54:27.207480 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 13 04:54:27.208623 systemd[1]: Starting User Manager for UID 500... Oct 13 04:54:27.210569 systemd[831]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:27.255584 systemd[831]: Queued start job for default target Main User Target. Oct 13 04:54:27.255736 systemd[831]: Reached target Paths. Oct 13 04:54:27.255749 systemd[831]: Reached target Sockets. Oct 13 04:54:27.255760 systemd[831]: Reached target Timers. Oct 13 04:54:27.255770 systemd[831]: Reached target Basic System. Oct 13 04:54:27.255811 systemd[831]: Reached target Main User Target. Oct 13 04:54:27.255824 systemd[831]: Startup finished in 41ms. Oct 13 04:54:27.255877 systemd[1]: Started User Manager for UID 500. Oct 13 04:54:27.263349 systemd[1]: Started Session 1 of User core. Oct 13 04:54:27.326717 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:60692). Oct 13 04:54:27.359839 sshd[840]: Accepted publickey for core from 10.0.0.1 port 60692 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:27.360798 sshd[840]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:27.363341 systemd-logind[797]: New session 2 of user core. Oct 13 04:54:27.373336 systemd[1]: Started Session 2 of User core. Oct 13 04:54:27.423912 sshd[840]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:27.444678 systemd[1]: sshd@1-10.0.0.7:22-10.0.0.1:60692.service: Deactivated successfully. Oct 13 04:54:27.445227 systemd[1]: session-2.scope: Deactivated successfully. Oct 13 04:54:27.445821 systemd-logind[797]: Session 2 logged out. Waiting for processes to exit. Oct 13 04:54:27.446739 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:60694). Oct 13 04:54:27.447404 systemd-logind[797]: Removed session 2. Oct 13 04:54:27.478868 sshd[846]: Accepted publickey for core from 10.0.0.1 port 60694 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:27.479746 sshd[846]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:27.482261 systemd-logind[797]: New session 3 of user core. Oct 13 04:54:27.495389 systemd[1]: Started Session 3 of User core. Oct 13 04:54:27.543135 sshd[846]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:27.559607 systemd[1]: sshd@2-10.0.0.7:22-10.0.0.1:60694.service: Deactivated successfully. Oct 13 04:54:27.560101 systemd[1]: session-3.scope: Deactivated successfully. Oct 13 04:54:27.560696 systemd-logind[797]: Session 3 logged out. Waiting for processes to exit. Oct 13 04:54:27.561603 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:60696). Oct 13 04:54:27.562293 systemd-logind[797]: Removed session 3. Oct 13 04:54:27.595490 sshd[852]: Accepted publickey for core from 10.0.0.1 port 60696 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:27.596406 sshd[852]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:27.598915 systemd-logind[797]: New session 4 of user core. Oct 13 04:54:27.605402 systemd[1]: Started Session 4 of User core. Oct 13 04:54:27.655872 sshd[852]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:27.667142 systemd[1]: sshd@3-10.0.0.7:22-10.0.0.1:60696.service: Deactivated successfully. Oct 13 04:54:27.667886 systemd[1]: session-4.scope: Deactivated successfully. Oct 13 04:54:27.668560 systemd-logind[797]: Session 4 logged out. Waiting for processes to exit. Oct 13 04:54:27.669756 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:60708). Oct 13 04:54:27.670483 systemd-logind[797]: Removed session 4. Oct 13 04:54:27.701640 sshd[858]: Accepted publickey for core from 10.0.0.1 port 60708 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:27.702763 sshd[858]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:27.705440 systemd-logind[797]: New session 5 of user core. Oct 13 04:54:27.725365 systemd[1]: Started Session 5 of User core. Oct 13 04:54:27.787948 sudo[861]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 13 04:54:27.788171 sudo[861]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 13 04:54:27.802038 sudo[861]: pam_unix(sudo:session): session closed for user root Oct 13 04:54:27.805319 sshd[858]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:27.814969 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:60710). Oct 13 04:54:27.816137 dbus-daemon[787]: [system] Reloaded configuration Oct 13 04:54:27.818916 systemd[1]: sshd@4-10.0.0.7:22-10.0.0.1:60708.service: Deactivated successfully. Oct 13 04:54:27.819555 systemd[1]: session-5.scope: Deactivated successfully. Oct 13 04:54:27.820212 systemd-logind[797]: Session 5 logged out. Waiting for processes to exit. Oct 13 04:54:27.820965 systemd-logind[797]: Removed session 5. Oct 13 04:54:27.847706 sshd[864]: Accepted publickey for core from 10.0.0.1 port 60710 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:27.848953 sshd[864]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:27.851586 systemd-logind[797]: New session 6 of user core. Oct 13 04:54:27.861392 systemd[1]: Started Session 6 of User core. Oct 13 04:54:27.911721 sudo[869]: 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 13 04:54:27.911936 sudo[869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 13 04:54:27.914236 sudo[869]: pam_unix(sudo:session): session closed for user root Oct 13 04:54:27.917902 sudo[868]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 13 04:54:27.918114 sudo[868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 13 04:54:27.937117 systemd[1]: Stopping Load Security Auditing Rules... Oct 13 04:54:27.937000 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 13 04:54:27.938716 kernel: kauditd_printk_skb: 49 callbacks suppressed Oct 13 04:54:27.938751 kernel: audit: type=1305 audit(1760331267.937:60): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 13 04:54:27.938899 auditctl[872]: No rules Oct 13 04:54:27.939180 systemd[1]: audit-rules.service: Deactivated successfully. Oct 13 04:54:27.939431 systemd[1]: Stopped Load Security Auditing Rules. Oct 13 04:54:27.940679 systemd[1]: Starting Load Security Auditing Rules... Oct 13 04:54:27.954441 systemd-networkd[725]: eth0: Gained IPv6LL Oct 13 04:54:27.955543 augenrules[889]: No rules Oct 13 04:54:27.956462 systemd[1]: Finished Load Security Auditing Rules. Oct 13 04:54:27.957262 sudo[868]: pam_unix(sudo:session): session closed for user root Oct 13 04:54:27.958476 sshd[864]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:27.969971 systemd[1]: sshd@5-10.0.0.7:22-10.0.0.1:60710.service: Deactivated successfully. Oct 13 04:54:27.970561 systemd[1]: session-6.scope: Deactivated successfully. Oct 13 04:54:27.971158 systemd-logind[797]: Session 6 logged out. Waiting for processes to exit. Oct 13 04:54:27.972138 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:60718). Oct 13 04:54:27.972855 systemd-logind[797]: Removed session 6. Oct 13 04:54:28.004997 sshd[895]: Accepted publickey for core from 10.0.0.1 port 60718 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:28.006064 sshd[895]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:28.008255 kernel: audit: type=1006 audit(1760331268.005:61): pid=895 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 13 04:54:28.009061 systemd-logind[797]: New session 7 of user core. Oct 13 04:54:28.018400 systemd[1]: Started Session 7 of User core. Oct 13 04:54:28.069233 sshd[895]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:28.076844 systemd[1]: sshd@6-10.0.0.7:22-10.0.0.1:60718.service: Deactivated successfully. Oct 13 04:54:28.077416 systemd[1]: session-7.scope: Deactivated successfully. Oct 13 04:54:28.078028 systemd-logind[797]: Session 7 logged out. Waiting for processes to exit. Oct 13 04:54:28.078975 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:60730). Oct 13 04:54:28.079695 systemd-logind[797]: Removed session 7. Oct 13 04:54:28.111805 sshd[901]: Accepted publickey for core from 10.0.0.1 port 60730 ssh2: RSA SHA256:YAOQ1HIQemLoKOGOT8yDcagrYMsAOBdROVm4TjEo2/0 Oct 13 04:54:28.112773 sshd[901]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 13 04:54:28.114241 kernel: audit: type=1006 audit(1760331268.112:62): pid=901 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 13 04:54:28.115619 systemd-logind[797]: New session 8 of user core. Oct 13 04:54:28.124391 systemd[1]: Started Session 8 of User core. Oct 13 04:54:28.173943 sshd[901]: pam_unix(sshd:session): session closed for user core Oct 13 04:54:28.176601 systemd[1]: sshd@7-10.0.0.7:22-10.0.0.1:60730.service: Deactivated successfully. Oct 13 04:54:28.177279 systemd[1]: session-8.scope: Deactivated successfully. Oct 13 04:54:28.177958 systemd-logind[797]: Session 8 logged out. Waiting for processes to exit. Oct 13 04:54:28.178597 systemd-logind[797]: Removed session 8.