Oct 29 20:30:24.680433 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 29 20:30:24.680449 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 29 20:30:24.680457 kernel: efi: EFI v2.70 by EDK II Oct 29 20:30:24.680462 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 29 20:30:24.680467 kernel: efi: seeding entropy pool Oct 29 20:30:24.680472 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 29 20:30:24.680478 kernel: ACPI: Early table checksum verification disabled Oct 29 20:30:24.680483 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 29 20:30:24.680488 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 29 20:30:24.680493 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:24.680499 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:24.680504 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:24.680509 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:24.680514 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:24.680520 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:24.680525 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:24.680531 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:24.680537 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:24.680542 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 29 20:30:24.680547 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 29 20:30:24.680552 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:30:24.680557 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 29 20:30:24.680562 kernel: Zone ranges: Oct 29 20:30:24.680568 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:30:24.680573 kernel: DMA32 empty Oct 29 20:30:24.680578 kernel: Normal empty Oct 29 20:30:24.680583 kernel: Movable zone start for each node Oct 29 20:30:24.680589 kernel: Early memory node ranges Oct 29 20:30:24.680594 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 29 20:30:24.680599 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 29 20:30:24.680604 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 29 20:30:24.680609 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 29 20:30:24.680614 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 29 20:30:24.680619 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 29 20:30:24.680625 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 29 20:30:24.680630 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 29 20:30:24.680635 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 29 20:30:24.680640 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 29 20:30:24.680645 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 29 20:30:24.680650 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:30:24.680658 kernel: On node 0 totalpages: 643072 Oct 29 20:30:24.680664 kernel: DMA zone: 10048 pages used for memmap Oct 29 20:30:24.680669 kernel: DMA zone: 0 pages reserved Oct 29 20:30:24.680675 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 29 20:30:24.680680 kernel: psci: probing for conduit method from ACPI. Oct 29 20:30:24.680686 kernel: psci: PSCIv1.1 detected in firmware. Oct 29 20:30:24.680691 kernel: psci: Using standard PSCI v0.2 function IDs Oct 29 20:30:24.680696 kernel: psci: Trusted OS migration not required Oct 29 20:30:24.680703 kernel: psci: SMC Calling Convention v1.1 Oct 29 20:30:24.680708 kernel: ACPI: SRAT not present Oct 29 20:30:24.680714 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 29 20:30:24.680719 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 29 20:30:24.680725 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 29 20:30:24.680730 kernel: Detected PIPT I-cache on CPU0 Oct 29 20:30:24.680735 kernel: CPU features: detected: GIC system register CPU interface Oct 29 20:30:24.680741 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 29 20:30:24.680746 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 29 20:30:24.680758 kernel: CPU features: detected: Hardware dirty bit management Oct 29 20:30:24.680764 kernel: CPU features: detected: Spectre-v4 Oct 29 20:30:24.680771 kernel: CPU features: detected: ARM erratum 1418040 Oct 29 20:30:24.680776 kernel: CPU features: detected: Spectre-BHB Oct 29 20:30:24.680782 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 29 20:30:24.680787 kernel: Policy zone: DMA Oct 29 20:30:24.680794 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 29 20:30:24.680799 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 29 20:30:24.680805 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 29 20:30:24.680810 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 29 20:30:24.680816 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 29 20:30:24.680822 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 29 20:30:24.680827 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 29 20:30:24.680834 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 29 20:30:24.680840 kernel: rcu: RCU event tracing is enabled. Oct 29 20:30:24.680846 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 29 20:30:24.680851 kernel: Trampoline variant of Tasks RCU enabled. Oct 29 20:30:24.680857 kernel: Tracing variant of Tasks RCU enabled. Oct 29 20:30:24.680863 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 29 20:30:24.680868 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 29 20:30:24.680874 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 29 20:30:24.680879 kernel: GICv3: 256 SPIs implemented Oct 29 20:30:24.680884 kernel: GICv3: 0 Extended SPIs implemented Oct 29 20:30:24.680890 kernel: GICv3: Distributor has no Range Selector support Oct 29 20:30:24.680895 kernel: GICv3: 16 PPIs implemented Oct 29 20:30:24.680902 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 29 20:30:24.680907 kernel: ACPI: SRAT not present Oct 29 20:30:24.680912 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 29 20:30:24.680918 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 29 20:30:24.680924 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 29 20:30:24.680929 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 29 20:30:24.680935 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 29 20:30:24.680940 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:30:24.680946 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 29 20:30:24.680952 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 29 20:30:24.680957 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 29 20:30:24.680963 kernel: arm-pv: using stolen time PV Oct 29 20:30:24.680970 kernel: Console: colour dummy device 80x25 Oct 29 20:30:24.680975 kernel: ACPI: Core revision 20200925 Oct 29 20:30:24.680981 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 29 20:30:24.680987 kernel: pid_max: default: 32768 minimum: 301 Oct 29 20:30:24.680993 kernel: LSM: Security Framework initializing Oct 29 20:30:24.680999 kernel: SELinux: Initializing. Oct 29 20:30:24.681004 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 29 20:30:24.681010 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 29 20:30:24.681016 kernel: rcu: Hierarchical SRCU implementation. Oct 29 20:30:24.681023 kernel: Platform MSI: ITS@0x8080000 domain created Oct 29 20:30:24.681028 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 29 20:30:24.681034 kernel: Remapping and enabling EFI services. Oct 29 20:30:24.681048 kernel: smp: Bringing up secondary CPUs ... Oct 29 20:30:24.681054 kernel: Detected PIPT I-cache on CPU1 Oct 29 20:30:24.681060 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 29 20:30:24.681065 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 29 20:30:24.681071 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:30:24.681077 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 29 20:30:24.681083 kernel: Detected PIPT I-cache on CPU2 Oct 29 20:30:24.681102 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 29 20:30:24.681108 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 29 20:30:24.681114 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:30:24.681119 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 29 20:30:24.681125 kernel: Detected PIPT I-cache on CPU3 Oct 29 20:30:24.681135 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 29 20:30:24.681141 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 29 20:30:24.681148 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:30:24.681154 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 29 20:30:24.681160 kernel: smp: Brought up 1 node, 4 CPUs Oct 29 20:30:24.681165 kernel: SMP: Total of 4 processors activated. Oct 29 20:30:24.681171 kernel: CPU features: detected: Privileged Access Never Oct 29 20:30:24.681177 kernel: CPU features: detected: LSE atomic instructions Oct 29 20:30:24.681183 kernel: CPU features: detected: User Access Override Oct 29 20:30:24.681189 kernel: CPU features: detected: 32-bit EL0 Support Oct 29 20:30:24.681195 kernel: CPU features: detected: Common not Private translations Oct 29 20:30:24.681201 kernel: CPU features: detected: RAS Extension Support Oct 29 20:30:24.681208 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 29 20:30:24.681214 kernel: CPU features: detected: CRC32 instructions Oct 29 20:30:24.681220 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 29 20:30:24.681226 kernel: CPU: All CPU(s) started at EL1 Oct 29 20:30:24.681232 kernel: alternatives: patching kernel code Oct 29 20:30:24.681238 kernel: devtmpfs: initialized Oct 29 20:30:24.681244 kernel: KASLR enabled Oct 29 20:30:24.681250 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 29 20:30:24.681257 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 29 20:30:24.681263 kernel: pinctrl core: initialized pinctrl subsystem Oct 29 20:30:24.681269 kernel: SMBIOS 3.0.0 present. Oct 29 20:30:24.681275 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 29 20:30:24.681280 kernel: NET: Registered protocol family 16 Oct 29 20:30:24.681286 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 29 20:30:24.681292 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 29 20:30:24.681299 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 29 20:30:24.681305 kernel: audit: initializing netlink subsys (disabled) Oct 29 20:30:24.681311 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Oct 29 20:30:24.681317 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 29 20:30:24.681323 kernel: cpuidle: using governor menu Oct 29 20:30:24.681329 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 29 20:30:24.681335 kernel: ASID allocator initialised with 32768 entries Oct 29 20:30:24.681341 kernel: ACPI: bus type PCI registered Oct 29 20:30:24.681347 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 29 20:30:24.681354 kernel: Serial: AMBA PL011 UART driver Oct 29 20:30:24.681360 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 29 20:30:24.681366 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 29 20:30:24.681372 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 29 20:30:24.681378 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 29 20:30:24.681384 kernel: cryptd: max_cpu_qlen set to 1000 Oct 29 20:30:24.681390 kernel: ACPI: Added _OSI(Module Device) Oct 29 20:30:24.681396 kernel: ACPI: Added _OSI(Processor Device) Oct 29 20:30:24.681402 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 29 20:30:24.681409 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 29 20:30:24.681415 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 29 20:30:24.681421 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 29 20:30:24.681427 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 29 20:30:24.681433 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 29 20:30:24.681439 kernel: ACPI: Interpreter enabled Oct 29 20:30:24.681445 kernel: ACPI: Using GIC for interrupt routing Oct 29 20:30:24.681451 kernel: ACPI: MCFG table detected, 1 entries Oct 29 20:30:24.681457 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 29 20:30:24.681463 kernel: printk: console [ttyAMA0] enabled Oct 29 20:30:24.681470 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 29 20:30:24.681573 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 29 20:30:24.681632 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 29 20:30:24.681684 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 29 20:30:24.681736 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 29 20:30:24.681794 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 29 20:30:24.681802 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 29 20:30:24.681810 kernel: PCI host bridge to bus 0000:00 Oct 29 20:30:24.681870 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 29 20:30:24.681918 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 29 20:30:24.681965 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 29 20:30:24.682012 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 29 20:30:24.682084 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 29 20:30:24.682146 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 29 20:30:24.682202 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 29 20:30:24.682256 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 29 20:30:24.682309 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 29 20:30:24.682363 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 29 20:30:24.682416 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 29 20:30:24.682470 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 29 20:30:24.682519 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 29 20:30:24.682567 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 29 20:30:24.682614 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 29 20:30:24.682622 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 29 20:30:24.682628 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 29 20:30:24.682634 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 29 20:30:24.682640 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 29 20:30:24.682646 kernel: vgaarb: loaded Oct 29 20:30:24.682652 kernel: Registered efivars operations Oct 29 20:30:24.682658 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 29 20:30:24.682666 kernel: VFS: Disk quotas dquot_6.6.0 Oct 29 20:30:24.682672 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 29 20:30:24.682678 kernel: pnp: PnP ACPI init Oct 29 20:30:24.682738 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 29 20:30:24.682794 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 29 20:30:24.682803 kernel: pnp: PnP ACPI: found 1 devices Oct 29 20:30:24.682809 kernel: NET: Registered protocol family 2 Oct 29 20:30:24.682815 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 29 20:30:24.682823 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 29 20:30:24.682830 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 29 20:30:24.682836 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 29 20:30:24.682842 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 29 20:30:24.682848 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 29 20:30:24.682855 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 29 20:30:24.682861 kernel: NET: Registered protocol family 1 Oct 29 20:30:24.682867 kernel: PCI: CLS 0 bytes, default 64 Oct 29 20:30:24.682873 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 29 20:30:24.682880 kernel: kvm [1]: HYP mode not available Oct 29 20:30:24.682885 kernel: Initialise system trusted keyrings Oct 29 20:30:24.682891 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 29 20:30:24.682897 kernel: Key type asymmetric registered Oct 29 20:30:24.682903 kernel: Asymmetric key parser 'x509' registered Oct 29 20:30:24.682909 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 29 20:30:24.682916 kernel: io scheduler mq-deadline registered Oct 29 20:30:24.682921 kernel: io scheduler kyber registered Oct 29 20:30:24.682927 kernel: io scheduler bfq registered Oct 29 20:30:24.682935 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 29 20:30:24.682941 kernel: ACPI: Power Button [PWRB] Oct 29 20:30:24.682947 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 29 20:30:24.683001 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 29 20:30:24.683009 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 29 20:30:24.683015 kernel: msm_serial: driver initialized Oct 29 20:30:24.683021 kernel: random: fast init done Oct 29 20:30:24.683027 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 29 20:30:24.683033 kernel: random: crng init done Oct 29 20:30:24.683056 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 29 20:30:24.683064 kernel: thunder_xcv, ver 1.0 Oct 29 20:30:24.683070 kernel: thunder_bgx, ver 1.0 Oct 29 20:30:24.683076 kernel: nicpf, ver 1.0 Oct 29 20:30:24.683082 kernel: nicvf, ver 1.0 Oct 29 20:30:24.683142 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 29 20:30:24.683191 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-29T20:30:24 UTC (1761769824) Oct 29 20:30:24.683200 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 29 20:30:24.683206 kernel: NET: Registered protocol family 10 Oct 29 20:30:24.683213 kernel: Segment Routing with IPv6 Oct 29 20:30:24.683219 kernel: NET: Registered protocol family 17 Oct 29 20:30:24.683225 kernel: Key type dns_resolver registered Oct 29 20:30:24.683231 kernel: registered taskstats version 1 Oct 29 20:30:24.683237 kernel: Loading compiled-in X.509 certificates Oct 29 20:30:24.683243 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 29 20:30:24.683249 kernel: Key type ._fscrypt registered Oct 29 20:30:24.683255 kernel: Key type .fscrypt registered Oct 29 20:30:24.683261 kernel: Key type fscrypt-provisioning registered Oct 29 20:30:24.683268 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 29 20:30:24.683274 kernel: ima: Allocated hash algorithm: sha1 Oct 29 20:30:24.683280 kernel: ima: No architecture policies found Oct 29 20:30:24.683286 kernel: Freeing unused kernel memory: 34240K Oct 29 20:30:24.683292 kernel: Run /init as init process Oct 29 20:30:24.683298 kernel: with arguments: Oct 29 20:30:24.683304 kernel: /init Oct 29 20:30:24.683309 kernel: with environment: Oct 29 20:30:24.683315 kernel: HOME=/ Oct 29 20:30:24.683321 kernel: TERM=linux Oct 29 20:30:24.683328 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 29 20:30:24.683336 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 29 20:30:24.683344 systemd[1]: Detected virtualization kvm. Oct 29 20:30:24.683351 systemd[1]: Detected architecture arm64. Oct 29 20:30:24.683357 systemd[1]: Running in initial RAM disk. Oct 29 20:30:24.683363 systemd[1]: No hostname configured, using default hostname. Oct 29 20:30:24.683369 systemd[1]: Hostname set to . Oct 29 20:30:24.683377 systemd[1]: Initializing machine ID from VM UUID. Oct 29 20:30:24.683384 systemd[1]: Queued start job for default target Initrd Default Target. Oct 29 20:30:24.683390 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 29 20:30:24.683397 systemd[1]: Reached target Local Encrypted Volumes. Oct 29 20:30:24.683403 systemd[1]: Reached target Path Units. Oct 29 20:30:24.683409 systemd[1]: Reached target Slice Units. Oct 29 20:30:24.683416 systemd[1]: Reached target Swaps. Oct 29 20:30:24.683422 systemd[1]: Reached target Timer Units. Oct 29 20:30:24.683429 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 29 20:30:24.683436 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 29 20:30:24.683442 systemd[1]: Listening on Journal Audit Socket. Oct 29 20:30:24.683449 systemd[1]: Listening on Journal Socket (/dev/log). Oct 29 20:30:24.683455 systemd[1]: Listening on Journal Socket. Oct 29 20:30:24.683461 systemd[1]: Listening on Network Service Netlink Socket. Oct 29 20:30:24.683468 systemd[1]: Listening on udev Control Socket. Oct 29 20:30:24.683474 systemd[1]: Listening on udev Kernel Socket. Oct 29 20:30:24.683480 systemd[1]: Reached target Socket Units. Oct 29 20:30:24.683488 systemd[1]: Starting Create List of Static Device Nodes... Oct 29 20:30:24.683494 systemd[1]: Finished Network Cleanup. Oct 29 20:30:24.683501 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 29 20:30:24.683507 systemd[1]: Starting Journal Service... Oct 29 20:30:24.683513 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 29 20:30:24.683520 systemd[1]: Starting Apply Kernel Variables... Oct 29 20:30:24.683526 systemd[1]: Starting Setup Virtual Console... Oct 29 20:30:24.683532 systemd[1]: Finished Create List of Static Device Nodes. Oct 29 20:30:24.683538 systemd[1]: Finished Apply Kernel Variables. Oct 29 20:30:24.683546 systemd[1]: Finished Setup Virtual Console. Oct 29 20:30:24.683552 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 29 20:30:24.683561 systemd-journald[278]: Journal started Oct 29 20:30:24.683593 systemd-journald[278]: Runtime Journal (/run/log/journal/aa202aacd10c488194879fdc4acf541e) is 6.0M, max 48.5M, 42.4M free. Oct 29 20:30:24.685531 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 29 20:30:24.687059 systemd[1]: Started Journal Service. Oct 29 20:30:24.687217 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 29 20:30:24.696740 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 29 20:30:24.698375 systemd[1]: Starting dracut cmdline hook... Oct 29 20:30:24.706776 dracut-cmdline[296]: dracut-dracut-053 Oct 29 20:30:24.708949 dracut-cmdline[296]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 29 20:30:24.765062 kernel: SCSI subsystem initialized Oct 29 20:30:24.768055 kernel: Loading iSCSI transport class v2.0-870. Oct 29 20:30:24.774074 kernel: iscsi: registered transport (tcp) Oct 29 20:30:24.785076 kernel: iscsi: registered transport (qla4xxx) Oct 29 20:30:24.785092 kernel: QLogic iSCSI HBA Driver Oct 29 20:30:24.794329 systemd[1]: Finished dracut cmdline hook. Oct 29 20:30:24.795663 systemd[1]: Starting dracut pre-udev hook... Oct 29 20:30:24.808609 kernel: device-mapper: uevent: version 1.0.3 Oct 29 20:30:24.808635 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 29 20:30:24.843069 kernel: raid6: neonx8 gen() 13769 MB/s Oct 29 20:30:24.860059 kernel: raid6: neonx8 xor() 10732 MB/s Oct 29 20:30:24.877072 kernel: raid6: neonx4 gen() 13636 MB/s Oct 29 20:30:24.894061 kernel: raid6: neonx4 xor() 11594 MB/s Oct 29 20:30:24.911068 kernel: raid6: neonx2 gen() 13031 MB/s Oct 29 20:30:24.928072 kernel: raid6: neonx2 xor() 9778 MB/s Oct 29 20:30:24.945071 kernel: raid6: neonx1 gen() 10987 MB/s Oct 29 20:30:24.962070 kernel: raid6: neonx1 xor() 8840 MB/s Oct 29 20:30:24.979070 kernel: raid6: int64x8 gen() 6836 MB/s Oct 29 20:30:24.996071 kernel: raid6: int64x8 xor() 3786 MB/s Oct 29 20:30:25.013071 kernel: raid6: int64x4 gen() 6919 MB/s Oct 29 20:30:25.030071 kernel: raid6: int64x4 xor() 3831 MB/s Oct 29 20:30:25.047070 kernel: raid6: int64x2 gen() 6187 MB/s Oct 29 20:30:25.064071 kernel: raid6: int64x2 xor() 3320 MB/s Oct 29 20:30:25.081070 kernel: raid6: int64x1 gen() 5012 MB/s Oct 29 20:30:25.098155 kernel: raid6: int64x1 xor() 2598 MB/s Oct 29 20:30:25.098177 kernel: raid6: using algorithm neonx8 gen() 13769 MB/s Oct 29 20:30:25.098193 kernel: raid6: .... xor() 10732 MB/s, rmw enabled Oct 29 20:30:25.099262 kernel: raid6: using neon recovery algorithm Oct 29 20:30:25.109058 kernel: xor: measuring software checksum speed Oct 29 20:30:25.110063 kernel: 8regs : 17041 MB/sec Oct 29 20:30:25.111518 kernel: 32regs : 20723 MB/sec Oct 29 20:30:25.111530 kernel: arm64_neon : 29173 MB/sec Oct 29 20:30:25.111538 kernel: xor: using function: arm64_neon (29173 MB/sec) Oct 29 20:30:25.157067 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 29 20:30:25.166703 systemd[1]: Finished dracut pre-udev hook. Oct 29 20:30:25.167000 audit: BPF prog-id=6 op=LOAD Oct 29 20:30:25.168000 audit: BPF prog-id=7 op=LOAD Oct 29 20:30:25.169685 kernel: audit: type=1334 audit(1761769825.167:2): prog-id=6 op=LOAD Oct 29 20:30:25.169705 kernel: audit: type=1334 audit(1761769825.168:3): prog-id=7 op=LOAD Oct 29 20:30:25.169713 kernel: audit: type=1334 audit(1761769825.169:4): prog-id=8 op=LOAD Oct 29 20:30:25.169000 audit: BPF prog-id=8 op=LOAD Oct 29 20:30:25.170109 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 29 20:30:25.181876 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 29 20:30:25.183563 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 29 20:30:25.186107 systemd[1]: Starting dracut pre-trigger hook... Oct 29 20:30:25.188000 audit: BPF prog-id=9 op=LOAD Oct 29 20:30:25.189663 systemd[1]: Starting Network Configuration... Oct 29 20:30:25.191893 kernel: audit: type=1334 audit(1761769825.188:5): prog-id=9 op=LOAD Oct 29 20:30:25.200906 dracut-pre-trigger[424]: rd.md=0: removing MD RAID activation Oct 29 20:30:25.207806 systemd-networkd[427]: lo: Link UP Oct 29 20:30:25.207814 systemd-networkd[427]: lo: Gained carrier Oct 29 20:30:25.208110 systemd-networkd[427]: Enumeration completed Oct 29 20:30:25.208660 systemd[1]: Started Network Configuration. Oct 29 20:30:25.211030 systemd[1]: Starting Network Name Resolution... Oct 29 20:30:25.213579 kernel: audit: type=1334 audit(1761769825.210:6): prog-id=10 op=LOAD Oct 29 20:30:25.210000 audit: BPF prog-id=10 op=LOAD Oct 29 20:30:25.226896 systemd[1]: Finished dracut pre-trigger hook. Oct 29 20:30:25.228337 systemd[1]: Starting Coldplug All udev Devices... Oct 29 20:30:25.237690 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 29 20:30:25.251537 systemd-resolved[444]: Positive Trust Anchors: Oct 29 20:30:25.251549 systemd-resolved[444]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 20:30:25.251577 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 29 20:30:25.251840 systemd-resolved[444]: Defaulting to hostname 'linux'. Oct 29 20:30:25.252674 systemd[1]: Started Network Name Resolution. Oct 29 20:30:25.254602 systemd[1]: Reached target Network. Oct 29 20:30:25.261248 systemd[1]: Reached target Host and Network Name Lookups. Oct 29 20:30:25.262717 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 29 20:30:25.268783 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 29 20:30:25.270377 systemd[1]: Starting Open-iSCSI... Oct 29 20:30:25.271186 systemd[1]: Finished Coldplug All udev Devices. Oct 29 20:30:25.272987 iscsid[483]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 29 20:30:25.272987 iscsid[483]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log Oct 29 20:30:25.272987 iscsid[483]: 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 29 20:30:25.272987 iscsid[483]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 29 20:30:25.272987 iscsid[483]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 29 20:30:25.272987 iscsid[483]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 29 20:30:25.272987 iscsid[483]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 29 20:30:25.276085 systemd[1]: Started Open-iSCSI. Oct 29 20:30:25.278814 systemd[1]: Starting dracut initqueue hook... Oct 29 20:30:25.294655 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 29 20:30:25.294791 kernel: vda: detected capacity change from 0 to 4756340736 Oct 29 20:30:25.307693 systemd-udevd[474]: Using default interface naming scheme 'v249'. Oct 29 20:30:25.308863 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 20:30:25.312919 systemd-networkd[427]: eth0: Link UP Oct 29 20:30:25.324554 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Oct 29 20:30:25.327330 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 29 20:30:25.329550 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 29 20:30:25.330663 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 29 20:30:25.334625 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (474) Oct 29 20:30:25.340379 systemd[1]: Found device /dev/disk/by-label/OEM. Oct 29 20:30:25.341555 systemd[1]: Reached target Initrd Root Device. Oct 29 20:30:25.343524 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 29 20:30:25.345710 systemd[1]: Finished dracut initqueue hook. Oct 29 20:30:25.346663 systemd[1]: Reached target Preparation for Remote File Systems. Oct 29 20:30:25.348473 systemd[1]: Reached target Remote Encrypted Volumes. Oct 29 20:30:25.350188 systemd[1]: Reached target Remote File Systems. Oct 29 20:30:25.352306 systemd[1]: Starting dracut pre-mount hook... Oct 29 20:30:25.355055 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 20:30:25.359066 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 20:30:25.360527 systemd[1]: Finished dracut pre-mount hook. Oct 29 20:30:25.364057 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 20:30:26.339091 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 29 20:30:26.339184 systemd-networkd[427]: eth0: Gained carrier Oct 29 20:30:26.352843 systemd-networkd[427]: eth0: DHCPv4 address 10.0.0.5/16 via 10.0.0.1 Oct 29 20:30:26.370837 disk-uuid[503]: The operation has completed successfully. Oct 29 20:30:26.372226 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 20:30:26.389443 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 29 20:30:26.390212 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 29 20:30:26.392475 systemd[1]: Starting Ignition (setup)... Oct 29 20:30:26.400054 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 29 20:30:26.400096 kernel: BTRFS info (device vda6): has skinny extents Oct 29 20:30:26.405710 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 29 20:30:26.410318 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 29 20:30:26.410431 systemd[1]: Finished Ignition (setup). Oct 29 20:30:26.412573 systemd[1]: Starting Ignition (disks)... Oct 29 20:30:26.421937 ignition[540]: Ignition v0.36.1-15-gde4e6cc9 Oct 29 20:30:26.421955 ignition[540]: Stage: disks Oct 29 20:30:26.421963 ignition[540]: reading system config file "/usr/lib/ignition/base.ign" Oct 29 20:30:26.421973 ignition[540]: no config at "/usr/lib/ignition/base.ign" Oct 29 20:30:26.422014 ignition[540]: parsed url from cmdline: "" Oct 29 20:30:26.422017 ignition[540]: no config URL provided Oct 29 20:30:26.422021 ignition[540]: reading system config file "/usr/lib/ignition/user.ign" Oct 29 20:30:26.422029 ignition[540]: no config at "/usr/lib/ignition/user.ign" Oct 29 20:30:26.422076 ignition[540]: op(1): [started] loading QEMU firmware config module Oct 29 20:30:26.422081 ignition[540]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 29 20:30:26.423096 ignition[540]: op(1): [finished] loading QEMU firmware config module Oct 29 20:30:26.436321 ignition[540]: parsing config with SHA512: 4b386c901ff3926ed74aa6f53a44eec93723f5831efb1396e670d89902168d320b6015c7812a74412ad994a520fd4bd0f7be4171b2c4548c0993cdde198de862 Oct 29 20:30:26.438320 ignition[540]: disks: disks passed Oct 29 20:30:26.438330 ignition[540]: Ignition finished successfully Oct 29 20:30:26.438981 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 29 20:30:26.439112 systemd[1]: Finished Ignition (disks). Oct 29 20:30:26.440531 systemd[1]: Reached target Preparation for Local File Systems. Oct 29 20:30:26.442739 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 29 20:30:26.445169 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 29 20:30:26.453632 systemd-fsck[553]: ROOT: clean, 528/553792 files, 37752/553472 blocks Oct 29 20:30:26.457661 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 29 20:30:26.459684 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 29 20:30:26.459352 systemd[1]: Mounting /sysroot... Oct 29 20:30:26.475888 systemd[1]: Found device /dev/mapper/usr. Oct 29 20:30:26.478814 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 29 20:30:26.481301 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 29 20:30:26.493085 systemd-fsck[570]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 29 20:30:26.493085 systemd-fsck[570]: You must have r/w access to the filesystem or be root Oct 29 20:30:26.499295 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 29 20:30:26.499313 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 29 20:30:26.499109 systemd-fsck[566]: fsck failed with exit status 8. Oct 29 20:30:26.499113 systemd-fsck[566]: Ignoring error. Oct 29 20:30:26.499162 systemd[1]: Mounted /sysroot. Oct 29 20:30:26.501109 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 29 20:30:26.502552 systemd[1]: Reached target Initrd Root File System. Oct 29 20:30:26.504214 systemd[1]: Mounting /sysusr/usr... Oct 29 20:30:26.511884 systemd[1]: Mounted /sysusr/usr. Oct 29 20:30:26.513131 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 29 20:30:26.512644 systemd[1]: Reached target Local File Systems. Oct 29 20:30:26.513822 systemd[1]: Reached target System Initialization. Oct 29 20:30:26.515249 systemd[1]: Reached target Basic System. Oct 29 20:30:26.517625 systemd[1]: Mounting /sysroot/usr... Oct 29 20:30:26.519566 systemd[1]: Mounted /sysroot/usr. Oct 29 20:30:26.520857 systemd[1]: Starting Root filesystem setup... Oct 29 20:30:26.544994 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 29 20:30:26.545154 systemd[1]: Finished Root filesystem setup. Oct 29 20:30:26.547373 systemd[1]: Starting Ignition (files)... Oct 29 20:30:26.548580 systemd[1]: Starting /sysroot/boot... Oct 29 20:30:26.550388 ignition[585]: Ignition v0.36.1-15-gde4e6cc9 Oct 29 20:30:26.550395 ignition[585]: Stage: files Oct 29 20:30:26.550404 ignition[585]: reading system config file "/usr/lib/ignition/base.ign" Oct 29 20:30:26.550413 ignition[585]: no config at "/usr/lib/ignition/base.ign" Oct 29 20:30:26.550910 ignition[585]: files: compiled without relabeling support, skipping Oct 29 20:30:26.565305 ignition[585]: files: createUsers: op(1): [started] creating or modifying user "core" Oct 29 20:30:26.565318 ignition[585]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Oct 29 20:30:26.566692 ignition[585]: files: createUsers: op(1): [finished] creating or modifying user "core" Oct 29 20:30:26.566706 ignition[585]: files: createUsers: op(2): [started] adding ssh keys to user "core" Oct 29 20:30:26.568022 ignition[585]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Oct 29 20:30:26.569431 systemd[1]: ignition-files.service: Deactivated successfully. Oct 29 20:30:26.568051 ignition[585]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Oct 29 20:30:26.569542 systemd[1]: Finished Ignition (files). Oct 29 20:30:26.568335 ignition[585]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Oct 29 20:30:26.570373 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Oct 29 20:30:26.568342 ignition[585]: files: op(4): [started] processing unit "coreos-metadata.service" Oct 29 20:30:26.583736 kernel: audit: type=1334 audit(1761769826.580:7): prog-id=10 op=UNLOAD Oct 29 20:30:26.583769 kernel: audit: type=1334 audit(1761769826.581:8): prog-id=3 op=UNLOAD Oct 29 20:30:26.580000 audit: BPF prog-id=10 op=UNLOAD Oct 29 20:30:26.581000 audit: BPF prog-id=3 op=UNLOAD Oct 29 20:30:26.570949 systemd[1]: Starting Reload Configuration from the Real Root... Oct 29 20:30:26.568425 ignition[585]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 29 20:30:26.573502 systemd[1]: Finished /sysroot/boot. Oct 29 20:30:26.568837 ignition[585]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 29 20:30:26.576987 systemd[1]: Starting Ignition (record completion)... Oct 29 20:30:26.568843 ignition[585]: files: op(4): [finished] processing unit "coreos-metadata.service" Oct 29 20:30:26.589000 audit: BPF prog-id=9 op=UNLOAD Oct 29 20:30:26.589000 audit: BPF prog-id=6 op=UNLOAD Oct 29 20:30:26.578137 systemd[1]: Reloading. Oct 29 20:30:26.593222 kernel: audit: type=1334 audit(1761769826.589:9): prog-id=9 op=UNLOAD Oct 29 20:30:26.593242 kernel: audit: type=1334 audit(1761769826.589:10): prog-id=6 op=UNLOAD Oct 29 20:30:26.568847 ignition[585]: files: files passed Oct 29 20:30:26.568850 ignition[585]: Ignition finished successfully Oct 29 20:30:26.668000 audit: BPF prog-id=11 op=LOAD Oct 29 20:30:26.668000 audit: BPF prog-id=12 op=LOAD Oct 29 20:30:26.668000 audit: BPF prog-id=13 op=LOAD Oct 29 20:30:26.668000 audit: BPF prog-id=14 op=LOAD Oct 29 20:30:26.668000 audit: BPF prog-id=4 op=UNLOAD Oct 29 20:30:26.668000 audit: BPF prog-id=5 op=UNLOAD Oct 29 20:30:26.669000 audit: BPF prog-id=15 op=LOAD Oct 29 20:30:26.669000 audit: BPF prog-id=16 op=LOAD Oct 29 20:30:26.669000 audit: BPF prog-id=17 op=LOAD Oct 29 20:30:26.669000 audit: BPF prog-id=18 op=LOAD Oct 29 20:30:26.669000 audit: BPF prog-id=7 op=UNLOAD Oct 29 20:30:26.669000 audit: BPF prog-id=8 op=UNLOAD Oct 29 20:30:26.670322 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 29 20:30:26.670443 systemd[1]: Finished Ignition (record completion). Oct 29 20:30:26.683993 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 29 20:30:26.684134 systemd[1]: Finished Reload Configuration from the Real Root. Oct 29 20:30:26.685963 systemd[1]: Reached target Initrd File Systems. Oct 29 20:30:26.687510 systemd[1]: Reached target Initrd Default Target. Oct 29 20:30:26.688931 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 29 20:30:26.689584 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 29 20:30:26.699441 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 29 20:30:26.701000 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 29 20:30:26.706691 systemd[1]: Stopped target Host and Network Name Lookups. Oct 29 20:30:26.707719 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 29 20:30:26.709365 systemd[1]: Stopped target Timer Units. Oct 29 20:30:26.710795 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 29 20:30:26.710897 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 29 20:30:26.712315 systemd[1]: Stopped target Initrd Default Target. Oct 29 20:30:26.713871 systemd[1]: Stopped target Basic System. Oct 29 20:30:26.715300 systemd[1]: Stopped target Initrd Root Device. Oct 29 20:30:26.716715 systemd[1]: Stopped target Path Units. Oct 29 20:30:26.717972 systemd[1]: Stopped target Remote File Systems. Oct 29 20:30:26.719395 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 29 20:30:26.720882 systemd[1]: Stopped target Slice Units. Oct 29 20:30:26.722215 systemd[1]: Stopped target Socket Units. Oct 29 20:30:26.723704 systemd[1]: Stopped target System Initialization. Oct 29 20:30:26.725020 systemd[1]: Stopped target Local File Systems. Oct 29 20:30:26.726361 systemd[1]: Stopped target Preparation for Local File Systems. Oct 29 20:30:26.727961 systemd[1]: Stopped target Swaps. Oct 29 20:30:26.729224 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 29 20:30:26.729327 systemd[1]: Stopped dracut pre-mount hook. Oct 29 20:30:26.730805 systemd[1]: Stopped target Local Encrypted Volumes. Oct 29 20:30:26.732006 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 29 20:30:26.737552 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 29 20:30:26.739056 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 29 20:30:26.739161 systemd[1]: Stopped dracut initqueue hook. Oct 29 20:30:26.742775 iscsid[483]: iscsid shutting down. Oct 29 20:30:26.740948 systemd[1]: Stopping Open-iSCSI... Oct 29 20:30:26.742745 systemd[1]: Stopping /sysroot/boot... Oct 29 20:30:26.743396 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 29 20:30:26.743522 systemd[1]: Stopped Coldplug All udev Devices. Oct 29 20:30:26.744799 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 29 20:30:26.744880 systemd[1]: Stopped dracut pre-trigger hook. Oct 29 20:30:26.747122 systemd[1]: iscsid.service: Deactivated successfully. Oct 29 20:30:26.747251 systemd[1]: Stopped Open-iSCSI. Oct 29 20:30:26.748752 systemd[1]: iscsid.socket: Deactivated successfully. Oct 29 20:30:26.748884 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 29 20:30:26.749964 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 29 20:30:26.751898 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 29 20:30:26.752010 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 29 20:30:26.753343 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 29 20:30:26.753449 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 29 20:30:26.755072 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 29 20:30:26.755175 systemd[1]: Stopped /sysroot/boot. Oct 29 20:30:26.756660 systemd[1]: Stopped target Network. Oct 29 20:30:26.757490 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 29 20:30:26.757553 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 29 20:30:26.759164 systemd[1]: Stopping Network Name Resolution... Oct 29 20:30:26.764027 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 29 20:30:26.764157 systemd[1]: Stopped Network Name Resolution. Oct 29 20:30:26.765693 systemd[1]: Stopping Network Configuration... Oct 29 20:30:26.770648 systemd-networkd[427]: eth0: DHCP lease lost Oct 29 20:30:26.775000 audit: BPF prog-id=11 op=UNLOAD Oct 29 20:30:26.779111 systemd-networkd[427]: eth0: DHCPv6 lease lost Oct 29 20:30:26.780844 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 29 20:30:26.780970 systemd[1]: Stopped Network Configuration. Oct 29 20:30:26.782732 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 29 20:30:26.782771 systemd[1]: Closed Network Service Netlink Socket. Oct 29 20:30:26.784510 systemd[1]: Stopping Network Cleanup... Oct 29 20:30:26.789000 audit: BPF prog-id=15 op=UNLOAD Oct 29 20:30:26.785426 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 29 20:30:26.785494 systemd[1]: Stopped Apply Kernel Variables. Oct 29 20:30:26.787600 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 29 20:30:26.792391 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 29 20:30:26.792502 systemd[1]: Stopped Network Cleanup. Oct 29 20:30:26.795544 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 29 20:30:26.795664 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 29 20:30:26.797662 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 29 20:30:26.797695 systemd[1]: Closed udev Control Socket. Oct 29 20:30:26.799113 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 29 20:30:26.799147 systemd[1]: Closed udev Kernel Socket. Oct 29 20:30:26.800670 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 29 20:30:26.800713 systemd[1]: Stopped dracut pre-udev hook. Oct 29 20:30:26.806000 audit: BPF prog-id=16 op=UNLOAD Oct 29 20:30:26.801957 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 29 20:30:26.801998 systemd[1]: Stopped dracut cmdline hook. Oct 29 20:30:26.803532 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 29 20:30:26.803574 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 29 20:30:26.805609 systemd[1]: Starting Cleanup udev Database... Oct 29 20:30:26.806740 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 29 20:30:26.808079 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 29 20:30:26.808144 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 29 20:30:26.809811 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 29 20:30:26.809854 systemd[1]: Stopped Create List of Static Device Nodes. Oct 29 20:30:26.811270 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 20:30:26.811316 systemd[1]: Stopped Setup Virtual Console. Oct 29 20:30:26.813015 systemd[1]: rngd.service: Deactivated successfully. Oct 29 20:30:26.813144 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 29 20:30:26.824000 audit: BPF prog-id=12 op=UNLOAD Oct 29 20:30:26.814717 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 29 20:30:26.814824 systemd[1]: Finished Cleanup udev Database. Oct 29 20:30:26.815975 systemd[1]: Reached target Switch Root. Oct 29 20:30:26.817969 systemd[1]: Starting Switch Root... Oct 29 20:30:26.822607 systemd[1]: Switching root. Oct 29 20:30:26.834153 systemd-journald[278]: Journal stopped Oct 29 20:30:28.971742 systemd-journald[278]: Received SIGTERM from PID 1 (systemd). Oct 29 20:30:28.971802 kernel: SELinux: policy capability network_peer_controls=1 Oct 29 20:30:28.971814 kernel: SELinux: policy capability open_perms=1 Oct 29 20:30:28.971823 kernel: SELinux: policy capability extended_socket_class=1 Oct 29 20:30:28.971832 kernel: SELinux: policy capability always_check_network=0 Oct 29 20:30:28.971841 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 29 20:30:28.971850 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 29 20:30:28.971862 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 29 20:30:28.971871 systemd[1]: Successfully loaded SELinux policy in 31.965ms. Oct 29 20:30:28.971886 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.471ms. Oct 29 20:30:28.971897 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 29 20:30:28.971906 systemd[1]: Detected virtualization kvm. Oct 29 20:30:28.971916 systemd[1]: Detected architecture arm64. Oct 29 20:30:28.971925 systemd[1]: Detected first boot. Oct 29 20:30:28.971934 systemd[1]: Initializing machine ID from VM UUID. Oct 29 20:30:28.971945 systemd[1]: Populated /etc with preset unit settings. Oct 29 20:30:28.971957 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 29 20:30:28.971967 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 29 20:30:28.971977 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 29 20:30:28.971986 systemd[1]: Stopped Switch Root. Oct 29 20:30:28.971996 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 29 20:30:28.972005 systemd[1]: Created slice Slice /system/addon-config. Oct 29 20:30:28.972015 systemd[1]: Created slice Slice /system/addon-run. Oct 29 20:30:28.972026 systemd[1]: Created slice Slice /system/getty. Oct 29 20:30:28.972035 systemd[1]: Created slice Slice /system/modprobe. Oct 29 20:30:28.972060 systemd[1]: Created slice Slice /system/serial-getty. Oct 29 20:30:28.972071 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 29 20:30:28.972080 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 29 20:30:28.972090 systemd[1]: Created slice User and Session Slice. Oct 29 20:30:28.972103 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 29 20:30:28.972112 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 29 20:30:28.972121 systemd[1]: Set up automount Boot partition Automount Point. Oct 29 20:30:28.972132 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 29 20:30:28.972142 systemd[1]: Stopped target Switch Root. Oct 29 20:30:28.972152 systemd[1]: Stopped target Initrd File Systems. Oct 29 20:30:28.972161 systemd[1]: Stopped target Initrd Root File System. Oct 29 20:30:28.972171 systemd[1]: Reached target Remote Encrypted Volumes. Oct 29 20:30:28.972180 systemd[1]: Reached target Remote File Systems. Oct 29 20:30:28.972190 systemd[1]: Reached target Slice Units. Oct 29 20:30:28.972200 systemd[1]: Reached target Swaps. Oct 29 20:30:28.972209 systemd[1]: Reached target Verify torcx succeeded. Oct 29 20:30:28.972218 systemd[1]: Reached target Local Verity Protected Volumes. Oct 29 20:30:28.972229 systemd[1]: Listening on Process Core Dump Socket. Oct 29 20:30:28.972239 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 29 20:30:28.972248 systemd[1]: Listening on Network Service Netlink Socket. Oct 29 20:30:28.972257 systemd[1]: Listening on udev Control Socket. Oct 29 20:30:28.972267 systemd[1]: Listening on udev Kernel Socket. Oct 29 20:30:28.972276 systemd[1]: Mounting Huge Pages File System... Oct 29 20:30:28.972285 systemd[1]: Mounting POSIX Message Queue File System... Oct 29 20:30:28.972295 systemd[1]: Mounting External Media Directory... Oct 29 20:30:28.972305 systemd[1]: Mounting Kernel Debug File System... Oct 29 20:30:28.972314 systemd[1]: Mounting Kernel Trace File System... Oct 29 20:30:28.972324 systemd[1]: Mounting Temporary Directory /tmp... Oct 29 20:30:28.972335 systemd[1]: Starting Create missing system files... Oct 29 20:30:28.972345 systemd[1]: Starting Create List of Static Device Nodes... Oct 29 20:30:28.972354 systemd[1]: Starting Load Kernel Module configfs... Oct 29 20:30:28.972364 systemd[1]: Starting Load Kernel Module drm... Oct 29 20:30:28.972373 systemd[1]: Starting Load Kernel Module fuse... Oct 29 20:30:28.972382 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 29 20:30:28.972392 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 29 20:30:28.972401 systemd[1]: Stopped File System Check on Root Device. Oct 29 20:30:28.972411 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 29 20:30:28.972421 systemd[1]: Stopped systemd-fsck-usr.service. Oct 29 20:30:28.972430 kernel: fuse: init (API version 7.32) Oct 29 20:30:28.972439 systemd[1]: Stopped Journal Service. Oct 29 20:30:28.972448 kernel: kauditd_printk_skb: 42 callbacks suppressed Oct 29 20:30:28.972457 kernel: audit: type=1334 audit(1761769828.954:53): prog-id=30 op=LOAD Oct 29 20:30:28.972465 kernel: audit: type=1334 audit(1761769828.956:54): prog-id=31 op=LOAD Oct 29 20:30:28.972474 kernel: audit: type=1334 audit(1761769828.957:55): prog-id=32 op=LOAD Oct 29 20:30:28.972484 systemd[1]: Starting Journal Service... Oct 29 20:30:28.972493 kernel: audit: type=1334 audit(1761769828.957:56): prog-id=28 op=UNLOAD Oct 29 20:30:28.972503 kernel: audit: type=1334 audit(1761769828.957:57): prog-id=29 op=UNLOAD Oct 29 20:30:28.972512 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 29 20:30:28.972522 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 29 20:30:28.972531 systemd[1]: Starting Apply Kernel Variables... Oct 29 20:30:28.972541 systemd[1]: Starting Coldplug All udev Devices... Oct 29 20:30:28.972550 systemd[1]: verity-setup.service: Deactivated successfully. Oct 29 20:30:28.972560 kernel: audit: type=1305 audit(1761769828.970:58): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 29 20:30:28.972569 systemd[1]: Stopped verity-setup.service. Oct 29 20:30:28.972580 systemd-journald[800]: Journal started Oct 29 20:30:28.972613 systemd-journald[800]: Runtime Journal (/run/log/journal/aa202aacd10c488194879fdc4acf541e) is 6.0M, max 48.5M, 42.4M free. Oct 29 20:30:26.897000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 29 20:30:26.929000 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 29 20:30:26.929000 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 29 20:30:26.929000 audit: BPF prog-id=19 op=LOAD Oct 29 20:30:26.929000 audit: BPF prog-id=19 op=UNLOAD Oct 29 20:30:26.929000 audit: BPF prog-id=20 op=LOAD Oct 29 20:30:26.929000 audit: BPF prog-id=20 op=UNLOAD Oct 29 20:30:26.961000 audit[749]: AVC avc: denied { associate } for pid=749 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 29 20:30:28.831000 audit: BPF prog-id=21 op=LOAD Oct 29 20:30:28.832000 audit: BPF prog-id=22 op=LOAD Oct 29 20:30:28.832000 audit: BPF prog-id=23 op=LOAD Oct 29 20:30:28.832000 audit: BPF prog-id=13 op=UNLOAD Oct 29 20:30:28.832000 audit: BPF prog-id=14 op=UNLOAD Oct 29 20:30:28.842000 audit: BPF prog-id=24 op=LOAD Oct 29 20:30:28.842000 audit: BPF prog-id=21 op=UNLOAD Oct 29 20:30:28.842000 audit: BPF prog-id=25 op=LOAD Oct 29 20:30:28.842000 audit: BPF prog-id=26 op=LOAD Oct 29 20:30:28.843000 audit: BPF prog-id=22 op=UNLOAD Oct 29 20:30:28.843000 audit: BPF prog-id=23 op=UNLOAD Oct 29 20:30:28.843000 audit: BPF prog-id=27 op=LOAD Oct 29 20:30:28.843000 audit: BPF prog-id=24 op=UNLOAD Oct 29 20:30:28.843000 audit: BPF prog-id=28 op=LOAD Oct 29 20:30:28.843000 audit: BPF prog-id=29 op=LOAD Oct 29 20:30:28.843000 audit: BPF prog-id=25 op=UNLOAD Oct 29 20:30:28.843000 audit: BPF prog-id=26 op=UNLOAD Oct 29 20:30:28.856000 audit: BPF prog-id=27 op=UNLOAD Oct 29 20:30:28.954000 audit: BPF prog-id=30 op=LOAD Oct 29 20:30:28.956000 audit: BPF prog-id=31 op=LOAD Oct 29 20:30:28.957000 audit: BPF prog-id=32 op=LOAD Oct 29 20:30:28.957000 audit: BPF prog-id=28 op=UNLOAD Oct 29 20:30:28.957000 audit: BPF prog-id=29 op=UNLOAD Oct 29 20:30:28.970000 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 29 20:30:28.831240 systemd[1]: Queued start job for default target Multi-User System. Oct 29 20:30:26.960086 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" 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 29 20:30:28.844024 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 29 20:30:26.960395 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 29 20:30:26.960414 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 29 20:30:26.960556 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 29 20:30:26.960569 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 29 20:30:26.960597 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 29 20:30:26.960610 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 29 20:30:26.960808 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 29 20:30:26.960845 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 29 20:30:26.960860 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 29 20:30:26.961228 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" 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 29 20:30:26.961258 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" 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 29 20:30:26.961277 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" 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 29 20:30:26.961292 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 29 20:30:26.961311 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" 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 29 20:30:26.961325 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:26Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 29 20:30:28.664021 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:28Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 29 20:30:28.664326 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:28Z" 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 29 20:30:28.664425 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:28Z" 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 29 20:30:28.664551 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:28Z" 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 29 20:30:28.664604 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:28Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 29 20:30:28.664663 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-10-29T20:30:28Z" 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 29 20:30:28.976061 systemd[1]: Started Journal Service. Oct 29 20:30:28.977148 systemd[1]: Mounted Huge Pages File System. Oct 29 20:30:28.978006 systemd[1]: Mounted POSIX Message Queue File System. Oct 29 20:30:28.978964 systemd[1]: Mounted External Media Directory. Oct 29 20:30:28.979938 systemd[1]: Mounted Kernel Debug File System. Oct 29 20:30:28.980890 systemd[1]: Mounted Kernel Trace File System. Oct 29 20:30:28.981845 systemd[1]: Mounted Temporary Directory /tmp. Oct 29 20:30:28.982992 systemd[1]: Finished Create missing system files. Oct 29 20:30:28.984230 systemd[1]: Finished Create List of Static Device Nodes. Oct 29 20:30:28.985331 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 29 20:30:28.985512 systemd[1]: Finished Load Kernel Module configfs. Oct 29 20:30:28.986566 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 29 20:30:28.986739 systemd[1]: Finished Load Kernel Module drm. Oct 29 20:30:28.987743 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 29 20:30:28.987928 systemd[1]: Finished Load Kernel Module fuse. Oct 29 20:30:28.989078 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 29 20:30:28.999889 systemd[1]: Finished Apply Kernel Variables. Oct 29 20:30:29.002702 systemd[1]: Mounting FUSE Control File System... Oct 29 20:30:29.004441 systemd[1]: Mounting Kernel Configuration File System... Oct 29 20:30:29.005297 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 29 20:30:29.006599 systemd[1]: Starting Rebuild Hardware Database... Oct 29 20:30:29.008459 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 29 20:30:29.009429 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 29 20:30:29.010336 systemd[1]: Starting Load/Save Random Seed... Oct 29 20:30:29.012094 systemd[1]: Starting Create System Users... Oct 29 20:30:29.013828 systemd[1]: Mounted FUSE Control File System. Oct 29 20:30:29.014752 systemd-journald[800]: Time spent on flushing to /var/log/journal/aa202aacd10c488194879fdc4acf541e is 8.037ms for 784 entries. Oct 29 20:30:29.014752 systemd-journald[800]: System Journal (/var/log/journal/aa202aacd10c488194879fdc4acf541e) is 8.0M, max 203.0M, 195.0M free. Oct 29 20:30:29.015540 systemd[1]: Mounted Kernel Configuration File System. Oct 29 20:30:29.020957 systemd[1]: Finished Coldplug All udev Devices. Oct 29 20:30:29.022314 systemd[1]: Finished Load/Save Random Seed. Oct 29 20:30:29.023193 systemd[1]: Reached target First Boot Complete. Oct 29 20:30:29.029858 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 29 20:30:29.031793 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 29 20:30:29.033111 systemd-sysusers[812]: Creating group sgx with gid 999. Oct 29 20:30:29.033894 systemd-sysusers[812]: Creating group systemd-oom with gid 998. Oct 29 20:30:29.034370 systemd-sysusers[812]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Oct 29 20:30:29.034955 systemd-sysusers[812]: Creating group systemd-timesync with gid 997. Oct 29 20:30:29.035403 systemd-sysusers[812]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Oct 29 20:30:29.035956 systemd-sysusers[812]: Creating group systemd-coredump with gid 996. Oct 29 20:30:29.036480 systemd-sysusers[812]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Oct 29 20:30:29.045329 systemd[1]: Finished Create System Users. Oct 29 20:30:29.054869 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 29 20:30:29.067189 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 29 20:30:29.257425 systemd[1]: Finished Rebuild Hardware Database. Oct 29 20:30:29.266525 kernel: audit: type=1334 audit(1761769829.264:59): prog-id=33 op=LOAD Oct 29 20:30:29.266596 kernel: audit: type=1334 audit(1761769829.264:60): prog-id=34 op=LOAD Oct 29 20:30:29.266611 kernel: audit: type=1334 audit(1761769829.265:61): prog-id=35 op=LOAD Oct 29 20:30:29.264000 audit: BPF prog-id=33 op=LOAD Oct 29 20:30:29.264000 audit: BPF prog-id=34 op=LOAD Oct 29 20:30:29.265000 audit: BPF prog-id=35 op=LOAD Oct 29 20:30:29.266491 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 29 20:30:29.266785 kernel: audit: type=1334 audit(1761769829.265:62): prog-id=17 op=UNLOAD Oct 29 20:30:29.265000 audit: BPF prog-id=17 op=UNLOAD Oct 29 20:30:29.265000 audit: BPF prog-id=18 op=UNLOAD Oct 29 20:30:29.290011 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 29 20:30:29.299000 audit: BPF prog-id=36 op=LOAD Oct 29 20:30:29.300186 systemd[1]: Starting Network Configuration... Oct 29 20:30:29.317669 systemd-udevd[832]: Using default interface naming scheme 'v249'. Oct 29 20:30:29.329665 systemd-networkd[835]: lo: Link UP Oct 29 20:30:29.329676 systemd-networkd[835]: lo: Gained carrier Oct 29 20:30:29.330021 systemd-networkd[835]: Enumeration completed Oct 29 20:30:29.330128 systemd[1]: Started Network Configuration. Oct 29 20:30:29.331354 systemd-networkd[835]: eth0: Link UP Oct 29 20:30:29.341132 systemd-networkd[835]: eth0: Gained carrier Oct 29 20:30:29.345221 systemd-networkd[835]: eth0: DHCPv4 address 10.0.0.5/16 via 10.0.0.1 Oct 29 20:30:29.347323 udevadm[814]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 29 20:30:29.371101 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 29 20:30:29.380816 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 29 20:30:29.388631 lvm[844]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 29 20:30:29.419072 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 29 20:30:29.420535 systemd[1]: Reached target Local Encrypted Volumes. Oct 29 20:30:29.438964 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 29 20:30:29.442615 lvm[845]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 29 20:30:29.467033 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 29 20:30:29.468370 systemd[1]: Reached target Preparation for Local File Systems. Oct 29 20:30:29.469485 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 29 20:30:29.469513 systemd[1]: Reached target Containers. Oct 29 20:30:29.479914 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 29 20:30:29.491597 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 29 20:30:29.493630 systemd[1]: Mounting /usr/share/oem... Oct 29 20:30:29.499603 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 29 20:30:29.499678 kernel: BTRFS info (device vda6): has skinny extents Oct 29 20:30:29.501828 systemd[1]: Mounted /usr/share/oem. Oct 29 20:30:29.502620 systemd[1]: Reached target Local File Systems. Oct 29 20:30:29.509805 systemd[1]: Starting Rebuild Dynamic Linker Cache... Oct 29 20:30:29.511058 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 29 20:30:29.511096 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 29 20:30:29.511992 systemd[1]: Starting Commit a transient machine-id on disk... Oct 29 20:30:29.513935 systemd[1]: Starting Create Volatile Files and Directories... Oct 29 20:30:29.521909 systemd-tmpfiles[870]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 29 20:30:29.523249 systemd-tmpfiles[870]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 29 20:30:29.526606 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 29 20:30:29.527912 systemd[1]: Finished Commit a transient machine-id on disk. Oct 29 20:30:29.557241 systemd-tmpfiles[870]: Detected autofs mount point /boot during canonicalization of /boot. Oct 29 20:30:29.557252 systemd-tmpfiles[870]: Skipping /boot Oct 29 20:30:29.563967 systemd-tmpfiles[870]: Detected autofs mount point /boot during canonicalization of /boot. Oct 29 20:30:29.563978 systemd-tmpfiles[870]: Skipping /boot Oct 29 20:30:29.585073 systemd[1]: Finished Rebuild Dynamic Linker Cache. Oct 29 20:30:29.598699 systemd[1]: Finished Create Volatile Files and Directories. Oct 29 20:30:29.600921 systemd[1]: Starting Load Security Auditing Rules... Oct 29 20:30:29.602838 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 29 20:30:29.604863 systemd[1]: Starting Rebuild Journal Catalog... Oct 29 20:30:29.606000 audit: BPF prog-id=37 op=LOAD Oct 29 20:30:29.607383 systemd[1]: Starting Network Name Resolution... Oct 29 20:30:29.609000 audit: BPF prog-id=38 op=LOAD Oct 29 20:30:29.611598 systemd[1]: Starting Network Time Synchronization... Oct 29 20:30:29.613337 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 29 20:30:29.614836 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 29 20:30:29.617538 systemd[1]: Finished Rebuild Journal Catalog. Oct 29 20:30:29.619607 systemd[1]: Starting Update is Completed... Oct 29 20:30:29.620351 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 29 20:30:29.620849 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 29 20:30:29.626970 systemd[1]: Finished Update is Completed. Oct 29 20:30:29.634000 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 29 20:30:29.634430 augenrules[892]: No rules Oct 29 20:30:29.635136 systemd[1]: Finished Load Security Auditing Rules. Oct 29 20:30:29.651468 systemd-resolved[880]: Positive Trust Anchors: Oct 29 20:30:29.651478 systemd-resolved[880]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 20:30:29.651505 systemd-resolved[880]: 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 29 20:30:29.652334 systemd-resolved[880]: Defaulting to hostname 'linux'. Oct 29 20:30:29.169751 systemd-timesyncd[881]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 29 20:30:29.170951 systemd[1]: Started Network Time Synchronization. Oct 29 20:30:29.172011 systemd[1]: Started Network Name Resolution. Oct 29 20:30:29.172951 systemd[1]: Reached target Network. Oct 29 20:30:29.173759 systemd[1]: Reached target Host and Network Name Lookups. Oct 29 20:30:29.174757 systemd[1]: Reached target System Initialization. Oct 29 20:30:29.176500 systemd[1]: Started Watch for update engine configuration changes. Oct 29 20:30:29.177629 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 29 20:30:29.178910 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 29 20:30:29.179854 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 29 20:30:29.179882 systemd[1]: Reached target Path Units. Oct 29 20:30:29.180607 systemd[1]: Reached target System Time Set. Oct 29 20:30:29.181612 systemd[1]: Started Daily Log Rotation. Oct 29 20:30:29.182501 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 29 20:30:29.183647 systemd[1]: Reached target Timer Units. Oct 29 20:30:29.184748 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 29 20:30:29.201234 systemd[1]: Starting Docker Socket for the API... Oct 29 20:30:29.204163 systemd[1]: Listening on OpenSSH Server Socket. Oct 29 20:30:29.205387 systemd[1]: Listening on Docker Socket for the API. Oct 29 20:30:29.206345 systemd[1]: Reached target Socket Units. Oct 29 20:30:29.207117 systemd[1]: Reached target Basic System. Oct 29 20:30:29.207897 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 29 20:30:29.207926 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 29 20:30:29.208875 systemd[1]: Started D-Bus System Message Bus. Oct 29 20:30:29.211835 systemd[1]: Starting Extend Filesystems... Oct 29 20:30:29.212590 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 29 20:30:29.213497 systemd[1]: Starting Generate /run/flatcar/motd... Oct 29 20:30:29.215227 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 29 20:30:29.217151 systemd[1]: Starting Generate sshd host keys... Oct 29 20:30:29.217989 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 29 20:30:29.218011 systemd[1]: Reached target Load system-provided cloud configs. Oct 29 20:30:29.220768 systemd[1]: Starting User Login Management... Oct 29 20:30:29.222257 extend-filesystems[903]: Found vda Oct 29 20:30:29.223470 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 29 20:30:29.223831 extend-filesystems[903]: Found vda1 Oct 29 20:30:29.223831 extend-filesystems[903]: Found vda2 Oct 29 20:30:29.224814 systemd[1]: Starting Update Engine... Oct 29 20:30:29.225809 extend-filesystems[903]: Found vda3 Oct 29 20:30:29.225809 extend-filesystems[903]: Found usr Oct 29 20:30:29.225809 extend-filesystems[903]: Found vda4 Oct 29 20:30:29.225809 extend-filesystems[903]: Found vda6 Oct 29 20:30:29.225809 extend-filesystems[903]: Found vda7 Oct 29 20:30:29.225809 extend-filesystems[903]: Found vda9 Oct 29 20:30:29.225809 extend-filesystems[903]: Checking size of /dev/vda9 Oct 29 20:30:29.227333 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 29 20:30:29.227356 systemd[1]: Reached target Load user-provided cloud configs. Oct 29 20:30:29.228969 systemd[1]: motdgen.service: Deactivated successfully. Oct 29 20:30:29.229191 systemd[1]: Finished Generate /run/flatcar/motd. Oct 29 20:30:29.230955 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 29 20:30:29.231154 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 29 20:30:29.238316 extend-filesystems[903]: Old size kept for /dev/vda9 Oct 29 20:30:29.239067 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 29 20:30:29.239266 systemd[1]: Finished Extend Filesystems. Oct 29 20:30:29.259088 update_engine[918]: I1029 20:30:29.258826 918 main.cc:89] Flatcar Update Engine starting Oct 29 20:30:29.261025 systemd[1]: Started Update Engine. Oct 29 20:30:29.261275 update_engine[918]: I1029 20:30:29.261247 918 update_check_scheduler.cc:74] Next update check in 7m37s Oct 29 20:30:29.270915 systemd[1]: Started Cluster reboot manager. Oct 29 20:30:29.273234 systemd-logind[914]: Watching system buttons on /dev/input/event0 (Power Button) Oct 29 20:30:29.273391 systemd-logind[914]: New seat seat0. Oct 29 20:30:29.276262 systemd[1]: Started User Login Management. Oct 29 20:30:29.299694 locksmithd[926]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 29 20:30:29.709641 sshd_keygen[919]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Oct 29 20:30:29.727225 systemd[1]: Finished Generate sshd host keys. Oct 29 20:30:29.747381 systemd[1]: Starting Generate /run/issue... Oct 29 20:30:29.751571 systemd[1]: issuegen.service: Deactivated successfully. Oct 29 20:30:29.751769 systemd[1]: Finished Generate /run/issue. Oct 29 20:30:29.753801 systemd[1]: Starting Permit User Sessions... Oct 29 20:30:29.757710 systemd[1]: Finished Permit User Sessions. Oct 29 20:30:29.759711 systemd[1]: Started Getty on tty1. Oct 29 20:30:29.761479 systemd[1]: Started Serial Getty on ttyAMA0. Oct 29 20:30:29.762451 systemd[1]: Reached target Login Prompts. Oct 29 20:30:29.763370 systemd[1]: Reached target Multi-User System. Oct 29 20:30:29.765309 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 29 20:30:29.769813 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 29 20:30:29.770014 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 29 20:30:29.771002 systemd[1]: Startup finished in 689ms (kernel) + 2.301s (initrd) + 3.389s (userspace) = 6.380s. Oct 29 20:30:30.334566 systemd-networkd[835]: eth0: Gained IPv6LL Oct 29 20:30:35.919950 systemd[1]: Created slice Slice /system/sshd. Oct 29 20:30:35.921110 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56010). Oct 29 20:30:35.971426 sshd[948]: Accepted publickey for core from 10.0.0.1 port 56010 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:35.973501 sshd[948]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:36.000894 systemd[1]: Created slice User Slice of UID 500. Oct 29 20:30:36.002395 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 29 20:30:36.004160 systemd-logind[914]: New session 1 of user core. Oct 29 20:30:36.008330 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 29 20:30:36.009498 systemd[1]: Starting User Manager for UID 500... Oct 29 20:30:36.011749 systemd[951]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:36.056777 systemd[951]: Queued start job for default target Main User Target. Oct 29 20:30:36.057115 systemd[951]: Reached target Paths. Oct 29 20:30:36.057196 systemd[951]: Reached target Sockets. Oct 29 20:30:36.057263 systemd[951]: Reached target Timers. Oct 29 20:30:36.057322 systemd[951]: Reached target Basic System. Oct 29 20:30:36.057416 systemd[951]: Reached target Main User Target. Oct 29 20:30:36.057488 systemd[951]: Startup finished in 42ms. Oct 29 20:30:36.057514 systemd[1]: Started User Manager for UID 500. Oct 29 20:30:36.069691 systemd[1]: Started Session 1 of User core. Oct 29 20:30:36.129171 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56018). Oct 29 20:30:36.173994 sshd[960]: Accepted publickey for core from 10.0.0.1 port 56018 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:36.174911 sshd[960]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:36.177818 systemd-logind[914]: New session 2 of user core. Oct 29 20:30:36.185972 systemd[1]: Started Session 2 of User core. Oct 29 20:30:36.239995 sshd[960]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:36.247283 systemd[1]: sshd@1-10.0.0.5:22-10.0.0.1:56018.service: Deactivated successfully. Oct 29 20:30:36.247860 systemd[1]: session-2.scope: Deactivated successfully. Oct 29 20:30:36.248390 systemd-logind[914]: Session 2 logged out. Waiting for processes to exit. Oct 29 20:30:36.249346 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56028). Oct 29 20:30:36.249943 systemd-logind[914]: Removed session 2. Oct 29 20:30:36.292937 sshd[966]: Accepted publickey for core from 10.0.0.1 port 56028 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:36.294412 sshd[966]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:36.297381 systemd-logind[914]: New session 3 of user core. Oct 29 20:30:36.313176 systemd[1]: Started Session 3 of User core. Oct 29 20:30:36.362461 sshd[966]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:36.369179 systemd[1]: sshd@2-10.0.0.5:22-10.0.0.1:56028.service: Deactivated successfully. Oct 29 20:30:36.369680 systemd[1]: session-3.scope: Deactivated successfully. Oct 29 20:30:36.370206 systemd-logind[914]: Session 3 logged out. Waiting for processes to exit. Oct 29 20:30:36.371131 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56034). Oct 29 20:30:36.371651 systemd-logind[914]: Removed session 3. Oct 29 20:30:36.414885 sshd[973]: Accepted publickey for core from 10.0.0.1 port 56034 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:36.415742 sshd[973]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:36.418634 systemd-logind[914]: New session 4 of user core. Oct 29 20:30:36.440485 systemd[1]: Started Session 4 of User core. Oct 29 20:30:36.494727 sshd[973]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:36.512065 systemd[1]: sshd@3-10.0.0.5:22-10.0.0.1:56034.service: Deactivated successfully. Oct 29 20:30:36.512651 systemd[1]: session-4.scope: Deactivated successfully. Oct 29 20:30:36.513281 systemd-logind[914]: Session 4 logged out. Waiting for processes to exit. Oct 29 20:30:36.514416 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56040). Oct 29 20:30:36.515162 systemd-logind[914]: Removed session 4. Oct 29 20:30:36.559549 sshd[979]: Accepted publickey for core from 10.0.0.1 port 56040 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:36.560726 sshd[979]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:36.563488 systemd-logind[914]: New session 5 of user core. Oct 29 20:30:36.575648 systemd[1]: Started Session 5 of User core. Oct 29 20:30:36.631158 sudo[982]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 29 20:30:36.631357 sudo[982]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:30:36.647325 sudo[982]: pam_unix(sudo:session): session closed for user root Oct 29 20:30:36.649454 sshd[979]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:36.663261 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56054). Oct 29 20:30:36.666394 dbus-daemon[902]: [system] Reloaded configuration Oct 29 20:30:36.668501 systemd[1]: sshd@4-10.0.0.5:22-10.0.0.1:56040.service: Deactivated successfully. Oct 29 20:30:36.669166 systemd[1]: session-5.scope: Deactivated successfully. Oct 29 20:30:36.669735 systemd-logind[914]: Session 5 logged out. Waiting for processes to exit. Oct 29 20:30:36.670339 systemd-logind[914]: Removed session 5. Oct 29 20:30:36.707457 sshd[985]: Accepted publickey for core from 10.0.0.1 port 56054 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:36.708407 sshd[985]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:36.710847 systemd-logind[914]: New session 6 of user core. Oct 29 20:30:36.725165 systemd[1]: Started Session 6 of User core. Oct 29 20:30:36.776292 sudo[990]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 29 20:30:36.776493 sudo[990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:30:36.778829 sudo[990]: pam_unix(sudo:session): session closed for user root Oct 29 20:30:36.782228 sudo[989]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 29 20:30:36.782427 sudo[989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:30:36.799878 systemd[1]: Stopping Load Security Auditing Rules... Oct 29 20:30:36.800000 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 29 20:30:36.802006 auditctl[993]: No rules Oct 29 20:30:36.802299 systemd[1]: audit-rules.service: Deactivated successfully. Oct 29 20:30:36.802531 systemd[1]: Stopped Load Security Auditing Rules. Oct 29 20:30:36.804013 kernel: kauditd_printk_skb: 5 callbacks suppressed Oct 29 20:30:36.804060 kernel: audit: type=1305 audit(1761769836.800:68): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 29 20:30:36.803868 systemd[1]: Starting Load Security Auditing Rules... Oct 29 20:30:36.818567 augenrules[1010]: No rules Oct 29 20:30:36.819236 systemd[1]: Finished Load Security Auditing Rules. Oct 29 20:30:36.820048 sudo[989]: pam_unix(sudo:session): session closed for user root Oct 29 20:30:36.821221 sshd[985]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:36.838303 systemd[1]: sshd@5-10.0.0.5:22-10.0.0.1:56054.service: Deactivated successfully. Oct 29 20:30:36.839083 systemd-logind[914]: Session 6 logged out. Waiting for processes to exit. Oct 29 20:30:36.839133 systemd[1]: session-6.scope: Deactivated successfully. Oct 29 20:30:36.840417 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56062). Oct 29 20:30:36.841156 systemd-logind[914]: Removed session 6. Oct 29 20:30:36.885185 sshd[1017]: Accepted publickey for core from 10.0.0.1 port 56062 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:36.888193 sshd[1017]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:36.888806 kernel: audit: type=1006 audit(1761769836.885:69): pid=1017 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 29 20:30:36.890665 systemd-logind[914]: New session 7 of user core. Oct 29 20:30:36.905106 systemd[1]: Started Session 7 of User core. Oct 29 20:30:36.956913 sudo[1020]: 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 29 20:30:39.981078 update_engine[1268]: Oct 29 20:30:39.981078 update_engine[1268]: Oct 29 20:30:39.981078 update_engine[1268]: Oct 29 20:30:39.981078 update_engine[1268]: Oct 29 20:30:39.981078 update_engine[1268]: Oct 29 20:30:39.981078 update_engine[1268]: Oct 29 20:30:39.981078 update_engine[1268]: Oct 29 20:30:39.981078 update_engine[1268]: Oct 29 20:30:39.981247 update_engine[1268]: I1029 20:30:39.981081 1268 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 29 20:30:39.983096 update_engine[1268]: I1029 20:30:39.983064 1268 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 29 20:30:39.983359 update_engine[1268]: I1029 20:30:39.983318 1268 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 29 20:30:39.984463 update_engine[1268]: I1029 20:30:39.984432 1268 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 29 20:30:39.984556 update_engine[1268]: I1029 20:30:39.984529 1268 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Oct 29 20:30:39.984556 update_engine[1268]: I1029 20:30:39.984541 1268 omaha_request_action.cc:619] Omaha request response: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.984556 update_engine[1268]: Oct 29 20:30:39.986707 update_engine[1268]: I1029 20:30:39.986501 1268 omaha_request_action.cc:447] Omaha Response manifest version = Oct 29 20:30:39.986707 update_engine[1268]: I1029 20:30:39.986531 1268 omaha_request_action.cc:470] Found 1 url(s) Oct 29 20:30:39.986707 update_engine[1268]: I1029 20:30:39.986543 1268 omaha_request_action.cc:506] Processing first of 1 package(s) Oct 29 20:30:39.986707 update_engine[1268]: I1029 20:30:39.986553 1268 omaha_request_action.cc:513] Omaha Response package name = update.gz Oct 29 20:30:39.986707 update_engine[1268]: I1029 20:30:39.986557 1268 omaha_request_action.cc:529] Url0: http://10.0.0.4:34567/packages/update.gz Oct 29 20:30:39.986707 update_engine[1268]: I1029 20:30:39.986564 1268 omaha_request_action.cc:541] Payload size = 439328019 bytes Oct 29 20:30:39.986707 update_engine[1268]: I1029 20:30:39.986574 1268 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Oct 29 20:30:39.986707 update_engine[1268]: I1029 20:30:39.986586 1268 payload_state.cc:51] Resetting all persisted state as this is a new response Oct 29 20:30:39.986707 update_engine[1268]: I1029 20:30:39.986589 1268 payload_state.cc:360] Current Response Signature = Oct 29 20:30:39.986707 update_engine[1268]: NumURLs = 1 Oct 29 20:30:39.986707 update_engine[1268]: Url0 = http://10.0.0.4:34567/packages/update.gz Oct 29 20:30:39.986707 update_engine[1268]: Payload Size = 439328019 Oct 29 20:30:39.986707 update_engine[1268]: Payload Sha256 Hash = JprWN+czonR3c0MyWAyU2g4RVVt99zqV4E+IEkT3wn8= Oct 29 20:30:39.986707 update_engine[1268]: Is Delta Payload = 0 Oct 29 20:30:39.986707 update_engine[1268]: Max Failure Count Per Url = 10 Oct 29 20:30:39.986707 update_engine[1268]: Disable Payload Backoff = 1 Oct 29 20:30:39.986707 update_engine[1268]: I1029 20:30:39.986672 1268 payload_state.cc:381] Payload Attempt Number = 0 Oct 29 20:30:39.986707 update_engine[1268]: I1029 20:30:39.986703 1268 payload_state.cc:404] Current URL Index = 0 Oct 29 20:30:39.987046 update_engine[1268]: I1029 20:30:39.986730 1268 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Oct 29 20:30:39.987046 update_engine[1268]: I1029 20:30:39.986757 1268 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Oct 29 20:30:39.987046 update_engine[1268]: I1029 20:30:39.986761 1268 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 29 20:30:39.987046 update_engine[1268]: I1029 20:30:39.986809 1268 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Oct 29 20:30:39.987046 update_engine[1268]: I1029 20:30:39.986826 1268 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Oct 29 20:30:39.987046 update_engine[1268]: I1029 20:30:39.986829 1268 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Oct 29 20:30:39.987046 update_engine[1268]: I1029 20:30:39.986845 1268 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Oct 29 20:30:39.987046 update_engine[1268]: E1029 20:30:39.986848 1268 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Oct 29 20:30:39.987301 update_engine[1268]: I1029 20:30:39.987275 1268 omaha_response_handler_action.cc:85] Using this install plan: Oct 29 20:30:39.987301 update_engine[1268]: I1029 20:30:39.987291 1268 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.4:34567/packages/update.gz, payload size: 439328019, payload hash: JprWN+czonR3c0MyWAyU2g4RVVt99zqV4E+IEkT3wn8=, 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 29 20:30:39.987410 update_engine[1268]: I1029 20:30:39.987368 1268 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Oct 29 20:30:39.988668 update_engine[1268]: I1029 20:30:39.988633 1268 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Oct 29 20:30:40.014542 sshd[1290]: Accepted publickey for core from 10.0.0.1 port 53208 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:40.014974 sshd[1290]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:40.018735 systemd-logind[914]: New session 25 of user core. Oct 29 20:30:40.022946 systemd[1]: Started Session 25 of User core. Oct 29 20:30:40.085241 sshd[1290]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:40.088282 systemd[1]: sshd@24-10.0.0.5:22-10.0.0.1:53208.service: Deactivated successfully. Oct 29 20:30:40.089001 systemd[1]: session-25.scope: Deactivated successfully. Oct 29 20:30:40.089545 systemd-logind[914]: Session 25 logged out. Waiting for processes to exit. Oct 29 20:30:40.090290 systemd-logind[914]: Removed session 25. Oct 29 20:30:41.650797 update_engine[1268]: I1029 20:30:41.650712 1268 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Oct 29 20:30:41.650797 update_engine[1268]: I1029 20:30:41.650754 1268 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Oct 29 20:30:41.716479 update_engine[1268]: E1029 20:30:41.716423 1268 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Oct 29 20:30:41.716479 update_engine[1268]: I1029 20:30:41.716465 1268 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Oct 29 20:30:41.716479 update_engine[1268]: I1029 20:30:41.716470 1268 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Oct 29 20:30:41.716479 update_engine[1268]: I1029 20:30:41.716472 1268 update_attempter.cc:302] Processing Done. Oct 29 20:30:41.716693 update_engine[1268]: E1029 20:30:41.716519 1268 update_attempter.cc:615] Update failed. Oct 29 20:30:41.716693 update_engine[1268]: I1029 20:30:41.716524 1268 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Oct 29 20:30:41.716693 update_engine[1268]: I1029 20:30:41.716528 1268 payload_state.cc:276] Incrementing the URL failure count Oct 29 20:30:41.716693 update_engine[1268]: I1029 20:30:41.716531 1268 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 29 20:30:41.716775 update_engine[1268]: I1029 20:30:41.716715 1268 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 29 20:30:41.716775 update_engine[1268]: I1029 20:30:41.716737 1268 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.4:34567/v1/update Oct 29 20:30:41.716775 update_engine[1268]: I1029 20:30:41.716742 1268 omaha_request_action.cc:269] Request: Oct 29 20:30:41.716775 update_engine[1268]: Oct 29 20:30:41.716775 update_engine[1268]: Oct 29 20:30:41.716775 update_engine[1268]: Oct 29 20:30:41.716775 update_engine[1268]: Oct 29 20:30:41.716775 update_engine[1268]: Oct 29 20:30:41.716775 update_engine[1268]: Oct 29 20:30:41.716775 update_engine[1268]: I1029 20:30:41.716745 1268 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 29 20:30:41.716968 update_engine[1268]: I1029 20:30:41.716866 1268 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 29 20:30:41.716990 update_engine[1268]: I1029 20:30:41.716974 1268 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 29 20:30:41.902217 update_engine[1268]: I1029 20:30:41.902117 1268 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 29 20:30:41.902324 update_engine[1268]: I1029 20:30:41.902218 1268 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Oct 29 20:30:41.902324 update_engine[1268]: I1029 20:30:41.902227 1268 omaha_request_action.cc:619] Omaha request response: Oct 29 20:30:41.902324 update_engine[1268]: Oct 29 20:30:41.902324 update_engine[1268]: Oct 29 20:30:41.902324 update_engine[1268]: Oct 29 20:30:41.902324 update_engine[1268]: Oct 29 20:30:41.902324 update_engine[1268]: Oct 29 20:30:41.902324 update_engine[1268]: Oct 29 20:30:41.902324 update_engine[1268]: E1029 20:30:41.902242 1268 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Oct 29 20:30:41.902324 update_engine[1268]: I1029 20:30:41.902247 1268 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 29 20:30:41.902324 update_engine[1268]: I1029 20:30:41.902251 1268 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 29 20:30:41.902324 update_engine[1268]: I1029 20:30:41.902253 1268 update_attempter.cc:302] Processing Done. Oct 29 20:30:41.902324 update_engine[1268]: I1029 20:30:41.902257 1268 update_attempter.cc:306] Error event sent. Oct 29 20:30:50.098496 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:46446). Oct 29 20:30:50.145836 sshd[1302]: Accepted publickey for core from 10.0.0.1 port 46446 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:50.147175 sshd[1302]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:50.147661 kernel: kauditd_printk_skb: 287 callbacks suppressed Oct 29 20:30:50.147701 kernel: audit: type=1006 audit(1761769850.145:365): pid=1302 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=26 res=1 Oct 29 20:30:50.149818 systemd-logind[914]: New session 26 of user core. Oct 29 20:30:50.164274 systemd[1]: Started Session 26 of User core. Oct 29 20:30:50.220807 sshd[1302]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:50.228330 systemd[1]: sshd@25-10.0.0.5:22-10.0.0.1:46446.service: Deactivated successfully. Oct 29 20:30:50.228927 systemd[1]: session-26.scope: Deactivated successfully. Oct 29 20:30:50.229437 systemd-logind[914]: Session 26 logged out. Waiting for processes to exit. Oct 29 20:30:50.230341 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:46450). Oct 29 20:30:50.230907 systemd-logind[914]: Removed session 26. Oct 29 20:30:50.275496 sshd[1309]: Accepted publickey for core from 10.0.0.1 port 46450 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:50.276918 sshd[1309]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:50.279830 kernel: audit: type=1006 audit(1761769850.275:366): pid=1309 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=27 res=1 Oct 29 20:30:50.280568 systemd-logind[914]: New session 27 of user core. Oct 29 20:30:50.288933 systemd[1]: Started Session 27 of User core. Oct 29 20:30:50.344241 sshd[1309]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:50.352475 systemd[1]: sshd@26-10.0.0.5:22-10.0.0.1:46450.service: Deactivated successfully. Oct 29 20:30:50.353054 systemd[1]: session-27.scope: Deactivated successfully. Oct 29 20:30:50.353601 systemd-logind[914]: Session 27 logged out. Waiting for processes to exit. Oct 29 20:30:50.354460 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:46456). Oct 29 20:30:50.355140 systemd-logind[914]: Removed session 27. Oct 29 20:30:50.396849 sshd[1317]: Accepted publickey for core from 10.0.0.1 port 46456 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:50.397881 sshd[1317]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:50.399803 kernel: audit: type=1006 audit(1761769850.396:367): pid=1317 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=28 res=1 Oct 29 20:30:50.401592 systemd-logind[914]: New session 28 of user core. Oct 29 20:30:50.411996 systemd[1]: Started Session 28 of User core. Oct 29 20:30:50.461633 sshd[1317]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:50.469324 systemd[1]: sshd@27-10.0.0.5:22-10.0.0.1:46456.service: Deactivated successfully. Oct 29 20:30:50.469894 systemd[1]: session-28.scope: Deactivated successfully. Oct 29 20:30:50.470421 systemd-logind[914]: Session 28 logged out. Waiting for processes to exit. Oct 29 20:30:50.471322 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:46460). Oct 29 20:30:50.472377 systemd-logind[914]: Removed session 28. Oct 29 20:30:50.516600 sshd[1323]: Accepted publickey for core from 10.0.0.1 port 46460 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:50.518049 sshd[1323]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:50.520807 kernel: audit: type=1006 audit(1761769850.516:368): pid=1323 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=29 res=1 Oct 29 20:30:50.521977 systemd-logind[914]: New session 29 of user core. Oct 29 20:30:50.535452 systemd[1]: Started Session 29 of User core. Oct 29 20:30:50.586318 sshd[1323]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:50.606112 systemd[1]: sshd@28-10.0.0.5:22-10.0.0.1:46460.service: Deactivated successfully. Oct 29 20:30:50.606720 systemd[1]: session-29.scope: Deactivated successfully. Oct 29 20:30:50.607294 systemd-logind[914]: Session 29 logged out. Waiting for processes to exit. Oct 29 20:30:50.608245 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:46474). Oct 29 20:30:50.608935 systemd-logind[914]: Removed session 29. Oct 29 20:30:50.655143 sshd[1329]: Accepted publickey for core from 10.0.0.1 port 46474 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:30:50.656231 sshd[1329]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:30:50.658817 kernel: audit: type=1006 audit(1761769850.655: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 29 20:30:50.659854 systemd-logind[914]: New session 30 of user core. Oct 29 20:30:50.671125 systemd[1]: Started Session 30 of User core. Oct 29 20:30:50.724889 sudo[1333]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Oct 29 20:30:50.725075 sudo[1333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:30:50.730632 systemd[1]: sshd.socket: Deactivated successfully. Oct 29 20:30:50.730964 systemd[1]: Closed OpenSSH Server Socket. Oct 29 20:30:50.731802 sudo[1333]: pam_unix(sudo:session): session closed for user root Oct 29 20:30:50.735155 sudo[1332]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Oct 29 20:30:50.735556 sudo[1332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:30:50.749742 sshd[948]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:50.749803 systemd[1]: Stopping Session 1 of User core... Oct 29 20:30:50.751178 systemd[1]: Stopping Session 30 of User core... Oct 29 20:30:50.751638 sshd[1329]: pam_unix(sshd:session): session closed for user core Oct 29 20:30:50.751755 sudo[1332]: pam_unix(sudo:session): session closed for user root Oct 29 20:30:50.752267 systemd[1]: Removed slice Slice /system/addon-config. Oct 29 20:30:50.753530 systemd[1]: Removed slice Slice /system/addon-run. Oct 29 20:30:50.754808 systemd[1]: Removed slice Slice /system/modprobe. Oct 29 20:30:50.755985 systemd[1]: Removed slice Slice /system/system-cloudinit. Oct 29 20:30:50.757019 systemd[1]: Stopped target Multi-User System. Oct 29 20:30:50.757890 systemd[1]: Stopped target Login Prompts. Oct 29 20:30:50.758684 systemd[1]: Stopped target Containers. Oct 29 20:30:50.759536 systemd[1]: Stopped target Host and Network Name Lookups. Oct 29 20:30:50.760558 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 29 20:30:50.761634 systemd[1]: Stopped target Timer Units. Oct 29 20:30:50.762446 systemd[1]: logrotate.timer: Deactivated successfully. Oct 29 20:30:50.762492 systemd[1]: Stopped Daily Log Rotation. Oct 29 20:30:50.763289 systemd[1]: mdadm.timer: Deactivated successfully. Oct 29 20:30:50.763330 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Oct 29 20:30:50.764445 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Oct 29 20:30:50.764487 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Oct 29 20:30:50.765523 systemd[1]: Stopped target System Time Set. Oct 29 20:30:50.766400 systemd[1]: Stopped target Load user-provided cloud configs. Oct 29 20:30:50.767443 systemd[1]: Stopped target Load system-provided cloud configs. Oct 29 20:30:50.768523 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 29 20:30:50.768630 systemd[1]: Closed Process Core Dump Socket. Oct 29 20:30:50.780184 systemd[1]: Unmounting Boot partition... Oct 29 20:30:50.781166 systemd[1]: Stopping Getty on tty1... Oct 29 20:30:50.782022 systemd[1]: Stopping Serial Getty on ttyAMA0... Oct 29 20:30:50.784281 systemd[1]: Stopping OpenSSH per-connection server daemon... Oct 29 20:30:50.785294 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:46474)... Oct 29 20:30:50.785432 sshd[1329]: pam_systemd(sshd:session): Failed to release session: Interrupted system call Oct 29 20:30:50.786429 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Oct 29 20:30:50.786594 systemd[1]: Stopped Commit a transient machine-id on disk. Oct 29 20:30:50.787717 systemd[1]: Stopped target First Boot Complete. Oct 29 20:30:50.789658 systemd[1]: Stopping Load/Save Random Seed... Oct 29 20:30:50.790716 systemd[1]: Stopping Update Engine... Oct 29 20:30:50.793949 systemd[1]: getty@tty1.service: Deactivated successfully. Oct 29 20:30:50.794145 systemd[1]: Stopped Getty on tty1. Oct 29 20:30:50.795318 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Oct 29 20:30:50.795510 systemd[1]: Stopped Serial Getty on ttyAMA0. Oct 29 20:30:50.796871 systemd[1]: sshd@0-10.0.0.5:22-10.0.0.1:56010.service: Deactivated successfully. Oct 29 20:30:50.797073 systemd[1]: Stopped OpenSSH per-connection server daemon. Oct 29 20:30:50.798540 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 29 20:30:50.798620 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 29 20:30:50.798893 systemd[1]: Stopped Update Engine. Oct 29 20:30:50.799647 systemd[1]: update-engine.service: Consumed 2.399s CPU time. Oct 29 20:30:50.800037 systemd[1]: sshd@29-10.0.0.5:22-10.0.0.1:46474.service: Deactivated successfully. Oct 29 20:30:50.800225 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:46474). Oct 29 20:30:50.812349 systemd[1]: boot.mount: Deactivated successfully. Oct 29 20:30:50.812606 systemd[1]: Unmounted Boot partition. Oct 29 20:30:50.813842 systemd[1]: systemd-random-seed.service: Deactivated successfully. Oct 29 20:30:50.814056 systemd[1]: Stopped Load/Save Random Seed. Oct 29 20:30:50.815082 systemd[1]: session-30.scope: Deactivated successfully. Oct 29 20:30:50.815312 systemd[1]: Stopped Session 30 of User core. Oct 29 20:30:50.816399 systemd[1]: session-1.scope: Deactivated successfully. Oct 29 20:30:50.816653 systemd[1]: Stopped Session 1 of User core. Oct 29 20:30:50.818703 systemd-logind[914]: Session 1 logged out. Waiting for processes to exit. Oct 29 20:30:50.819029 systemd[1]: Removed slice Slice /system/getty. Oct 29 20:30:50.820206 systemd[1]: Removed slice Slice /system/serial-getty. Oct 29 20:30:50.821451 systemd[1]: Removed slice Slice /system/sshd. Oct 29 20:30:50.822724 systemd[1]: sshd-keygen.service: Deactivated successfully. Oct 29 20:30:50.822863 systemd[1]: Stopped Generate sshd host keys. Oct 29 20:30:50.823741 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Oct 29 20:30:50.824069 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Oct 29 20:30:50.825420 systemd[1]: Stopping User Login Management... Oct 29 20:30:50.826418 systemd[1]: Stopping User Manager for UID 500... Oct 29 20:30:50.827836 systemd[951]: Stopped target Main User Target. Oct 29 20:30:50.827856 systemd[951]: Stopped target Basic System. Oct 29 20:30:50.827865 systemd[951]: Stopped target Paths. Oct 29 20:30:50.827873 systemd[951]: Stopped target Sockets. Oct 29 20:30:50.827889 systemd[951]: Reached target Shutdown. Oct 29 20:30:50.827896 systemd[951]: Stopped target Timers. Oct 29 20:30:50.828003 systemd[951]: Finished Exit the Session. Oct 29 20:30:50.828027 systemd[951]: Reached target Exit the Session. Oct 29 20:30:50.829479 systemd-logind[914]: Session 30 logged out. Waiting for processes to exit. Oct 29 20:30:50.830153 systemd[1]: user@500.service: Deactivated successfully. Oct 29 20:30:50.830325 systemd[1]: Stopped User Manager for UID 500. Oct 29 20:30:50.832355 systemd[1]: Stopping User Runtime Directory /run/user/500... Oct 29 20:30:50.837378 systemd[1]: run-user-500.mount: Deactivated successfully. Oct 29 20:30:50.837442 systemd[1]: Unmounted /run/user/500. Oct 29 20:30:50.838559 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Oct 29 20:30:50.838779 systemd[1]: Stopped User Runtime Directory /run/user/500. Oct 29 20:30:50.840403 systemd[1]: Removed slice User Slice of UID 500. Oct 29 20:30:50.842063 systemd[1]: Stopping D-Bus System Message Bus... Oct 29 20:30:50.843623 systemd[1]: Stopping Permit User Sessions... Oct 29 20:30:50.844927 systemd[1]: systemd-logind.service: Deactivated successfully. Oct 29 20:30:50.845175 systemd[1]: Stopped User Login Management. Oct 29 20:30:50.846495 systemd[1]: dbus.service: Deactivated successfully. Oct 29 20:30:50.846729 systemd[1]: Stopped D-Bus System Message Bus. Oct 29 20:30:50.847844 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Oct 29 20:30:50.848038 systemd[1]: Stopped Permit User Sessions. Oct 29 20:30:50.848925 systemd[1]: Stopped target Basic System. Oct 29 20:30:50.849666 systemd[1]: Stopped target Network. Oct 29 20:30:50.849000 audit: BPF prog-id=64 op=UNLOAD Oct 29 20:30:50.851335 systemd[1]: Stopped target Path Units. Oct 29 20:30:50.851828 kernel: audit: type=1334 audit(1761769850.849:370): prog-id=64 op=UNLOAD Oct 29 20:30:50.852067 systemd[1]: motdgen.path: Deactivated successfully. Oct 29 20:30:50.858764 systemd[1]: Stopped Watch for update engine configuration changes. Oct 29 20:30:50.859770 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Oct 29 20:30:50.861838 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 29 20:30:50.862880 systemd[1]: Stopped target Remote File Systems. Oct 29 20:30:50.863670 systemd[1]: Stopped target Slice Units. Oct 29 20:30:50.864745 systemd[1]: Removed slice User and Session Slice. Oct 29 20:30:50.865636 systemd[1]: Stopped target Socket Units. Oct 29 20:30:50.866443 systemd[1]: dbus.socket: Deactivated successfully. Oct 29 20:30:50.866503 systemd[1]: Closed D-Bus System Message Bus Socket. Oct 29 20:30:50.867501 systemd[1]: docker.socket: Deactivated successfully. Oct 29 20:30:50.867752 systemd[1]: Closed Docker Socket for the API. Oct 29 20:30:50.868716 systemd[1]: Stopped target System Initialization. Oct 29 20:30:50.869621 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Oct 29 20:30:50.869741 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Oct 29 20:30:50.870877 systemd[1]: Stopped target Local Verity Protected Volumes. Oct 29 20:30:50.881826 systemd[1]: Stopping Load Security Auditing Rules... Oct 29 20:30:50.882942 systemd[1]: Stopping Network Name Resolution... Oct 29 20:30:50.884012 systemd[1]: Stopping Network Time Synchronization... Oct 29 20:30:50.884316 auditctl[1348]: No rules Oct 29 20:30:50.884760 systemd[1]: systemd-update-done.service: Deactivated successfully. Oct 29 20:30:50.884860 systemd[1]: Stopped Update is Completed. Oct 29 20:30:50.885604 systemd[1]: ldconfig.service: Deactivated successfully. Oct 29 20:30:50.885665 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Oct 29 20:30:50.886574 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Oct 29 20:30:50.886647 systemd[1]: Stopped Rebuild Hardware Database. Oct 29 20:30:50.887504 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Oct 29 20:30:50.887567 systemd[1]: Stopped Rebuild Journal Catalog. Oct 29 20:30:50.889239 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Oct 29 20:30:50.891713 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 29 20:30:50.891995 systemd[1]: Stopped Network Name Resolution. Oct 29 20:30:50.893127 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Oct 29 20:30:50.893356 systemd[1]: Stopped Network Time Synchronization. Oct 29 20:30:50.894567 systemd[1]: audit-rules.service: Deactivated successfully. Oct 29 20:30:50.894803 systemd[1]: Stopped Load Security Auditing Rules. Oct 29 20:30:50.897050 systemd[1]: Stopping Network Configuration... Oct 29 20:30:50.898023 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Oct 29 20:30:50.898236 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Oct 29 20:30:50.898000 audit: BPF prog-id=63 op=UNLOAD Oct 29 20:30:50.900645 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 29 20:30:50.900742 systemd[1]: Stopped Create Volatile Files and Directories. Oct 29 20:30:50.900800 kernel: audit: type=1334 audit(1761769850.898:371): prog-id=63 op=UNLOAD Oct 29 20:30:50.900822 systemd-networkd[835]: eth0: DHCPv6 lease lost Oct 29 20:30:50.900000 audit: BPF prog-id=67 op=UNLOAD Oct 29 20:30:50.902736 systemd[1]: Stopped target Local File Systems. Oct 29 20:30:50.902849 kernel: audit: type=1334 audit(1761769850.900:372): prog-id=67 op=UNLOAD Oct 29 20:30:50.904596 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Oct 29 20:30:50.906094 systemd[1]: Unmounting External Media Directory... Oct 29 20:30:50.907701 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Oct 29 20:30:50.909515 systemd[1]: Unmounting /run/torcx/unpack... Oct 29 20:30:50.910849 systemd[1]: Unmounting Temporary Directory /tmp... Oct 29 20:30:50.912136 systemd[1]: Unmounting /usr/share/oem... Oct 29 20:30:50.913719 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Oct 29 20:30:50.916428 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 29 20:30:50.916676 systemd[1]: Stopped Network Configuration. Oct 29 20:30:50.917719 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 29 20:30:50.917971 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Oct 29 20:30:50.919226 systemd[1]: media.mount: Deactivated successfully. Oct 29 20:30:50.919474 systemd[1]: Unmounted External Media Directory. Oct 29 20:30:50.920455 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Oct 29 20:30:50.920700 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Oct 29 20:30:50.937012 systemd[1]: tmp.mount: Deactivated successfully. Oct 29 20:30:50.937281 systemd[1]: Unmounted Temporary Directory /tmp. Oct 29 20:30:50.938291 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Oct 29 20:30:50.938508 systemd[1]: Unmounted /run/torcx/unpack. Oct 29 20:30:50.939520 systemd[1]: usr-share-oem.mount: Deactivated successfully. Oct 29 20:30:50.939800 systemd[1]: Unmounted /usr/share/oem. Oct 29 20:30:50.940659 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 29 20:30:50.940911 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Oct 29 20:30:50.941000 audit: BPF prog-id=56 op=UNLOAD Oct 29 20:30:50.942352 systemd[1]: Stopped target Swaps. Oct 29 20:30:50.943805 kernel: audit: type=1334 audit(1761769850.941:373): prog-id=56 op=UNLOAD Oct 29 20:30:50.943874 systemd[1]: Reached target Unmount All Filesystems. Oct 29 20:30:50.944752 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 29 20:30:50.944835 systemd[1]: Closed Network Service Netlink Socket. Oct 29 20:30:50.945689 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Oct 29 20:30:50.945757 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Oct 29 20:30:50.947034 systemd[1]: Removed slice Slice /system/systemd-fsck. Oct 29 20:30:50.948111 systemd[1]: Stopped target Preparation for Local File Systems. Oct 29 20:30:50.949117 systemd[1]: lvm2-activation.service: Deactivated successfully. Oct 29 20:30:50.949189 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 29 20:30:50.950301 systemd[1]: Stopped target Local Encrypted Volumes. Oct 29 20:30:50.951200 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 29 20:30:50.951260 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 29 20:30:50.952348 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Oct 29 20:30:50.955923 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Oct 29 20:30:50.957036 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Oct 29 20:30:50.957112 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 29 20:30:50.958178 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 29 20:30:50.958233 systemd[1]: Stopped Apply Kernel Variables. Oct 29 20:30:50.959049 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 29 20:30:50.959112 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 29 20:30:50.960038 systemd[1]: systemd-sysusers.service: Deactivated successfully. Oct 29 20:30:50.960098 systemd[1]: Stopped Create System Users. Oct 29 20:30:50.960887 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Oct 29 20:30:50.960939 systemd[1]: Stopped Remount Root and Kernel File Systems. Oct 29 20:30:50.961887 systemd[1]: Reached target System Shutdown. Oct 29 20:30:50.962664 systemd[1]: Reached target Late Shutdown Services. Oct 29 20:30:50.963694 systemd[1]: systemd-reboot.service: Deactivated successfully. Oct 29 20:30:50.963733 systemd[1]: Finished System Reboot. Oct 29 20:30:50.964483 systemd[1]: Reached target System Reboot. Oct 29 20:30:50.965283 systemd[1]: Shutting down. Oct 29 20:30:50.966000 audit: BPF prog-id=59 op=UNLOAD Oct 29 20:30:50.966000 audit: BPF prog-id=58 op=UNLOAD Oct 29 20:30:50.966000 audit: BPF prog-id=57 op=UNLOAD Oct 29 20:30:50.967000 audit: BPF prog-id=62 op=UNLOAD Oct 29 20:30:50.967000 audit: BPF prog-id=61 op=UNLOAD Oct 29 20:30:50.967000 audit: BPF prog-id=60 op=UNLOAD Oct 29 20:30:50.968801 kernel: audit: type=1334 audit(1761769850.966:374): prog-id=59 op=UNLOAD Oct 29 20:30:50.968000 audit: BPF prog-id=66 op=UNLOAD Oct 29 20:30:50.968000 audit: BPF prog-id=65 op=UNLOAD Oct 29 20:30:51.009809 systemd-shutdown[1]: Syncing filesystems and block devices. Oct 29 20:30:51.016005 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Oct 29 20:30:51.016064 systemd-journald[800]: Journal stopped -- Reboot -- Oct 29 20:30:59.670260 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 29 20:30:59.670276 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 29 20:30:59.670284 kernel: efi: EFI v2.70 by EDK II Oct 29 20:30:59.670289 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 29 20:30:59.670294 kernel: efi: seeding entropy pool Oct 29 20:30:59.670299 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 29 20:30:59.670305 kernel: ACPI: Early table checksum verification disabled Oct 29 20:30:59.670310 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 29 20:30:59.670315 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 29 20:30:59.670320 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:59.670326 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:59.670331 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:59.670336 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:59.670341 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:59.670347 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:59.670352 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:59.670358 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:59.670364 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:30:59.670369 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 29 20:30:59.670374 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 29 20:30:59.670379 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:30:59.670384 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 29 20:30:59.670389 kernel: Zone ranges: Oct 29 20:30:59.670394 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:30:59.670399 kernel: DMA32 empty Oct 29 20:30:59.670404 kernel: Normal empty Oct 29 20:30:59.670409 kernel: Movable zone start for each node Oct 29 20:30:59.670415 kernel: Early memory node ranges Oct 29 20:30:59.670421 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 29 20:30:59.670426 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 29 20:30:59.670431 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 29 20:30:59.670436 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 29 20:30:59.670441 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 29 20:30:59.670446 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 29 20:30:59.670451 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 29 20:30:59.670456 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 29 20:30:59.670461 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 29 20:30:59.670466 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 29 20:30:59.670471 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 29 20:30:59.670477 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:30:59.670493 kernel: On node 0 totalpages: 643072 Oct 29 20:30:59.670499 kernel: DMA zone: 10048 pages used for memmap Oct 29 20:30:59.670505 kernel: DMA zone: 0 pages reserved Oct 29 20:30:59.670510 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 29 20:30:59.670515 kernel: psci: probing for conduit method from ACPI. Oct 29 20:30:59.670521 kernel: psci: PSCIv1.1 detected in firmware. Oct 29 20:30:59.670526 kernel: psci: Using standard PSCI v0.2 function IDs Oct 29 20:30:59.670532 kernel: psci: Trusted OS migration not required Oct 29 20:30:59.670539 kernel: psci: SMC Calling Convention v1.1 Oct 29 20:30:59.670544 kernel: ACPI: SRAT not present Oct 29 20:30:59.670550 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 29 20:30:59.670555 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 29 20:30:59.670560 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 29 20:30:59.670566 kernel: Detected PIPT I-cache on CPU0 Oct 29 20:30:59.670571 kernel: CPU features: detected: GIC system register CPU interface Oct 29 20:30:59.670577 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 29 20:30:59.670582 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 29 20:30:59.670588 kernel: CPU features: detected: Hardware dirty bit management Oct 29 20:30:59.670593 kernel: CPU features: detected: Spectre-v4 Oct 29 20:30:59.670600 kernel: CPU features: detected: ARM erratum 1418040 Oct 29 20:30:59.670605 kernel: CPU features: detected: Spectre-BHB Oct 29 20:30:59.670611 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 29 20:30:59.670616 kernel: Policy zone: DMA Oct 29 20:30:59.670623 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 29 20:30:59.670629 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 29 20:30:59.670634 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 29 20:30:59.670640 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 29 20:30:59.670646 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 29 20:30:59.670651 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 29 20:30:59.670657 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 29 20:30:59.670664 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 29 20:30:59.670670 kernel: rcu: RCU event tracing is enabled. Oct 29 20:30:59.670676 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 29 20:30:59.670702 kernel: Trampoline variant of Tasks RCU enabled. Oct 29 20:30:59.670709 kernel: Tracing variant of Tasks RCU enabled. Oct 29 20:30:59.670715 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 29 20:30:59.670720 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 29 20:30:59.670726 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 29 20:30:59.670731 kernel: GICv3: 256 SPIs implemented Oct 29 20:30:59.670737 kernel: GICv3: 0 Extended SPIs implemented Oct 29 20:30:59.670742 kernel: GICv3: Distributor has no Range Selector support Oct 29 20:30:59.670748 kernel: GICv3: 16 PPIs implemented Oct 29 20:30:59.670755 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 29 20:30:59.670760 kernel: ACPI: SRAT not present Oct 29 20:30:59.670768 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 29 20:30:59.670774 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 29 20:30:59.670780 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 29 20:30:59.670786 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 29 20:30:59.670792 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 29 20:30:59.670798 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:30:59.670803 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 29 20:30:59.670809 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 29 20:30:59.670815 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 29 20:30:59.670821 kernel: arm-pv: using stolen time PV Oct 29 20:30:59.670828 kernel: Console: colour dummy device 80x25 Oct 29 20:30:59.670833 kernel: ACPI: Core revision 20200925 Oct 29 20:30:59.670839 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 29 20:30:59.670848 kernel: pid_max: default: 32768 minimum: 301 Oct 29 20:30:59.670855 kernel: LSM: Security Framework initializing Oct 29 20:30:59.670862 kernel: SELinux: Initializing. Oct 29 20:30:59.670869 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 29 20:30:59.670875 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 29 20:30:59.670881 kernel: rcu: Hierarchical SRCU implementation. Oct 29 20:30:59.670888 kernel: Platform MSI: ITS@0x8080000 domain created Oct 29 20:30:59.670895 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 29 20:30:59.670905 kernel: Remapping and enabling EFI services. Oct 29 20:30:59.670911 kernel: smp: Bringing up secondary CPUs ... Oct 29 20:30:59.670917 kernel: Detected PIPT I-cache on CPU1 Oct 29 20:30:59.670925 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 29 20:30:59.670931 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 29 20:30:59.670937 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:30:59.670942 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 29 20:30:59.670949 kernel: Detected PIPT I-cache on CPU2 Oct 29 20:30:59.670956 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 29 20:30:59.670962 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 29 20:30:59.670967 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:30:59.670973 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 29 20:30:59.670979 kernel: Detected PIPT I-cache on CPU3 Oct 29 20:30:59.670989 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 29 20:30:59.670995 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 29 20:30:59.671002 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:30:59.671008 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 29 20:30:59.671014 kernel: smp: Brought up 1 node, 4 CPUs Oct 29 20:30:59.671037 kernel: SMP: Total of 4 processors activated. Oct 29 20:30:59.671044 kernel: CPU features: detected: Privileged Access Never Oct 29 20:30:59.671050 kernel: CPU features: detected: LSE atomic instructions Oct 29 20:30:59.671056 kernel: CPU features: detected: User Access Override Oct 29 20:30:59.671062 kernel: CPU features: detected: 32-bit EL0 Support Oct 29 20:30:59.671068 kernel: CPU features: detected: Common not Private translations Oct 29 20:30:59.671074 kernel: CPU features: detected: RAS Extension Support Oct 29 20:30:59.671082 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 29 20:30:59.671088 kernel: CPU features: detected: CRC32 instructions Oct 29 20:30:59.671094 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 29 20:30:59.671100 kernel: CPU: All CPU(s) started at EL1 Oct 29 20:30:59.671106 kernel: alternatives: patching kernel code Oct 29 20:30:59.671113 kernel: devtmpfs: initialized Oct 29 20:30:59.671119 kernel: KASLR enabled Oct 29 20:30:59.671125 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 29 20:30:59.671132 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 29 20:30:59.671138 kernel: pinctrl core: initialized pinctrl subsystem Oct 29 20:30:59.671144 kernel: SMBIOS 3.0.0 present. Oct 29 20:30:59.671150 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 29 20:30:59.671156 kernel: NET: Registered protocol family 16 Oct 29 20:30:59.671162 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 29 20:30:59.671168 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 29 20:30:59.671176 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 29 20:30:59.671182 kernel: audit: initializing netlink subsys (disabled) Oct 29 20:30:59.671188 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Oct 29 20:30:59.671194 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 29 20:30:59.671200 kernel: cpuidle: using governor menu Oct 29 20:30:59.671206 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 29 20:30:59.671212 kernel: ASID allocator initialised with 32768 entries Oct 29 20:30:59.671218 kernel: ACPI: bus type PCI registered Oct 29 20:30:59.671224 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 29 20:30:59.671231 kernel: Serial: AMBA PL011 UART driver Oct 29 20:30:59.671237 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 29 20:30:59.671243 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 29 20:30:59.671250 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 29 20:30:59.671256 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 29 20:30:59.671262 kernel: cryptd: max_cpu_qlen set to 1000 Oct 29 20:30:59.671268 kernel: ACPI: Added _OSI(Module Device) Oct 29 20:30:59.671274 kernel: ACPI: Added _OSI(Processor Device) Oct 29 20:30:59.671280 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 29 20:30:59.671287 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 29 20:30:59.671293 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 29 20:30:59.671299 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 29 20:30:59.671305 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 29 20:30:59.671311 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 29 20:30:59.671317 kernel: ACPI: Interpreter enabled Oct 29 20:30:59.671323 kernel: ACPI: Using GIC for interrupt routing Oct 29 20:30:59.671329 kernel: ACPI: MCFG table detected, 1 entries Oct 29 20:30:59.671335 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 29 20:30:59.671341 kernel: printk: console [ttyAMA0] enabled Oct 29 20:30:59.671349 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 29 20:30:59.671452 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 29 20:30:59.671518 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 29 20:30:59.671572 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 29 20:30:59.671624 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 29 20:30:59.671676 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 29 20:30:59.671697 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 29 20:30:59.671705 kernel: PCI host bridge to bus 0000:00 Oct 29 20:30:59.671767 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 29 20:30:59.671816 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 29 20:30:59.671864 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 29 20:30:59.671911 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 29 20:30:59.671975 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 29 20:30:59.672036 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 29 20:30:59.672094 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 29 20:30:59.672148 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 29 20:30:59.672202 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 29 20:30:59.672256 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 29 20:30:59.672316 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 29 20:30:59.672377 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 29 20:30:59.672444 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 29 20:30:59.672501 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 29 20:30:59.672550 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 29 20:30:59.672558 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 29 20:30:59.672564 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 29 20:30:59.672570 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 29 20:30:59.672576 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 29 20:30:59.672582 kernel: vgaarb: loaded Oct 29 20:30:59.672588 kernel: Registered efivars operations Oct 29 20:30:59.672594 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 29 20:30:59.672602 kernel: VFS: Disk quotas dquot_6.6.0 Oct 29 20:30:59.672608 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 29 20:30:59.672614 kernel: pnp: PnP ACPI init Oct 29 20:30:59.672671 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 29 20:30:59.672759 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 29 20:30:59.672769 kernel: pnp: PnP ACPI: found 1 devices Oct 29 20:30:59.672775 kernel: NET: Registered protocol family 2 Oct 29 20:30:59.672782 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 29 20:30:59.672790 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 29 20:30:59.672796 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 29 20:30:59.672802 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 29 20:30:59.672808 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 29 20:30:59.672815 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 29 20:30:59.672821 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 29 20:30:59.672827 kernel: NET: Registered protocol family 1 Oct 29 20:30:59.672833 kernel: PCI: CLS 0 bytes, default 64 Oct 29 20:30:59.672839 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 29 20:30:59.672846 kernel: kvm [1]: HYP mode not available Oct 29 20:30:59.672852 kernel: Initialise system trusted keyrings Oct 29 20:30:59.672858 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 29 20:30:59.672865 kernel: Key type asymmetric registered Oct 29 20:30:59.672870 kernel: Asymmetric key parser 'x509' registered Oct 29 20:30:59.672876 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 29 20:30:59.672883 kernel: io scheduler mq-deadline registered Oct 29 20:30:59.672889 kernel: io scheduler kyber registered Oct 29 20:30:59.672895 kernel: io scheduler bfq registered Oct 29 20:30:59.672902 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 29 20:30:59.672908 kernel: ACPI: Power Button [PWRB] Oct 29 20:30:59.672914 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 29 20:30:59.672967 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 29 20:30:59.672975 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 29 20:30:59.672981 kernel: msm_serial: driver initialized Oct 29 20:30:59.672987 kernel: random: fast init done Oct 29 20:30:59.672993 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 29 20:30:59.672999 kernel: random: crng init done Oct 29 20:30:59.673005 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 29 20:30:59.673013 kernel: thunder_xcv, ver 1.0 Oct 29 20:30:59.673019 kernel: thunder_bgx, ver 1.0 Oct 29 20:30:59.673024 kernel: nicpf, ver 1.0 Oct 29 20:30:59.673030 kernel: nicvf, ver 1.0 Oct 29 20:30:59.673094 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 29 20:30:59.673144 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-29T20:30:59 UTC (1761769859) Oct 29 20:30:59.673152 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 29 20:30:59.673158 kernel: NET: Registered protocol family 10 Oct 29 20:30:59.673165 kernel: Segment Routing with IPv6 Oct 29 20:30:59.673172 kernel: NET: Registered protocol family 17 Oct 29 20:30:59.673177 kernel: Key type dns_resolver registered Oct 29 20:30:59.673183 kernel: registered taskstats version 1 Oct 29 20:30:59.673189 kernel: Loading compiled-in X.509 certificates Oct 29 20:30:59.673196 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 29 20:30:59.673202 kernel: Key type ._fscrypt registered Oct 29 20:30:59.673208 kernel: Key type .fscrypt registered Oct 29 20:30:59.673214 kernel: Key type fscrypt-provisioning registered Oct 29 20:30:59.673221 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 29 20:30:59.673227 kernel: ima: Allocated hash algorithm: sha1 Oct 29 20:30:59.673234 kernel: ima: No architecture policies found Oct 29 20:30:59.673240 kernel: Freeing unused kernel memory: 34240K Oct 29 20:30:59.673246 kernel: Run /init as init process Oct 29 20:30:59.673252 kernel: with arguments: Oct 29 20:30:59.673257 kernel: /init Oct 29 20:30:59.673263 kernel: with environment: Oct 29 20:30:59.673269 kernel: HOME=/ Oct 29 20:30:59.673275 kernel: TERM=linux Oct 29 20:30:59.673282 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 29 20:30:59.673290 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 29 20:30:59.673298 systemd[1]: Detected virtualization kvm. Oct 29 20:30:59.673304 systemd[1]: Detected architecture arm64. Oct 29 20:30:59.673311 systemd[1]: Running in initial RAM disk. Oct 29 20:30:59.673317 systemd[1]: No hostname configured, using default hostname. Oct 29 20:30:59.673323 systemd[1]: Hostname set to . Oct 29 20:30:59.673331 systemd[1]: Initializing machine ID from VM UUID. Oct 29 20:30:59.673337 systemd[1]: Queued start job for default target Initrd Default Target. Oct 29 20:30:59.673344 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 29 20:30:59.673350 systemd[1]: Reached target Local Encrypted Volumes. Oct 29 20:30:59.673356 systemd[1]: Reached target Path Units. Oct 29 20:30:59.673363 systemd[1]: Reached target Slice Units. Oct 29 20:30:59.673369 systemd[1]: Reached target Swaps. Oct 29 20:30:59.673375 systemd[1]: Reached target Timer Units. Oct 29 20:30:59.673383 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 29 20:30:59.673390 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 29 20:30:59.673396 systemd[1]: Listening on Journal Audit Socket. Oct 29 20:30:59.673403 systemd[1]: Listening on Journal Socket (/dev/log). Oct 29 20:30:59.673409 systemd[1]: Listening on Journal Socket. Oct 29 20:30:59.673415 systemd[1]: Listening on udev Control Socket. Oct 29 20:30:59.673422 systemd[1]: Listening on udev Kernel Socket. Oct 29 20:30:59.673428 systemd[1]: Reached target Socket Units. Oct 29 20:30:59.673434 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 29 20:30:59.673442 systemd[1]: Starting Create List of Static Device Nodes... Oct 29 20:30:59.673448 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 29 20:30:59.673455 systemd[1]: Starting Journal Service... Oct 29 20:30:59.673461 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 29 20:30:59.673468 systemd[1]: Starting Apply Kernel Variables... Oct 29 20:30:59.673474 systemd[1]: Starting Setup Virtual Console... Oct 29 20:30:59.673487 kernel: SCSI subsystem initialized Oct 29 20:30:59.673494 kernel: Loading iSCSI transport class v2.0-870. Oct 29 20:30:59.673501 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 29 20:30:59.673509 systemd[1]: Finished Create List of Static Device Nodes. Oct 29 20:30:59.673521 systemd-journald[270]: Journal started Oct 29 20:30:59.673556 systemd-journald[270]: Runtime Journal (/run/log/journal/aa202aacd10c488194879fdc4acf541e) is 6.0M, max 48.5M, 42.4M free. Oct 29 20:30:59.675707 systemd[1]: Started Journal Service. Oct 29 20:30:59.675767 systemd[1]: Finished Apply Kernel Variables. Oct 29 20:30:59.676762 systemd[1]: Finished Setup Virtual Console. Oct 29 20:30:59.678716 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 29 20:30:59.680175 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 29 20:30:59.683321 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 29 20:30:59.691984 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 29 20:30:59.693622 systemd[1]: Starting dracut cmdline hook... Oct 29 20:30:59.702099 dracut-cmdline[289]: dracut-dracut-053 Oct 29 20:30:59.704321 dracut-cmdline[289]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 29 20:30:59.758710 kernel: iscsi: registered transport (tcp) Oct 29 20:30:59.769702 kernel: iscsi: registered transport (qla4xxx) Oct 29 20:30:59.769719 kernel: QLogic iSCSI HBA Driver Oct 29 20:30:59.778974 systemd[1]: Finished dracut cmdline hook. Oct 29 20:30:59.780356 systemd[1]: Starting dracut pre-udev hook... Oct 29 20:30:59.781612 systemd[1]: Starting Open-iSCSI... Oct 29 20:30:59.783765 iscsid[374]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 29 20:30:59.783765 iscsid[374]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Oct 29 20:30:59.783765 iscsid[374]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 29 20:30:59.783765 iscsid[374]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 29 20:30:59.793256 iscsid[374]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 29 20:30:59.793256 iscsid[374]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 29 20:30:59.796884 kernel: device-mapper: uevent: version 1.0.3 Oct 29 20:30:59.796900 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 29 20:30:59.787302 systemd[1]: Started Open-iSCSI. Oct 29 20:30:59.829711 kernel: raid6: neonx8 gen() 13773 MB/s Oct 29 20:30:59.846707 kernel: raid6: neonx8 xor() 10729 MB/s Oct 29 20:30:59.863706 kernel: raid6: neonx4 gen() 13604 MB/s Oct 29 20:30:59.880704 kernel: raid6: neonx4 xor() 11559 MB/s Oct 29 20:30:59.897708 kernel: raid6: neonx2 gen() 12977 MB/s Oct 29 20:30:59.914704 kernel: raid6: neonx2 xor() 9862 MB/s Oct 29 20:30:59.931708 kernel: raid6: neonx1 gen() 10869 MB/s Oct 29 20:30:59.948706 kernel: raid6: neonx1 xor() 8814 MB/s Oct 29 20:30:59.965715 kernel: raid6: int64x8 gen() 6833 MB/s Oct 29 20:30:59.982716 kernel: raid6: int64x8 xor() 3799 MB/s Oct 29 20:30:59.999716 kernel: raid6: int64x4 gen() 6892 MB/s Oct 29 20:31:00.016704 kernel: raid6: int64x4 xor() 3837 MB/s Oct 29 20:31:00.033714 kernel: raid6: int64x2 gen() 6190 MB/s Oct 29 20:31:00.050711 kernel: raid6: int64x2 xor() 3314 MB/s Oct 29 20:31:00.067714 kernel: raid6: int64x1 gen() 5017 MB/s Oct 29 20:31:00.084781 kernel: raid6: int64x1 xor() 2597 MB/s Oct 29 20:31:00.084792 kernel: raid6: using algorithm neonx8 gen() 13773 MB/s Oct 29 20:31:00.084799 kernel: raid6: .... xor() 10729 MB/s, rmw enabled Oct 29 20:31:00.085866 kernel: raid6: using neon recovery algorithm Oct 29 20:31:00.096097 kernel: xor: measuring software checksum speed Oct 29 20:31:00.096109 kernel: 8regs : 17148 MB/sec Oct 29 20:31:00.097115 kernel: 32regs : 20776 MB/sec Oct 29 20:31:00.097966 kernel: arm64_neon : 29049 MB/sec Oct 29 20:31:00.097975 kernel: xor: using function: arm64_neon (29049 MB/sec) Oct 29 20:31:00.142708 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 29 20:31:00.152383 systemd[1]: Finished dracut pre-udev hook. Oct 29 20:31:00.153000 audit: BPF prog-id=6 op=LOAD Oct 29 20:31:00.153000 audit: BPF prog-id=7 op=LOAD Oct 29 20:31:00.155410 kernel: audit: type=1334 audit(1761769860.153:2): prog-id=6 op=LOAD Oct 29 20:31:00.155428 kernel: audit: type=1334 audit(1761769860.153:3): prog-id=7 op=LOAD Oct 29 20:31:00.155439 kernel: audit: type=1334 audit(1761769860.155:4): prog-id=8 op=LOAD Oct 29 20:31:00.155000 audit: BPF prog-id=8 op=LOAD Oct 29 20:31:00.155750 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 29 20:31:00.166820 systemd-udevd[407]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 29 20:31:00.168460 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 29 20:31:00.170718 systemd[1]: Starting dracut pre-trigger hook... Oct 29 20:31:00.180752 dracut-pre-trigger[416]: rd.md=0: removing MD RAID activation Oct 29 20:31:00.202302 systemd[1]: Finished dracut pre-trigger hook. Oct 29 20:31:00.203660 systemd[1]: Starting Coldplug All udev Devices... Oct 29 20:31:00.212846 systemd-udevd[407]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 29 20:31:00.232855 systemd[1]: Finished Coldplug All udev Devices. Oct 29 20:31:00.234278 systemd[1]: Starting dracut initqueue hook... Oct 29 20:31:00.245699 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 29 20:31:00.245808 kernel: vda: detected capacity change from 0 to 4756340736 Oct 29 20:31:00.259703 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 20:31:00.266155 systemd-udevd[460]: Using default interface naming scheme 'v249'. Oct 29 20:31:00.279313 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 29 20:31:00.280951 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 29 20:31:00.283925 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (450) Oct 29 20:31:00.288933 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 29 20:31:00.296037 systemd[1]: Reached target Initrd Root Device. Oct 29 20:31:00.297498 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 29 20:31:00.300763 systemd[1]: Finished dracut initqueue hook. Oct 29 20:31:00.301599 systemd[1]: Reached target Preparation for Remote File Systems. Oct 29 20:31:00.303090 systemd[1]: Reached target Remote Encrypted Volumes. Oct 29 20:31:00.304649 systemd[1]: Reached target Remote File Systems. Oct 29 20:31:00.306758 systemd[1]: Starting dracut pre-mount hook... Oct 29 20:31:00.307629 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 29 20:31:00.307778 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 29 20:31:00.309142 systemd[1]: Reached target Preparation for Local File Systems. Oct 29 20:31:00.311280 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 29 20:31:00.315361 systemd[1]: Finished dracut pre-mount hook. Oct 29 20:31:00.316859 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 29 20:31:00.324878 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 29 20:31:00.327533 systemd-fsck[499]: ROOT: clean, 641/553792 files, 42010/553472 blocks Oct 29 20:31:00.330513 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 29 20:31:00.332233 systemd[1]: Mounting /sysroot... Oct 29 20:31:00.350666 systemd[1]: Found device /dev/mapper/usr. Oct 29 20:31:00.352073 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 29 20:31:00.353156 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 29 20:31:00.364006 systemd-fsck[514]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 29 20:31:00.364006 systemd-fsck[514]: You must have r/w access to the filesystem or be root Oct 29 20:31:00.366883 systemd-fsck[511]: fsck failed with exit status 8. Oct 29 20:31:00.366890 systemd-fsck[511]: Ignoring error. Oct 29 20:31:00.367667 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 29 20:31:00.370158 systemd[1]: Mounting /sysusr/usr... Oct 29 20:31:00.375660 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 29 20:31:00.375706 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 29 20:31:00.376881 systemd[1]: Mounted /sysroot. Oct 29 20:31:00.378140 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 29 20:31:00.378137 systemd[1]: Mounted /sysusr/usr. Oct 29 20:31:00.379062 systemd[1]: Reached target Initrd Root File System. Oct 29 20:31:00.380143 systemd[1]: Reached target Local File Systems. Oct 29 20:31:00.381544 systemd[1]: Reached target System Initialization. Oct 29 20:31:00.382986 systemd[1]: Reached target Basic System. Oct 29 20:31:00.385370 systemd[1]: Mounting /sysroot/usr... Oct 29 20:31:00.386646 systemd[1]: Starting Reload Configuration from the Real Root... Oct 29 20:31:00.388292 systemd[1]: Mounted /sysroot/usr. Oct 29 20:31:00.390802 systemd[1]: Reloading. Oct 29 20:31:00.397000 audit: BPF prog-id=3 op=UNLOAD Oct 29 20:31:00.398716 kernel: audit: type=1334 audit(1761769860.397:5): prog-id=3 op=UNLOAD Oct 29 20:31:00.398000 audit: BPF prog-id=6 op=UNLOAD Oct 29 20:31:00.400722 kernel: audit: type=1334 audit(1761769860.398:6): prog-id=6 op=UNLOAD Oct 29 20:31:00.479000 audit: BPF prog-id=9 op=LOAD Oct 29 20:31:00.480000 audit: BPF prog-id=10 op=LOAD Oct 29 20:31:00.480000 audit: BPF prog-id=11 op=LOAD Oct 29 20:31:00.482359 kernel: audit: type=1334 audit(1761769860.479:7): prog-id=9 op=LOAD Oct 29 20:31:00.482397 kernel: audit: type=1334 audit(1761769860.480:8): prog-id=10 op=LOAD Oct 29 20:31:00.482406 kernel: audit: type=1334 audit(1761769860.480:9): prog-id=11 op=LOAD Oct 29 20:31:00.482415 kernel: audit: type=1334 audit(1761769860.480:10): prog-id=4 op=UNLOAD Oct 29 20:31:00.480000 audit: BPF prog-id=4 op=UNLOAD Oct 29 20:31:00.480000 audit: BPF prog-id=5 op=UNLOAD Oct 29 20:31:00.481000 audit: BPF prog-id=12 op=LOAD Oct 29 20:31:00.482000 audit: BPF prog-id=13 op=LOAD Oct 29 20:31:00.482000 audit: BPF prog-id=14 op=LOAD Oct 29 20:31:00.482000 audit: BPF prog-id=7 op=UNLOAD Oct 29 20:31:00.482000 audit: BPF prog-id=8 op=UNLOAD Oct 29 20:31:00.496946 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 29 20:31:00.497083 systemd[1]: Finished Reload Configuration from the Real Root. Oct 29 20:31:00.498905 systemd[1]: Reached target Initrd File Systems. Oct 29 20:31:00.500394 systemd[1]: Reached target Initrd Default Target. Oct 29 20:31:00.501875 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 29 20:31:00.502545 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 29 20:31:00.512528 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 29 20:31:00.514168 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 29 20:31:00.519816 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 29 20:31:00.520789 systemd[1]: Stopped target Timer Units. Oct 29 20:31:00.522268 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 29 20:31:00.522391 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 29 20:31:00.523752 systemd[1]: Stopped target Initrd Default Target. Oct 29 20:31:00.525312 systemd[1]: Stopped target Basic System. Oct 29 20:31:00.526733 systemd[1]: Stopped target Initrd Root Device. Oct 29 20:31:00.528238 systemd[1]: Stopped target Path Units. Oct 29 20:31:00.529480 systemd[1]: Stopped target Remote File Systems. Oct 29 20:31:00.530893 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 29 20:31:00.532356 systemd[1]: Stopped target Slice Units. Oct 29 20:31:00.533666 systemd[1]: Stopped target Socket Units. Oct 29 20:31:00.535230 systemd[1]: Stopped target System Initialization. Oct 29 20:31:00.536605 systemd[1]: Stopped target Local File Systems. Oct 29 20:31:00.537951 systemd[1]: Stopped target Preparation for Local File Systems. Oct 29 20:31:00.539524 systemd[1]: Stopped target Swaps. Oct 29 20:31:00.540774 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 29 20:31:00.540888 systemd[1]: Stopped dracut pre-mount hook. Oct 29 20:31:00.542514 systemd[1]: Stopped target Local Encrypted Volumes. Oct 29 20:31:00.543794 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 29 20:31:00.547726 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 29 20:31:00.548817 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 29 20:31:00.548929 systemd[1]: Stopped dracut initqueue hook. Oct 29 20:31:00.552562 iscsid[374]: iscsid shutting down. Oct 29 20:31:00.550629 systemd[1]: Stopping Open-iSCSI... Oct 29 20:31:00.551942 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 29 20:31:00.552062 systemd[1]: Stopped Apply Kernel Variables. Oct 29 20:31:00.553368 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 29 20:31:00.553468 systemd[1]: Stopped Coldplug All udev Devices. Oct 29 20:31:00.554620 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 29 20:31:00.554743 systemd[1]: Stopped dracut pre-trigger hook. Oct 29 20:31:00.556033 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 29 20:31:00.560335 systemd[1]: iscsid.service: Deactivated successfully. Oct 29 20:31:00.560451 systemd[1]: Stopped Open-iSCSI. Oct 29 20:31:00.562138 systemd[1]: iscsid.socket: Deactivated successfully. Oct 29 20:31:00.562187 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 29 20:31:00.563566 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 29 20:31:00.566463 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 29 20:31:00.576000 audit: BPF prog-id=12 op=UNLOAD Oct 29 20:31:00.566594 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 29 20:31:00.568150 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 29 20:31:00.568266 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 29 20:31:00.569811 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 29 20:31:00.569913 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 29 20:31:00.571961 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 29 20:31:00.572012 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 29 20:31:00.573545 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 29 20:31:00.573589 systemd[1]: Closed udev Control Socket. Oct 29 20:31:00.574854 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 29 20:31:00.574891 systemd[1]: Closed udev Kernel Socket. Oct 29 20:31:00.576171 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 29 20:31:00.576220 systemd[1]: Stopped dracut pre-udev hook. Oct 29 20:31:00.577746 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 29 20:31:00.577793 systemd[1]: Stopped dracut cmdline hook. Oct 29 20:31:00.579388 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 29 20:31:00.579434 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 29 20:31:00.581811 systemd[1]: Starting Cleanup udev Database... Oct 29 20:31:00.582605 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 29 20:31:00.600000 audit: BPF prog-id=9 op=UNLOAD Oct 29 20:31:00.584228 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 29 20:31:00.584293 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 29 20:31:00.585886 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 29 20:31:00.585932 systemd[1]: Stopped Create List of Static Device Nodes. Oct 29 20:31:00.587524 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 20:31:00.587571 systemd[1]: Stopped Setup Virtual Console. Oct 29 20:31:00.589136 systemd[1]: rngd.service: Deactivated successfully. Oct 29 20:31:00.589249 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 29 20:31:00.590877 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 29 20:31:00.590978 systemd[1]: Finished Cleanup udev Database. Oct 29 20:31:00.592139 systemd[1]: Reached target Switch Root. Oct 29 20:31:00.594136 systemd[1]: Starting Switch Root... Oct 29 20:31:00.599901 systemd[1]: Switching root. Oct 29 20:31:00.616045 systemd-journald[270]: Journal stopped Oct 29 20:31:02.671021 systemd-journald[270]: Received SIGTERM from PID 1 (systemd). Oct 29 20:31:02.671067 kernel: SELinux: policy capability network_peer_controls=1 Oct 29 20:31:02.671079 kernel: SELinux: policy capability open_perms=1 Oct 29 20:31:02.671093 kernel: SELinux: policy capability extended_socket_class=1 Oct 29 20:31:02.671105 kernel: SELinux: policy capability always_check_network=0 Oct 29 20:31:02.671116 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 29 20:31:02.671126 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 29 20:31:02.671134 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 29 20:31:02.671144 systemd[1]: Successfully loaded SELinux policy in 33.376ms. Oct 29 20:31:02.671156 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.235ms. Oct 29 20:31:02.671167 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 29 20:31:02.671178 systemd[1]: Detected virtualization kvm. Oct 29 20:31:02.671187 systemd[1]: Detected architecture arm64. Oct 29 20:31:02.671198 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 29 20:31:02.671208 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 29 20:31:02.671219 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 29 20:31:02.671229 systemd[1]: Stopped Switch Root. Oct 29 20:31:02.671240 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 29 20:31:02.671250 systemd[1]: Created slice Slice /system/addon-config. Oct 29 20:31:02.671260 systemd[1]: Created slice Slice /system/addon-run. Oct 29 20:31:02.671270 systemd[1]: Created slice Slice /system/getty. Oct 29 20:31:02.671279 systemd[1]: Created slice Slice /system/modprobe. Oct 29 20:31:02.671289 systemd[1]: Created slice Slice /system/serial-getty. Oct 29 20:31:02.671298 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 29 20:31:02.671308 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 29 20:31:02.671317 systemd[1]: Created slice User and Session Slice. Oct 29 20:31:02.671327 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 29 20:31:02.671338 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 29 20:31:02.671355 systemd[1]: Set up automount Boot partition Automount Point. Oct 29 20:31:02.671365 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 29 20:31:02.671375 systemd[1]: Stopped target Switch Root. Oct 29 20:31:02.671385 systemd[1]: Stopped target Initrd File Systems. Oct 29 20:31:02.671395 systemd[1]: Stopped target Initrd Root File System. Oct 29 20:31:02.671405 systemd[1]: Reached target Remote Encrypted Volumes. Oct 29 20:31:02.671414 systemd[1]: Reached target Remote File Systems. Oct 29 20:31:02.671424 systemd[1]: Reached target Slice Units. Oct 29 20:31:02.671435 systemd[1]: Reached target Swaps. Oct 29 20:31:02.671445 systemd[1]: Reached target Verify torcx succeeded. Oct 29 20:31:02.671455 systemd[1]: Reached target Local Verity Protected Volumes. Oct 29 20:31:02.671464 systemd[1]: Listening on Process Core Dump Socket. Oct 29 20:31:02.671474 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 29 20:31:02.671484 systemd[1]: Listening on Network Service Netlink Socket. Oct 29 20:31:02.671502 systemd[1]: Listening on udev Control Socket. Oct 29 20:31:02.671512 systemd[1]: Listening on udev Kernel Socket. Oct 29 20:31:02.671522 systemd[1]: Mounting Huge Pages File System... Oct 29 20:31:02.671532 systemd[1]: Mounting POSIX Message Queue File System... Oct 29 20:31:02.671543 systemd[1]: Mounting External Media Directory... Oct 29 20:31:02.671552 systemd[1]: Mounting Kernel Debug File System... Oct 29 20:31:02.671562 systemd[1]: Mounting Kernel Trace File System... Oct 29 20:31:02.671571 systemd[1]: Mounting Temporary Directory /tmp... Oct 29 20:31:02.671581 systemd[1]: Starting Create missing system files... Oct 29 20:31:02.671590 systemd[1]: Starting Create List of Static Device Nodes... Oct 29 20:31:02.671600 systemd[1]: Starting Load Kernel Module configfs... Oct 29 20:31:02.671610 systemd[1]: Starting Load Kernel Module drm... Oct 29 20:31:02.671619 systemd[1]: Starting Load Kernel Module fuse... Oct 29 20:31:02.671630 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 29 20:31:02.671640 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 29 20:31:02.671649 systemd[1]: Stopped File System Check on Root Device. Oct 29 20:31:02.671659 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 29 20:31:02.671668 systemd[1]: Stopped systemd-fsck-usr.service. Oct 29 20:31:02.671678 kernel: fuse: init (API version 7.32) Oct 29 20:31:02.671704 systemd[1]: Stopped Journal Service. Oct 29 20:31:02.671715 systemd[1]: Starting Journal Service... Oct 29 20:31:02.671724 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 29 20:31:02.671734 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 29 20:31:02.671746 systemd[1]: Starting Apply Kernel Variables... Oct 29 20:31:02.671755 systemd[1]: Starting Coldplug All udev Devices... Oct 29 20:31:02.671765 systemd[1]: verity-setup.service: Deactivated successfully. Oct 29 20:31:02.671775 systemd[1]: Stopped verity-setup.service. Oct 29 20:31:02.671785 systemd-journald[690]: Journal started Oct 29 20:31:02.671822 systemd-journald[690]: Runtime Journal (/run/log/journal/aa202aacd10c488194879fdc4acf541e) is 6.0M, max 48.5M, 42.4M free. Oct 29 20:31:00.690000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 29 20:31:00.716000 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 29 20:31:00.716000 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 29 20:31:00.716000 audit: BPF prog-id=15 op=LOAD Oct 29 20:31:00.716000 audit: BPF prog-id=15 op=UNLOAD Oct 29 20:31:00.716000 audit: BPF prog-id=16 op=LOAD Oct 29 20:31:00.716000 audit: BPF prog-id=16 op=UNLOAD Oct 29 20:31:00.748000 audit[642]: AVC avc: denied { associate } for pid=642 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Oct 29 20:31:02.548000 audit: BPF prog-id=17 op=LOAD Oct 29 20:31:02.548000 audit: BPF prog-id=18 op=LOAD Oct 29 20:31:02.548000 audit: BPF prog-id=19 op=LOAD Oct 29 20:31:02.548000 audit: BPF prog-id=10 op=UNLOAD Oct 29 20:31:02.548000 audit: BPF prog-id=11 op=UNLOAD Oct 29 20:31:02.562000 audit: BPF prog-id=17 op=UNLOAD Oct 29 20:31:02.658000 audit: BPF prog-id=20 op=LOAD Oct 29 20:31:02.658000 audit: BPF prog-id=21 op=LOAD Oct 29 20:31:02.658000 audit: BPF prog-id=22 op=LOAD Oct 29 20:31:02.658000 audit: BPF prog-id=18 op=UNLOAD Oct 29 20:31:02.658000 audit: BPF prog-id=19 op=UNLOAD Oct 29 20:31:02.669000 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 29 20:31:02.537259 systemd[1]: Queued start job for default target Multi-User System. Oct 29 20:31:00.747106 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" 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 29 20:31:02.550182 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 29 20:31:00.747397 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 29 20:31:00.747417 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 29 20:31:00.747740 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 29 20:31:00.747754 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 29 20:31:00.747792 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 29 20:31:00.747805 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 29 20:31:00.748156 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 29 20:31:00.748195 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 29 20:31:00.748210 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 29 20:31:00.748651 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" 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 29 20:31:00.748696 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" 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 29 20:31:00.748718 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" 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 29 20:31:00.748733 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 29 20:31:00.748851 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" 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 29 20:31:00.748868 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:00Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 29 20:31:02.445548 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:02Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 29 20:31:02.445840 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:02Z" 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 29 20:31:02.445946 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:02Z" 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 29 20:31:02.446064 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:02Z" 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 29 20:31:02.446155 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:02Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 29 20:31:02.446213 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-10-29T20:31:02Z" 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 29 20:31:02.676018 systemd[1]: Started Journal Service. Oct 29 20:31:02.676517 systemd[1]: Mounted Huge Pages File System. Oct 29 20:31:02.677474 systemd[1]: Mounted POSIX Message Queue File System. Oct 29 20:31:02.678568 systemd[1]: Mounted External Media Directory. Oct 29 20:31:02.679541 systemd[1]: Mounted Kernel Debug File System. Oct 29 20:31:02.680539 systemd[1]: Mounted Kernel Trace File System. Oct 29 20:31:02.681529 systemd[1]: Mounted Temporary Directory /tmp. Oct 29 20:31:02.682738 systemd[1]: Finished Create missing system files. Oct 29 20:31:02.683940 systemd[1]: Finished Create List of Static Device Nodes. Oct 29 20:31:02.685067 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 29 20:31:02.685246 systemd[1]: Finished Load Kernel Module configfs. Oct 29 20:31:02.686322 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 29 20:31:02.686526 systemd[1]: Finished Load Kernel Module drm. Oct 29 20:31:02.687591 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 29 20:31:02.687780 systemd[1]: Finished Load Kernel Module fuse. Oct 29 20:31:02.688955 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 29 20:31:02.690192 systemd[1]: Finished Apply Kernel Variables. Oct 29 20:31:02.710605 systemd[1]: Mounting FUSE Control File System... Oct 29 20:31:02.712374 systemd[1]: Mounting Kernel Configuration File System... Oct 29 20:31:02.713241 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 29 20:31:02.714114 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 29 20:31:02.715063 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 29 20:31:02.716118 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 29 20:31:02.717202 systemd[1]: Starting Load/Save Random Seed... Oct 29 20:31:02.718088 systemd[1]: Condition check resulted in Create System Users being skipped. Oct 29 20:31:02.719531 systemd-journald[690]: Time spent on flushing to /var/log/journal/aa202aacd10c488194879fdc4acf541e is 10.662ms for 655 entries. Oct 29 20:31:02.719531 systemd-journald[690]: System Journal (/var/log/journal/aa202aacd10c488194879fdc4acf541e) is 16.0M, max 203.0M, 187.0M free. Oct 29 20:31:02.741000 audit: BPF prog-id=23 op=LOAD Oct 29 20:31:02.741000 audit: BPF prog-id=24 op=LOAD Oct 29 20:31:02.741000 audit: BPF prog-id=25 op=LOAD Oct 29 20:31:02.741000 audit: BPF prog-id=13 op=UNLOAD Oct 29 20:31:02.741000 audit: BPF prog-id=14 op=UNLOAD Oct 29 20:31:02.719110 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 29 20:31:02.722273 systemd[1]: Mounted FUSE Control File System. Oct 29 20:31:02.723486 systemd[1]: Mounted Kernel Configuration File System. Oct 29 20:31:02.726602 systemd[1]: Finished Load/Save Random Seed. Oct 29 20:31:02.727745 systemd[1]: Condition check resulted in First Boot Complete being skipped. Oct 29 20:31:02.728312 systemd[1]: Finished Coldplug All udev Devices. Oct 29 20:31:02.734243 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 29 20:31:02.739705 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 29 20:31:02.742656 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 29 20:31:02.746793 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 29 20:31:02.765865 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 29 20:31:02.767000 audit: BPF prog-id=26 op=LOAD Oct 29 20:31:02.768737 systemd[1]: Starting Network Configuration... Oct 29 20:31:02.798380 systemd-networkd[715]: lo: Link UP Oct 29 20:31:02.798388 systemd-networkd[715]: lo: Gained carrier Oct 29 20:31:02.798875 systemd-networkd[715]: Enumeration completed Oct 29 20:31:02.798958 systemd[1]: Started Network Configuration. Oct 29 20:31:02.805606 systemd-udevd[711]: Using default interface naming scheme 'v249'. Oct 29 20:31:02.826782 systemd-networkd[715]: eth0: Link UP Oct 29 20:31:02.835770 systemd-networkd[715]: eth0: Gained carrier Oct 29 20:31:02.837496 udevadm[702]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 29 20:31:02.843822 systemd-networkd[715]: eth0: DHCPv4 address 10.0.0.5/16 via 10.0.0.1 Oct 29 20:31:02.858533 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 29 20:31:02.880345 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 29 20:31:02.889668 lvm[732]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 29 20:31:02.919268 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 29 20:31:02.920750 systemd[1]: Reached target Local Encrypted Volumes. Oct 29 20:31:02.940847 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 29 20:31:02.944642 lvm[733]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 29 20:31:02.971716 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 29 20:31:02.973132 systemd[1]: Reached target Preparation for Local File Systems. Oct 29 20:31:02.974396 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 29 20:31:02.974429 systemd[1]: Reached target Containers. Oct 29 20:31:02.986083 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 29 20:31:02.998950 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 29 20:31:03.001018 systemd[1]: Mounting /usr/share/oem... Oct 29 20:31:03.006847 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 29 20:31:03.006905 kernel: BTRFS info (device vda6): has skinny extents Oct 29 20:31:03.009072 systemd[1]: Mounted /usr/share/oem. Oct 29 20:31:03.009873 systemd[1]: Reached target Local File Systems. Oct 29 20:31:03.010776 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Oct 29 20:31:03.011109 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 29 20:31:03.011145 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 29 20:31:03.011173 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 29 20:31:03.012089 systemd[1]: Starting Create Volatile Files and Directories... Oct 29 20:31:03.017654 systemd-tmpfiles[756]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 29 20:31:03.018670 systemd-tmpfiles[756]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 29 20:31:03.045109 systemd-tmpfiles[756]: Detected autofs mount point /boot during canonicalization of /boot. Oct 29 20:31:03.045124 systemd-tmpfiles[756]: Skipping /boot Oct 29 20:31:03.050485 systemd-tmpfiles[756]: Detected autofs mount point /boot during canonicalization of /boot. Oct 29 20:31:03.050513 systemd-tmpfiles[756]: Skipping /boot Oct 29 20:31:03.079128 systemd[1]: Finished Create Volatile Files and Directories. Oct 29 20:31:03.092065 systemd[1]: Starting Load Security Auditing Rules... Oct 29 20:31:03.094146 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 29 20:31:03.095266 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Oct 29 20:31:03.095000 audit: BPF prog-id=27 op=LOAD Oct 29 20:31:03.096949 systemd[1]: Starting Network Name Resolution... Oct 29 20:31:03.098000 audit: BPF prog-id=28 op=LOAD Oct 29 20:31:03.099574 systemd[1]: Starting Network Time Synchronization... Oct 29 20:31:03.101627 systemd[1]: Condition check resulted in Update is Completed being skipped. Oct 29 20:31:03.102625 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 29 20:31:03.104119 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 29 20:31:03.105351 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 29 20:31:03.112075 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 29 20:31:03.117000 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 29 20:31:03.118023 augenrules[777]: No rules Oct 29 20:31:03.130018 systemd[1]: Finished Load Security Auditing Rules. Oct 29 20:31:01.954368 systemd-timesyncd[766]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 29 20:31:01.958634 systemd-resolved[760]: Positive Trust Anchors: Oct 29 20:31:01.958652 systemd-resolved[760]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 20:31:01.958680 systemd-resolved[760]: 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 29 20:31:01.959364 systemd-resolved[760]: Defaulting to hostname 'linux'. Oct 29 20:31:01.959741 systemd[1]: Started Network Time Synchronization. Oct 29 20:31:01.960863 systemd[1]: Reached target System Initialization. Oct 29 20:31:01.962007 systemd[1]: Started Watch for update engine configuration changes. Oct 29 20:31:01.963200 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 29 20:31:01.964409 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 29 20:31:01.965506 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 29 20:31:01.965529 systemd[1]: Reached target Path Units. Oct 29 20:31:01.966425 systemd[1]: Reached target System Time Set. Oct 29 20:31:01.967537 systemd[1]: Started Daily Log Rotation. Oct 29 20:31:01.969986 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 29 20:31:01.971235 systemd[1]: Reached target Timer Units. Oct 29 20:31:01.972328 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 29 20:31:01.984225 systemd[1]: Starting Docker Socket for the API... Oct 29 20:31:01.987381 systemd[1]: Listening on OpenSSH Server Socket. Oct 29 20:31:01.988663 systemd[1]: Started Network Name Resolution. Oct 29 20:31:01.989589 systemd[1]: Listening on Docker Socket for the API. Oct 29 20:31:01.990592 systemd[1]: Reached target Network. Oct 29 20:31:01.991364 systemd[1]: Reached target Host and Network Name Lookups. Oct 29 20:31:01.992350 systemd[1]: Reached target Socket Units. Oct 29 20:31:01.993154 systemd[1]: Reached target Basic System. Oct 29 20:31:01.993964 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 29 20:31:01.993995 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 29 20:31:01.994931 systemd[1]: Started D-Bus System Message Bus. Oct 29 20:31:01.998349 systemd[1]: Starting Extend Filesystems... Oct 29 20:31:01.999222 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 29 20:31:02.000281 systemd[1]: Starting Generate /run/flatcar/motd... Oct 29 20:31:02.002198 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 29 20:31:02.004440 systemd[1]: Starting Generate sshd host keys... Oct 29 20:31:02.005540 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 29 20:31:02.005577 systemd[1]: Reached target Load system-provided cloud configs. Oct 29 20:31:02.008583 systemd[1]: Starting User Login Management... Oct 29 20:31:02.009877 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 29 20:31:02.010723 systemd[1]: Starting Update Engine... Oct 29 20:31:02.011037 extend-filesystems[787]: Found vda Oct 29 20:31:02.012180 extend-filesystems[787]: Found vda1 Oct 29 20:31:02.012180 extend-filesystems[787]: Found vda2 Oct 29 20:31:02.012180 extend-filesystems[787]: Found vda3 Oct 29 20:31:02.012180 extend-filesystems[787]: Found usr Oct 29 20:31:02.012180 extend-filesystems[787]: Found vda4 Oct 29 20:31:02.012180 extend-filesystems[787]: Found vda6 Oct 29 20:31:02.011570 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 29 20:31:02.021871 extend-filesystems[787]: Found vda7 Oct 29 20:31:02.021871 extend-filesystems[787]: Found vda9 Oct 29 20:31:02.021871 extend-filesystems[787]: Checking size of /dev/vda9 Oct 29 20:31:02.011605 systemd[1]: Reached target Load user-provided cloud configs. Oct 29 20:31:02.013702 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 29 20:31:02.013999 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 29 20:31:02.016636 systemd[1]: motdgen.service: Deactivated successfully. Oct 29 20:31:02.017378 systemd[1]: Finished Generate /run/flatcar/motd. Oct 29 20:31:02.036180 systemd-logind[797]: Watching system buttons on /dev/input/event0 (Power Button) Oct 29 20:31:02.036364 systemd-logind[797]: New seat seat0. Oct 29 20:31:02.042790 systemd[1]: Started User Login Management. Oct 29 20:31:02.050778 extend-filesystems[787]: Old size kept for /dev/vda9 Oct 29 20:31:02.051322 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 29 20:31:02.051550 systemd[1]: Finished Extend Filesystems. Oct 29 20:31:02.068078 systemd[1]: Finished Generate sshd host keys. Oct 29 20:31:02.070541 systemd[1]: Starting Generate /run/issue... Oct 29 20:31:02.075776 systemd[1]: issuegen.service: Deactivated successfully. Oct 29 20:31:02.076022 systemd[1]: Finished Generate /run/issue. Oct 29 20:31:02.078233 systemd[1]: Starting Permit User Sessions... Oct 29 20:31:02.078342 update_engine[800]: I1029 20:31:02.077929 800 main.cc:89] Flatcar Update Engine starting Oct 29 20:31:02.079393 update_engine[800]: I1029 20:31:02.079373 800 payload_state.cc:360] Current Response Signature = Oct 29 20:31:02.079393 update_engine[800]: NumURLs = 1 Oct 29 20:31:02.079393 update_engine[800]: Url0 = http://10.0.0.4:34567/packages/update.gz Oct 29 20:31:02.079393 update_engine[800]: Payload Size = 439328019 Oct 29 20:31:02.079393 update_engine[800]: Payload Sha256 Hash = JprWN+czonR3c0MyWAyU2g4RVVt99zqV4E+IEkT3wn8= Oct 29 20:31:02.079393 update_engine[800]: Is Delta Payload = 0 Oct 29 20:31:02.079393 update_engine[800]: Max Failure Count Per Url = 10 Oct 29 20:31:02.079393 update_engine[800]: Disable Payload Backoff = 1 Oct 29 20:31:02.079802 update_engine[800]: I1029 20:31:02.079782 800 payload_state.cc:381] Payload Attempt Number = 0 Oct 29 20:31:02.080046 update_engine[800]: I1029 20:31:02.080031 800 payload_state.cc:404] Current URL Index = 0 Oct 29 20:31:02.080245 update_engine[800]: I1029 20:31:02.080232 800 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 29 20:31:02.080486 update_engine[800]: I1029 20:31:02.080442 800 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 29 20:31:02.082061 systemd[1]: Started Update Engine. Oct 29 20:31:02.082875 update_engine[800]: I1029 20:31:02.082850 800 update_check_scheduler.cc:74] Next update check in 8m54s Oct 29 20:31:02.083428 systemd[1]: Finished Permit User Sessions. Oct 29 20:31:02.085479 systemd[1]: Started Getty on tty1. Oct 29 20:31:02.087354 systemd[1]: Started Serial Getty on ttyAMA0. Oct 29 20:31:02.088376 systemd[1]: Reached target Login Prompts. Oct 29 20:31:02.089295 systemd[1]: Reached target Multi-User System. Oct 29 20:31:02.091332 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 29 20:31:02.096080 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 29 20:31:02.096285 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 29 20:31:02.097334 systemd[1]: Startup finished in 685ms (kernel) + 1.101s (initrd) + 2.624s (userspace) = 4.410s. Oct 29 20:31:02.838249 systemd-networkd[715]: eth0: Gained IPv6LL Oct 29 20:31:11.823073 systemd[1]: Created slice Slice /system/sshd. Oct 29 20:31:11.824276 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56866). Oct 29 20:31:11.871718 sshd[826]: Accepted publickey for core from 10.0.0.1 port 56866 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:31:11.873698 sshd[826]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:31:11.891168 systemd[1]: Created slice User Slice of UID 500. Oct 29 20:31:11.892204 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 29 20:31:11.893668 systemd-logind[797]: New session 1 of user core. Oct 29 20:31:11.897994 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 29 20:31:11.899096 systemd[1]: Starting User Manager for UID 500... Oct 29 20:31:11.901088 systemd[829]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:31:11.946185 systemd[829]: Queued start job for default target Main User Target. Oct 29 20:31:11.946328 systemd[829]: Reached target Paths. Oct 29 20:31:11.946341 systemd[829]: Reached target Sockets. Oct 29 20:31:11.946352 systemd[829]: Reached target Timers. Oct 29 20:31:11.946362 systemd[829]: Reached target Basic System. Oct 29 20:31:11.946407 systemd[829]: Reached target Main User Target. Oct 29 20:31:11.946419 systemd[829]: Startup finished in 41ms. Oct 29 20:31:11.946490 systemd[1]: Started User Manager for UID 500. Oct 29 20:31:11.952790 systemd[1]: Started Session 1 of User core. Oct 29 20:31:12.011375 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56870). Oct 29 20:31:12.055310 sshd[838]: Accepted publickey for core from 10.0.0.1 port 56870 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:31:12.056623 sshd[838]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:31:12.059787 systemd-logind[797]: New session 2 of user core. Oct 29 20:31:12.076531 systemd[1]: Started Session 2 of User core. Oct 29 20:31:12.130614 sshd[838]: pam_unix(sshd:session): session closed for user core Oct 29 20:31:12.138096 systemd[1]: sshd@1-10.0.0.5:22-10.0.0.1:56870.service: Deactivated successfully. Oct 29 20:31:12.138622 systemd[1]: session-2.scope: Deactivated successfully. Oct 29 20:31:12.139204 systemd-logind[797]: Session 2 logged out. Waiting for processes to exit. Oct 29 20:31:12.140153 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56882). Oct 29 20:31:12.140833 systemd-logind[797]: Removed session 2. Oct 29 20:31:12.182746 sshd[844]: Accepted publickey for core from 10.0.0.1 port 56882 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:31:12.183941 sshd[844]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:31:12.186698 systemd-logind[797]: New session 3 of user core. Oct 29 20:31:12.202564 systemd[1]: Started Session 3 of User core. Oct 29 20:31:12.251707 sshd[844]: pam_unix(sshd:session): session closed for user core Oct 29 20:31:12.260409 systemd[1]: sshd@2-10.0.0.5:22-10.0.0.1:56882.service: Deactivated successfully. Oct 29 20:31:12.260938 systemd[1]: session-3.scope: Deactivated successfully. Oct 29 20:31:12.261508 systemd-logind[797]: Session 3 logged out. Waiting for processes to exit. Oct 29 20:31:12.262454 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56894). Oct 29 20:31:12.263150 systemd-logind[797]: Removed session 3. Oct 29 20:31:12.305217 sshd[851]: Accepted publickey for core from 10.0.0.1 port 56894 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:31:12.306788 sshd[851]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:31:12.309961 systemd-logind[797]: New session 4 of user core. Oct 29 20:31:12.323939 systemd[1]: Started Session 4 of User core. Oct 29 20:31:12.377870 sshd[851]: pam_unix(sshd:session): session closed for user core Oct 29 20:31:12.392232 systemd[1]: sshd@3-10.0.0.5:22-10.0.0.1:56894.service: Deactivated successfully. Oct 29 20:31:12.392753 systemd[1]: session-4.scope: Deactivated successfully. Oct 29 20:31:12.393322 systemd-logind[797]: Session 4 logged out. Waiting for processes to exit. Oct 29 20:31:12.394222 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56908). Oct 29 20:31:12.394889 systemd-logind[797]: Removed session 4. Oct 29 20:31:12.439312 sshd[857]: Accepted publickey for core from 10.0.0.1 port 56908 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:31:12.440769 sshd[857]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:31:12.443268 systemd-logind[797]: New session 5 of user core. Oct 29 20:31:12.454634 systemd[1]: Started Session 5 of User core. Oct 29 20:31:12.511753 sudo[860]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 29 20:31:12.511957 sudo[860]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:31:12.533570 sudo[860]: pam_unix(sudo:session): session closed for user root Oct 29 20:31:12.535752 sshd[857]: pam_unix(sshd:session): session closed for user core Oct 29 20:31:12.546065 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56914). Oct 29 20:31:12.548593 dbus-daemon[786]: [system] Reloaded configuration Oct 29 20:31:12.551011 systemd[1]: sshd@4-10.0.0.5:22-10.0.0.1:56908.service: Deactivated successfully. Oct 29 20:31:12.551558 systemd[1]: session-5.scope: Deactivated successfully. Oct 29 20:31:12.552176 systemd-logind[797]: Session 5 logged out. Waiting for processes to exit. Oct 29 20:31:12.552931 systemd-logind[797]: Removed session 5. Oct 29 20:31:12.591070 sshd[863]: Accepted publickey for core from 10.0.0.1 port 56914 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:31:12.592513 sshd[863]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:31:12.594998 systemd-logind[797]: New session 6 of user core. Oct 29 20:31:12.605837 systemd[1]: Started Session 6 of User core. Oct 29 20:31:12.657908 sudo[868]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 29 20:31:12.658119 sudo[868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:31:12.660409 sudo[868]: pam_unix(sudo:session): session closed for user root Oct 29 20:31:12.663826 sudo[867]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 29 20:31:12.664026 sudo[867]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:31:12.684523 systemd[1]: Stopping Load Security Auditing Rules... Oct 29 20:31:12.684000 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 29 20:31:12.685723 auditctl[871]: No rules Oct 29 20:31:12.685989 systemd[1]: audit-rules.service: Deactivated successfully. Oct 29 20:31:12.686223 systemd[1]: Stopped Load Security Auditing Rules. Oct 29 20:31:12.686334 kernel: kauditd_printk_skb: 37 callbacks suppressed Oct 29 20:31:12.686357 kernel: audit: type=1305 audit(1761769872.684:48): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 29 20:31:12.687471 systemd[1]: Starting Load Security Auditing Rules... Oct 29 20:31:12.701630 augenrules[888]: No rules Oct 29 20:31:12.702354 systemd[1]: Finished Load Security Auditing Rules. Oct 29 20:31:12.703096 sudo[867]: pam_unix(sudo:session): session closed for user root Oct 29 20:31:12.704325 sshd[863]: pam_unix(sshd:session): session closed for user core Oct 29 20:31:12.716122 systemd[1]: sshd@5-10.0.0.5:22-10.0.0.1:56914.service: Deactivated successfully. Oct 29 20:31:12.716610 systemd[1]: session-6.scope: Deactivated successfully. Oct 29 20:31:12.717191 systemd-logind[797]: Session 6 logged out. Waiting for processes to exit. Oct 29 20:31:12.718075 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56918). Oct 29 20:31:12.718685 systemd-logind[797]: Removed session 6. Oct 29 20:31:12.764766 sshd[894]: Accepted publickey for core from 10.0.0.1 port 56918 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:31:12.766286 sshd[894]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:31:12.768661 kernel: audit: type=1006 audit(1761769872.765:49): pid=894 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Oct 29 20:31:12.770548 systemd-logind[797]: New session 7 of user core. Oct 29 20:31:12.778802 systemd[1]: Started Session 7 of User core. Oct 29 20:31:12.828193 sshd[894]: pam_unix(sshd:session): session closed for user core Oct 29 20:31:12.837447 systemd[1]: sshd@6-10.0.0.5:22-10.0.0.1:56918.service: Deactivated successfully. Oct 29 20:31:12.837993 systemd[1]: session-7.scope: Deactivated successfully. Oct 29 20:31:12.838508 systemd-logind[797]: Session 7 logged out. Waiting for processes to exit. Oct 29 20:31:12.839464 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:56932). Oct 29 20:31:12.840060 systemd-logind[797]: Removed session 7. Oct 29 20:31:12.884172 sshd[900]: Accepted publickey for core from 10.0.0.1 port 56932 ssh2: RSA SHA256:3JDYtbUu6Jz/KSaxw123NaXNecJ2RtDjzd/HWx5bk7s Oct 29 20:31:12.885490 sshd[900]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:31:12.887657 kernel: audit: type=1006 audit(1761769872.884:50): pid=900 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Oct 29 20:31:12.889317 systemd-logind[797]: New session 8 of user core. Oct 29 20:31:12.900220 systemd[1]: Started Session 8 of User core. Oct 29 20:31:12.950162 sshd[900]: pam_unix(sshd:session): session closed for user core Oct 29 20:31:12.953157 systemd[1]: sshd@7-10.0.0.5:22-10.0.0.1:56932.service: Deactivated successfully. Oct 29 20:31:12.953730 systemd[1]: session-8.scope: Deactivated successfully. Oct 29 20:31:12.954228 systemd-logind[797]: Session 8 logged out. Waiting for processes to exit. Oct 29 20:31:12.954958 systemd-logind[797]: Removed session 8.