Oct 29 20:03:54.677727 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 29 20:03:54.677744 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:03:54.677752 kernel: efi: EFI v2.70 by EDK II Oct 29 20:03:54.677758 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 29 20:03:54.677762 kernel: efi: seeding entropy pool Oct 29 20:03:54.677767 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 29 20:03:54.677773 kernel: ACPI: Early table checksum verification disabled Oct 29 20:03:54.677778 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 29 20:03:54.677783 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 29 20:03:54.677788 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:03:54.677795 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:03:54.677800 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:03:54.677805 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:03:54.677810 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:03:54.677816 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:03:54.677821 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:03:54.677827 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:03:54.677833 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:03:54.677839 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 29 20:03:54.677844 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 29 20:03:54.677849 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:03:54.677854 kernel: NUMA: NODE_DATA [mem 0xdc959900-0xdc95efff] Oct 29 20:03:54.677859 kernel: Zone ranges: Oct 29 20:03:54.677865 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:03:54.677870 kernel: DMA32 empty Oct 29 20:03:54.677875 kernel: Normal empty Oct 29 20:03:54.677880 kernel: Movable zone start for each node Oct 29 20:03:54.677886 kernel: Early memory node ranges Oct 29 20:03:54.677891 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 29 20:03:54.677896 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 29 20:03:54.677901 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 29 20:03:54.677907 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 29 20:03:54.677912 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 29 20:03:54.677917 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 29 20:03:54.677922 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 29 20:03:54.677927 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 29 20:03:54.677932 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 29 20:03:54.677937 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 29 20:03:54.677942 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 29 20:03:54.677948 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:03:54.677956 kernel: On node 0 totalpages: 643072 Oct 29 20:03:54.677962 kernel: DMA zone: 10048 pages used for memmap Oct 29 20:03:54.677967 kernel: DMA zone: 0 pages reserved Oct 29 20:03:54.677972 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 29 20:03:54.677978 kernel: psci: probing for conduit method from ACPI. Oct 29 20:03:54.677983 kernel: psci: PSCIv1.1 detected in firmware. Oct 29 20:03:54.677988 kernel: psci: Using standard PSCI v0.2 function IDs Oct 29 20:03:54.677994 kernel: psci: Trusted OS migration not required Oct 29 20:03:54.678001 kernel: psci: SMC Calling Convention v1.1 Oct 29 20:03:54.678006 kernel: ACPI: SRAT not present Oct 29 20:03:54.678012 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 29 20:03:54.678017 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 29 20:03:54.678022 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 29 20:03:54.678028 kernel: Detected PIPT I-cache on CPU0 Oct 29 20:03:54.678033 kernel: CPU features: detected: GIC system register CPU interface Oct 29 20:03:54.678039 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 29 20:03:54.678044 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 29 20:03:54.678050 kernel: CPU features: detected: Hardware dirty bit management Oct 29 20:03:54.678055 kernel: CPU features: detected: Spectre-v4 Oct 29 20:03:54.678061 kernel: CPU features: detected: ARM erratum 1418040 Oct 29 20:03:54.678067 kernel: CPU features: detected: Spectre-BHB Oct 29 20:03:54.678072 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 29 20:03:54.678078 kernel: Policy zone: DMA Oct 29 20:03:54.678084 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:03:54.678090 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 29 20:03:54.678096 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 29 20:03:54.678101 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 29 20:03:54.678107 kernel: Memory: 2452096K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120192K reserved, 0K cma-reserved) Oct 29 20:03:54.678113 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 29 20:03:54.678118 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 29 20:03:54.678125 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 29 20:03:54.678131 kernel: rcu: RCU event tracing is enabled. Oct 29 20:03:54.678136 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 29 20:03:54.678142 kernel: Trampoline variant of Tasks RCU enabled. Oct 29 20:03:54.678147 kernel: Tracing variant of Tasks RCU enabled. Oct 29 20:03:54.678153 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 29 20:03:54.678158 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 29 20:03:54.678164 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 29 20:03:54.678169 kernel: GICv3: 256 SPIs implemented Oct 29 20:03:54.678175 kernel: GICv3: 0 Extended SPIs implemented Oct 29 20:03:54.678180 kernel: GICv3: Distributor has no Range Selector support Oct 29 20:03:54.678185 kernel: GICv3: 16 PPIs implemented Oct 29 20:03:54.678192 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 29 20:03:54.678198 kernel: ACPI: SRAT not present Oct 29 20:03:54.678203 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 29 20:03:54.678208 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 29 20:03:54.678214 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 29 20:03:54.678220 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 29 20:03:54.678225 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 29 20:03:54.678231 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:03:54.678236 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 29 20:03:54.678242 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 29 20:03:54.678247 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 29 20:03:54.678253 kernel: arm-pv: using stolen time PV Oct 29 20:03:54.678260 kernel: Console: colour dummy device 80x25 Oct 29 20:03:54.678266 kernel: ACPI: Core revision 20200925 Oct 29 20:03:54.678272 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 29 20:03:54.678277 kernel: pid_max: default: 32768 minimum: 301 Oct 29 20:03:54.678283 kernel: LSM: Security Framework initializing Oct 29 20:03:54.678289 kernel: SELinux: Initializing. Oct 29 20:03:54.678295 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 29 20:03:54.678301 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 29 20:03:54.678306 kernel: rcu: Hierarchical SRCU implementation. Oct 29 20:03:54.678313 kernel: Platform MSI: ITS@0x8080000 domain created Oct 29 20:03:54.678319 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 29 20:03:54.678325 kernel: Remapping and enabling EFI services. Oct 29 20:03:54.678331 kernel: smp: Bringing up secondary CPUs ... Oct 29 20:03:54.678336 kernel: Detected PIPT I-cache on CPU1 Oct 29 20:03:54.678343 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 29 20:03:54.678348 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 29 20:03:54.678354 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:03:54.678360 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 29 20:03:54.678366 kernel: Detected PIPT I-cache on CPU2 Oct 29 20:03:54.678373 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 29 20:03:54.678379 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 29 20:03:54.678385 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:03:54.678390 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 29 20:03:54.678397 kernel: Detected PIPT I-cache on CPU3 Oct 29 20:03:54.678406 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 29 20:03:54.678413 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 29 20:03:54.678420 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:03:54.678425 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 29 20:03:54.678432 kernel: smp: Brought up 1 node, 4 CPUs Oct 29 20:03:54.678437 kernel: SMP: Total of 4 processors activated. Oct 29 20:03:54.678444 kernel: CPU features: detected: Privileged Access Never Oct 29 20:03:54.678450 kernel: CPU features: detected: LSE atomic instructions Oct 29 20:03:54.678458 kernel: CPU features: detected: User Access Override Oct 29 20:03:54.678464 kernel: CPU features: detected: 32-bit EL0 Support Oct 29 20:03:54.678470 kernel: CPU features: detected: Common not Private translations Oct 29 20:03:54.678476 kernel: CPU features: detected: RAS Extension Support Oct 29 20:03:54.678483 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 29 20:03:54.678489 kernel: CPU features: detected: CRC32 instructions Oct 29 20:03:54.678495 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 29 20:03:54.678501 kernel: CPU: All CPU(s) started at EL1 Oct 29 20:03:54.678507 kernel: alternatives: patching kernel code Oct 29 20:03:54.678514 kernel: devtmpfs: initialized Oct 29 20:03:54.678520 kernel: KASLR enabled Oct 29 20:03:54.678526 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 29 20:03:54.678533 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 29 20:03:54.678538 kernel: pinctrl core: initialized pinctrl subsystem Oct 29 20:03:54.678545 kernel: SMBIOS 3.0.0 present. Oct 29 20:03:54.678551 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 29 20:03:54.678556 kernel: NET: Registered protocol family 16 Oct 29 20:03:54.678563 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 29 20:03:54.678569 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 29 20:03:54.678576 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 29 20:03:54.678604 kernel: audit: initializing netlink subsys (disabled) Oct 29 20:03:54.678623 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Oct 29 20:03:54.678630 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 29 20:03:54.678635 kernel: cpuidle: using governor menu Oct 29 20:03:54.678642 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 29 20:03:54.678653 kernel: ASID allocator initialised with 32768 entries Oct 29 20:03:54.678659 kernel: ACPI: bus type PCI registered Oct 29 20:03:54.678666 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 29 20:03:54.678674 kernel: Serial: AMBA PL011 UART driver Oct 29 20:03:54.678686 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 29 20:03:54.678693 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 29 20:03:54.678699 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 29 20:03:54.678705 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 29 20:03:54.678711 kernel: cryptd: max_cpu_qlen set to 1000 Oct 29 20:03:54.678717 kernel: ACPI: Added _OSI(Module Device) Oct 29 20:03:54.678723 kernel: ACPI: Added _OSI(Processor Device) Oct 29 20:03:54.678729 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 29 20:03:54.678737 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 29 20:03:54.678743 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 29 20:03:54.678749 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 29 20:03:54.678755 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 29 20:03:54.678761 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 29 20:03:54.678767 kernel: ACPI: Interpreter enabled Oct 29 20:03:54.678773 kernel: ACPI: Using GIC for interrupt routing Oct 29 20:03:54.678779 kernel: ACPI: MCFG table detected, 1 entries Oct 29 20:03:54.678785 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 29 20:03:54.678791 kernel: printk: console [ttyAMA0] enabled Oct 29 20:03:54.678798 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 29 20:03:54.678918 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 29 20:03:54.678980 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 29 20:03:54.679034 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 29 20:03:54.679087 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 29 20:03:54.679140 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 29 20:03:54.679148 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 29 20:03:54.679157 kernel: PCI host bridge to bus 0000:00 Oct 29 20:03:54.679218 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 29 20:03:54.679268 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 29 20:03:54.679318 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 29 20:03:54.679366 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 29 20:03:54.679432 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 29 20:03:54.679495 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 29 20:03:54.679555 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 29 20:03:54.679610 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 29 20:03:54.679686 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 29 20:03:54.679747 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 29 20:03:54.679801 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 29 20:03:54.679855 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 29 20:03:54.679905 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 29 20:03:54.679957 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 29 20:03:54.680006 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 29 20:03:54.680014 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 29 20:03:54.680020 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 29 20:03:54.680026 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 29 20:03:54.680032 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 29 20:03:54.680038 kernel: vgaarb: loaded Oct 29 20:03:54.680044 kernel: Registered efivars operations Oct 29 20:03:54.680050 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 29 20:03:54.680058 kernel: VFS: Disk quotas dquot_6.6.0 Oct 29 20:03:54.680064 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 29 20:03:54.680070 kernel: pnp: PnP ACPI init Oct 29 20:03:54.680135 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 29 20:03:54.680186 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 29 20:03:54.680195 kernel: pnp: PnP ACPI: found 1 devices Oct 29 20:03:54.680201 kernel: NET: Registered protocol family 2 Oct 29 20:03:54.680207 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 29 20:03:54.680215 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 29 20:03:54.680221 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 29 20:03:54.680228 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 29 20:03:54.680234 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 29 20:03:54.680240 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 29 20:03:54.680246 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 29 20:03:54.680252 kernel: NET: Registered protocol family 1 Oct 29 20:03:54.680258 kernel: PCI: CLS 0 bytes, default 64 Oct 29 20:03:54.680264 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 29 20:03:54.680272 kernel: kvm [1]: HYP mode not available Oct 29 20:03:54.680278 kernel: Initialise system trusted keyrings Oct 29 20:03:54.680284 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 29 20:03:54.680291 kernel: Key type asymmetric registered Oct 29 20:03:54.680297 kernel: Asymmetric key parser 'x509' registered Oct 29 20:03:54.680303 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 29 20:03:54.680309 kernel: io scheduler mq-deadline registered Oct 29 20:03:54.680315 kernel: io scheduler kyber registered Oct 29 20:03:54.680321 kernel: io scheduler bfq registered Oct 29 20:03:54.680328 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 29 20:03:54.680334 kernel: ACPI: Power Button [PWRB] Oct 29 20:03:54.680340 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 29 20:03:54.680395 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 29 20:03:54.680404 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 29 20:03:54.680410 kernel: msm_serial: driver initialized Oct 29 20:03:54.680415 kernel: random: fast init done Oct 29 20:03:54.680421 kernel: random: crng init done Oct 29 20:03:54.680427 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 29 20:03:54.680434 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 29 20:03:54.680441 kernel: thunder_xcv, ver 1.0 Oct 29 20:03:54.680447 kernel: thunder_bgx, ver 1.0 Oct 29 20:03:54.680453 kernel: nicpf, ver 1.0 Oct 29 20:03:54.680459 kernel: nicvf, ver 1.0 Oct 29 20:03:54.680526 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 29 20:03:54.680578 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-29T20:03:54 UTC (1761768234) Oct 29 20:03:54.680586 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 29 20:03:54.680592 kernel: NET: Registered protocol family 10 Oct 29 20:03:54.680600 kernel: Segment Routing with IPv6 Oct 29 20:03:54.680606 kernel: NET: Registered protocol family 17 Oct 29 20:03:54.680612 kernel: Key type dns_resolver registered Oct 29 20:03:54.680618 kernel: registered taskstats version 1 Oct 29 20:03:54.680624 kernel: Loading compiled-in X.509 certificates Oct 29 20:03:54.680631 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 29 20:03:54.680637 kernel: Key type ._fscrypt registered Oct 29 20:03:54.680667 kernel: Key type .fscrypt registered Oct 29 20:03:54.680679 kernel: Key type fscrypt-provisioning registered Oct 29 20:03:54.680689 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 29 20:03:54.680695 kernel: ima: Allocated hash algorithm: sha1 Oct 29 20:03:54.680701 kernel: ima: No architecture policies found Oct 29 20:03:54.680707 kernel: Freeing unused kernel memory: 34240K Oct 29 20:03:54.680713 kernel: Run /init as init process Oct 29 20:03:54.680719 kernel: with arguments: Oct 29 20:03:54.680725 kernel: /init Oct 29 20:03:54.680731 kernel: with environment: Oct 29 20:03:54.680737 kernel: HOME=/ Oct 29 20:03:54.680743 kernel: TERM=linux Oct 29 20:03:54.680751 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 29 20:03:54.680759 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:03:54.680767 systemd[1]: Detected virtualization kvm. Oct 29 20:03:54.680774 systemd[1]: Detected architecture arm64. Oct 29 20:03:54.680780 systemd[1]: Running in initial RAM disk. Oct 29 20:03:54.680786 systemd[1]: No hostname configured, using default hostname. Oct 29 20:03:54.680793 systemd[1]: Hostname set to . Oct 29 20:03:54.680801 systemd[1]: Initializing machine ID from VM UUID. Oct 29 20:03:54.680807 systemd[1]: Queued start job for default target Initrd Default Target. Oct 29 20:03:54.680814 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 29 20:03:54.680820 systemd[1]: Reached target Local Encrypted Volumes. Oct 29 20:03:54.680826 systemd[1]: Reached target Path Units. Oct 29 20:03:54.680833 systemd[1]: Reached target Slice Units. Oct 29 20:03:54.680839 systemd[1]: Reached target Swaps. Oct 29 20:03:54.680846 systemd[1]: Reached target Timer Units. Oct 29 20:03:54.680854 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 29 20:03:54.680860 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 29 20:03:54.680867 systemd[1]: Listening on Journal Audit Socket. Oct 29 20:03:54.680873 systemd[1]: Listening on Journal Socket (/dev/log). Oct 29 20:03:54.680880 systemd[1]: Listening on Journal Socket. Oct 29 20:03:54.680886 systemd[1]: Listening on Network Service Netlink Socket. Oct 29 20:03:54.680893 systemd[1]: Listening on udev Control Socket. Oct 29 20:03:54.680899 systemd[1]: Listening on udev Kernel Socket. Oct 29 20:03:54.680905 systemd[1]: Reached target Socket Units. Oct 29 20:03:54.680914 systemd[1]: Starting Create List of Static Device Nodes... Oct 29 20:03:54.680920 systemd[1]: Finished Network Cleanup. Oct 29 20:03:54.680927 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 29 20:03:54.680933 systemd[1]: Starting Journal Service... Oct 29 20:03:54.680940 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 29 20:03:54.680947 systemd[1]: Starting Apply Kernel Variables... Oct 29 20:03:54.680953 systemd[1]: Starting Setup Virtual Console... Oct 29 20:03:54.680959 systemd[1]: Finished Create List of Static Device Nodes. Oct 29 20:03:54.680966 systemd[1]: Finished Apply Kernel Variables. Oct 29 20:03:54.680973 systemd[1]: Finished Setup Virtual Console. Oct 29 20:03:54.680980 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 29 20:03:54.680989 systemd-journald[279]: Journal started Oct 29 20:03:54.681028 systemd-journald[279]: Runtime Journal (/run/log/journal/a7820ab79e50450a9913c8d57cfc46ba) is 6.0M, max 48.5M, 42.4M free. Oct 29 20:03:54.684670 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 29 20:03:54.685957 systemd[1]: Started Journal Service. Oct 29 20:03:54.687009 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 29 20:03:54.698372 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 29 20:03:54.700156 systemd[1]: Starting dracut cmdline hook... Oct 29 20:03:54.709374 dracut-cmdline[296]: dracut-dracut-053 Oct 29 20:03:54.711664 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:03:54.770679 kernel: SCSI subsystem initialized Oct 29 20:03:54.774656 kernel: Loading iSCSI transport class v2.0-870. Oct 29 20:03:54.780682 kernel: iscsi: registered transport (tcp) Oct 29 20:03:54.791668 kernel: iscsi: registered transport (qla4xxx) Oct 29 20:03:54.791683 kernel: QLogic iSCSI HBA Driver Oct 29 20:03:54.802091 systemd[1]: Finished dracut cmdline hook. Oct 29 20:03:54.803588 systemd[1]: Starting dracut pre-udev hook... Oct 29 20:03:54.817291 kernel: device-mapper: uevent: version 1.0.3 Oct 29 20:03:54.817321 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 29 20:03:54.852669 kernel: raid6: neonx8 gen() 13778 MB/s Oct 29 20:03:54.869671 kernel: raid6: neonx8 xor() 10749 MB/s Oct 29 20:03:54.886663 kernel: raid6: neonx4 gen() 13620 MB/s Oct 29 20:03:54.903663 kernel: raid6: neonx4 xor() 11581 MB/s Oct 29 20:03:54.920679 kernel: raid6: neonx2 gen() 12921 MB/s Oct 29 20:03:54.937666 kernel: raid6: neonx2 xor() 9895 MB/s Oct 29 20:03:54.954680 kernel: raid6: neonx1 gen() 10690 MB/s Oct 29 20:03:54.971680 kernel: raid6: neonx1 xor() 8855 MB/s Oct 29 20:03:54.988680 kernel: raid6: int64x8 gen() 6829 MB/s Oct 29 20:03:55.005685 kernel: raid6: int64x8 xor() 3796 MB/s Oct 29 20:03:55.022679 kernel: raid6: int64x4 gen() 6914 MB/s Oct 29 20:03:55.039679 kernel: raid6: int64x4 xor() 3835 MB/s Oct 29 20:03:55.056682 kernel: raid6: int64x2 gen() 6193 MB/s Oct 29 20:03:55.073676 kernel: raid6: int64x2 xor() 3312 MB/s Oct 29 20:03:55.090667 kernel: raid6: int64x1 gen() 5005 MB/s Oct 29 20:03:55.107752 kernel: raid6: int64x1 xor() 2593 MB/s Oct 29 20:03:55.107772 kernel: raid6: using algorithm neonx8 gen() 13778 MB/s Oct 29 20:03:55.107787 kernel: raid6: .... xor() 10749 MB/s, rmw enabled Oct 29 20:03:55.108842 kernel: raid6: using neon recovery algorithm Oct 29 20:03:55.118666 kernel: xor: measuring software checksum speed Oct 29 20:03:55.119666 kernel: 8regs : 17141 MB/sec Oct 29 20:03:55.121123 kernel: 32regs : 20765 MB/sec Oct 29 20:03:55.121135 kernel: arm64_neon : 29153 MB/sec Oct 29 20:03:55.121142 kernel: xor: using function: arm64_neon (29153 MB/sec) Oct 29 20:03:55.166678 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 29 20:03:55.177254 systemd[1]: Finished dracut pre-udev hook. Oct 29 20:03:55.177000 audit: BPF prog-id=6 op=LOAD Oct 29 20:03:55.177000 audit: BPF prog-id=7 op=LOAD Oct 29 20:03:55.179769 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 29 20:03:55.181839 kernel: audit: type=1334 audit(1761768235.177:2): prog-id=6 op=LOAD Oct 29 20:03:55.181857 kernel: audit: type=1334 audit(1761768235.177:3): prog-id=7 op=LOAD Oct 29 20:03:55.181866 kernel: audit: type=1334 audit(1761768235.178:4): prog-id=8 op=LOAD Oct 29 20:03:55.178000 audit: BPF prog-id=8 op=LOAD Oct 29 20:03:55.191827 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 29 20:03:55.193505 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 29 20:03:55.195316 systemd[1]: Starting dracut pre-trigger hook... Oct 29 20:03:55.199000 audit: BPF prog-id=9 op=LOAD Oct 29 20:03:55.200274 systemd[1]: Starting Network Configuration... Oct 29 20:03:55.202112 kernel: audit: type=1334 audit(1761768235.199:5): prog-id=9 op=LOAD Oct 29 20:03:55.208586 dracut-pre-trigger[423]: rd.md=0: removing MD RAID activation Oct 29 20:03:55.217849 systemd-networkd[430]: lo: Link UP Oct 29 20:03:55.217857 systemd-networkd[430]: lo: Gained carrier Oct 29 20:03:55.218142 systemd-networkd[430]: Enumeration completed Oct 29 20:03:55.218219 systemd[1]: Started Network Configuration. Oct 29 20:03:55.219000 audit: BPF prog-id=10 op=LOAD Oct 29 20:03:55.220310 systemd[1]: Starting Network Name Resolution... Oct 29 20:03:55.223371 kernel: audit: type=1334 audit(1761768235.219:6): prog-id=10 op=LOAD Oct 29 20:03:55.237015 systemd[1]: Finished dracut pre-trigger hook. Oct 29 20:03:55.238502 systemd[1]: Starting Coldplug All udev Devices... Oct 29 20:03:55.248601 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 29 20:03:55.249012 systemd-resolved[446]: Positive Trust Anchors: Oct 29 20:03:55.249019 systemd-resolved[446]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 20:03:55.249047 systemd-resolved[446]: 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:03:55.249316 systemd-resolved[446]: Defaulting to hostname 'linux'. Oct 29 20:03:55.250014 systemd[1]: Started Network Name Resolution. Oct 29 20:03:55.251510 systemd[1]: Reached target Network. Oct 29 20:03:55.253305 systemd[1]: Reached target Host and Network Name Lookups. Oct 29 20:03:55.262890 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 29 20:03:55.268956 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 29 20:03:55.270461 systemd[1]: Starting Open-iSCSI... Oct 29 20:03:55.272965 iscsid[484]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 29 20:03:55.272965 iscsid[484]: 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:03:55.272965 iscsid[484]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 29 20:03:55.272965 iscsid[484]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 29 20:03:55.272965 iscsid[484]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 29 20:03:55.272965 iscsid[484]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 29 20:03:55.274615 systemd[1]: Finished Coldplug All udev Devices. Oct 29 20:03:55.279801 systemd[1]: Started Open-iSCSI. Oct 29 20:03:55.281845 systemd[1]: Starting dracut initqueue hook... Oct 29 20:03:55.310831 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 29 20:03:55.311001 kernel: vda: detected capacity change from 0 to 4756340736 Oct 29 20:03:55.318201 systemd-udevd[474]: Using default interface naming scheme 'v249'. Oct 29 20:03:55.321661 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 20:03:55.323968 systemd-networkd[430]: eth0: Link UP Oct 29 20:03:55.344676 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (468) Oct 29 20:03:55.348264 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 29 20:03:55.350444 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 29 20:03:55.351459 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 29 20:03:55.356749 systemd[1]: Found device /dev/disk/by-label/OEM. Oct 29 20:03:55.359271 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Oct 29 20:03:55.360153 systemd[1]: Reached target Initrd Root Device. Oct 29 20:03:55.362202 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 29 20:03:55.368282 systemd[1]: Finished dracut initqueue hook. Oct 29 20:03:55.369087 systemd[1]: Reached target Preparation for Remote File Systems. Oct 29 20:03:55.370502 systemd[1]: Reached target Remote Encrypted Volumes. Oct 29 20:03:55.372160 systemd[1]: Reached target Remote File Systems. Oct 29 20:03:55.374136 systemd[1]: Starting dracut pre-mount hook... Oct 29 20:03:55.381821 systemd[1]: Finished dracut pre-mount hook. Oct 29 20:03:55.388674 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 20:03:56.315700 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 29 20:03:56.315622 systemd-networkd[430]: eth0: Gained carrier Oct 29 20:03:56.322722 systemd-networkd[430]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 29 20:03:56.396456 disk-uuid[508]: The operation has completed successfully. Oct 29 20:03:56.397935 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 20:03:56.420677 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 29 20:03:56.420821 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 29 20:03:56.423265 systemd[1]: Starting Ignition (setup)... Oct 29 20:03:56.431665 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 29 20:03:56.431767 kernel: BTRFS info (device vda6): has skinny extents Oct 29 20:03:56.437557 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 29 20:03:56.442425 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 29 20:03:56.442540 systemd[1]: Finished Ignition (setup). Oct 29 20:03:56.444695 systemd[1]: Starting Ignition (disks)... Oct 29 20:03:56.453573 ignition[541]: Ignition v0.36.1-15-gde4e6cc9 Oct 29 20:03:56.453588 ignition[541]: Stage: disks Oct 29 20:03:56.453598 ignition[541]: reading system config file "/usr/lib/ignition/base.ign" Oct 29 20:03:56.453608 ignition[541]: no config at "/usr/lib/ignition/base.ign" Oct 29 20:03:56.453683 ignition[541]: parsed url from cmdline: "" Oct 29 20:03:56.453686 ignition[541]: no config URL provided Oct 29 20:03:56.453691 ignition[541]: reading system config file "/usr/lib/ignition/user.ign" Oct 29 20:03:56.453699 ignition[541]: no config at "/usr/lib/ignition/user.ign" Oct 29 20:03:56.453718 ignition[541]: op(1): [started] loading QEMU firmware config module Oct 29 20:03:56.453722 ignition[541]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 29 20:03:56.454702 ignition[541]: op(1): [finished] loading QEMU firmware config module Oct 29 20:03:56.468358 ignition[541]: parsing config with SHA512: a4191e249616de42ad4529da77beb56d204155da5c85dc3df3ebae53b2eb89bc690e92f76ae8c2ad016b53a70fb888544ea2cd07563a36d2eb0f3bc9c5cf5ed0 Oct 29 20:03:56.470238 ignition[541]: disks: disks passed Oct 29 20:03:56.470246 ignition[541]: Ignition finished successfully Oct 29 20:03:56.471116 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 29 20:03:56.471250 systemd[1]: Finished Ignition (disks). Oct 29 20:03:56.472394 systemd[1]: Reached target Preparation for Local File Systems. Oct 29 20:03:56.474600 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 29 20:03:56.476762 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 29 20:03:56.485230 systemd-fsck[554]: ROOT: clean, 528/553792 files, 37752/553472 blocks Oct 29 20:03:56.488941 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 29 20:03:56.490608 systemd[1]: Mounting /sysroot... Oct 29 20:03:56.494877 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 29 20:03:56.510272 systemd[1]: Found device /dev/mapper/usr. Oct 29 20:03:56.511631 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 29 20:03:56.512672 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 29 20:03:56.523431 systemd-fsck[568]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 29 20:03:56.523431 systemd-fsck[568]: You must have r/w access to the filesystem or be root Oct 29 20:03:56.523902 systemd-fsck[566]: fsck failed with exit status 8. Oct 29 20:03:56.523906 systemd-fsck[566]: Ignoring error. Oct 29 20:03:56.524541 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 29 20:03:56.526747 systemd[1]: Mounting /sysusr/usr... Oct 29 20:03:56.548073 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 29 20:03:56.548126 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 29 20:03:56.549015 systemd[1]: Mounted /sysroot. Oct 29 20:03:56.549697 systemd[1]: Reached target Initrd Root File System. Oct 29 20:03:56.559655 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 29 20:03:56.560009 systemd[1]: Mounted /sysusr/usr. Oct 29 20:03:56.560707 systemd[1]: Reached target Local File Systems. Oct 29 20:03:56.561859 systemd[1]: Reached target System Initialization. Oct 29 20:03:56.563190 systemd[1]: Reached target Basic System. Oct 29 20:03:56.565861 systemd[1]: Mounting /sysroot/usr... Oct 29 20:03:56.567989 systemd[1]: Mounted /sysroot/usr. Oct 29 20:03:56.569266 systemd[1]: Starting Root filesystem setup... Oct 29 20:03:56.593380 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 29 20:03:56.593509 systemd[1]: Finished Root filesystem setup. Oct 29 20:03:56.595833 systemd[1]: Starting Ignition (files)... Oct 29 20:03:56.597050 systemd[1]: Starting /sysroot/boot... Oct 29 20:03:56.598859 ignition[585]: Ignition v0.36.1-15-gde4e6cc9 Oct 29 20:03:56.598876 ignition[585]: Stage: files Oct 29 20:03:56.598886 ignition[585]: reading system config file "/usr/lib/ignition/base.ign" Oct 29 20:03:56.598896 ignition[585]: no config at "/usr/lib/ignition/base.ign" Oct 29 20:03:56.599366 ignition[585]: files: compiled without relabeling support, skipping Oct 29 20:03:56.616047 systemd[1]: Finished /sysroot/boot. Oct 29 20:03:56.620935 ignition[585]: files: createUsers: op(1): [started] creating or modifying user "core" Oct 29 20:03:56.620946 ignition[585]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Oct 29 20:03:56.622541 ignition[585]: files: createUsers: op(1): [finished] creating or modifying user "core" Oct 29 20:03:56.622552 ignition[585]: files: createUsers: op(2): [started] adding ssh keys to user "core" Oct 29 20:03:56.625337 ignition[585]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Oct 29 20:03:56.625363 ignition[585]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Oct 29 20:03:56.626635 ignition[585]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Oct 29 20:03:56.626642 ignition[585]: files: op(4): [started] processing unit "coreos-metadata.service" Oct 29 20:03:56.626748 ignition[585]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 29 20:03:56.630327 systemd[1]: ignition-files.service: Deactivated successfully. Oct 29 20:03:56.629689 ignition[585]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 29 20:03:56.630445 systemd[1]: Finished Ignition (files). Oct 29 20:03:56.629696 ignition[585]: files: op(4): [finished] processing unit "coreos-metadata.service" Oct 29 20:03:56.631423 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Oct 29 20:03:56.629701 ignition[585]: files: files passed Oct 29 20:03:56.632128 systemd[1]: Starting Ignition (record completion)... Oct 29 20:03:56.641000 audit: BPF prog-id=6 op=UNLOAD Oct 29 20:03:56.641000 audit: BPF prog-id=9 op=UNLOAD Oct 29 20:03:56.629705 ignition[585]: Ignition finished successfully Oct 29 20:03:56.644309 kernel: audit: type=1334 audit(1761768236.641:7): prog-id=6 op=UNLOAD Oct 29 20:03:56.644330 kernel: audit: type=1334 audit(1761768236.641:8): prog-id=9 op=UNLOAD Oct 29 20:03:56.644339 kernel: audit: type=1334 audit(1761768236.643:9): prog-id=3 op=UNLOAD Oct 29 20:03:56.643000 audit: BPF prog-id=3 op=UNLOAD Oct 29 20:03:56.634106 systemd[1]: Starting Reload Configuration from the Real Root... Oct 29 20:03:56.646677 kernel: audit: type=1334 audit(1761768236.643:10): prog-id=10 op=UNLOAD Oct 29 20:03:56.643000 audit: BPF prog-id=10 op=UNLOAD Oct 29 20:03:56.638401 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 29 20:03:56.638515 systemd[1]: Finished Ignition (record completion). Oct 29 20:03:56.639566 systemd[1]: Reloading. Oct 29 20:03:56.728000 audit: BPF prog-id=11 op=LOAD Oct 29 20:03:56.728000 audit: BPF prog-id=12 op=LOAD Oct 29 20:03:56.728000 audit: BPF prog-id=13 op=LOAD Oct 29 20:03:56.728000 audit: BPF prog-id=7 op=UNLOAD Oct 29 20:03:56.728000 audit: BPF prog-id=8 op=UNLOAD Oct 29 20:03:56.728000 audit: BPF prog-id=14 op=LOAD Oct 29 20:03:56.729000 audit: BPF prog-id=15 op=LOAD Oct 29 20:03:56.729000 audit: BPF prog-id=16 op=LOAD Oct 29 20:03:56.729000 audit: BPF prog-id=17 op=LOAD Oct 29 20:03:56.729000 audit: BPF prog-id=4 op=UNLOAD Oct 29 20:03:56.729000 audit: BPF prog-id=5 op=UNLOAD Oct 29 20:03:56.729000 audit: BPF prog-id=18 op=LOAD Oct 29 20:03:56.744799 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 29 20:03:56.744929 systemd[1]: Finished Reload Configuration from the Real Root. Oct 29 20:03:56.746635 systemd[1]: Reached target Initrd File Systems. Oct 29 20:03:56.748098 systemd[1]: Reached target Initrd Default Target. Oct 29 20:03:56.749431 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 29 20:03:56.750190 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 29 20:03:56.760212 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 29 20:03:56.761867 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 29 20:03:56.768074 systemd[1]: Stopped target Host and Network Name Lookups. Oct 29 20:03:56.769062 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 29 20:03:56.770518 systemd[1]: Stopped target Timer Units. Oct 29 20:03:56.771855 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 29 20:03:56.771970 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 29 20:03:56.773264 systemd[1]: Stopped target Initrd Default Target. Oct 29 20:03:56.774712 systemd[1]: Stopped target Basic System. Oct 29 20:03:56.776090 systemd[1]: Stopped target Initrd Root Device. Oct 29 20:03:56.777461 systemd[1]: Stopped target Path Units. Oct 29 20:03:56.778622 systemd[1]: Stopped target Remote File Systems. Oct 29 20:03:56.780119 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 29 20:03:56.781543 systemd[1]: Stopped target Slice Units. Oct 29 20:03:56.782842 systemd[1]: Stopped target Socket Units. Oct 29 20:03:56.784289 systemd[1]: Stopped target System Initialization. Oct 29 20:03:56.785536 systemd[1]: Stopped target Local File Systems. Oct 29 20:03:56.786813 systemd[1]: Stopped target Preparation for Local File Systems. Oct 29 20:03:56.788385 systemd[1]: Stopped target Swaps. Oct 29 20:03:56.789548 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 29 20:03:56.789685 systemd[1]: Stopped dracut pre-mount hook. Oct 29 20:03:56.791102 systemd[1]: Stopped target Local Encrypted Volumes. Oct 29 20:03:56.792298 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 29 20:03:56.795690 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 29 20:03:56.796772 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 29 20:03:56.796875 systemd[1]: Stopped dracut initqueue hook. Oct 29 20:03:56.800253 iscsid[484]: iscsid shutting down. Oct 29 20:03:56.798518 systemd[1]: Stopping Open-iSCSI... Oct 29 20:03:56.800378 systemd[1]: Stopping /sysroot/boot... Oct 29 20:03:56.801021 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 29 20:03:56.801152 systemd[1]: Stopped Coldplug All udev Devices. Oct 29 20:03:56.802340 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 29 20:03:56.802425 systemd[1]: Stopped dracut pre-trigger hook. Oct 29 20:03:56.804459 systemd[1]: iscsid.service: Deactivated successfully. Oct 29 20:03:56.804575 systemd[1]: Stopped Open-iSCSI. Oct 29 20:03:56.806147 systemd[1]: iscsid.socket: Deactivated successfully. Oct 29 20:03:56.806208 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 29 20:03:56.807956 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 29 20:03:56.810697 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 29 20:03:56.810812 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 29 20:03:56.812015 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 29 20:03:56.812127 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 29 20:03:56.813523 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 29 20:03:56.813629 systemd[1]: Stopped /sysroot/boot. Oct 29 20:03:56.815125 systemd[1]: Stopped target Network. Oct 29 20:03:56.815891 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 29 20:03:56.815958 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 29 20:03:56.817470 systemd[1]: Stopping Network Name Resolution... Oct 29 20:03:56.824040 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 29 20:03:56.824161 systemd[1]: Stopped Network Name Resolution. Oct 29 20:03:56.825516 systemd[1]: Stopping Network Configuration... Oct 29 20:03:56.829803 systemd-networkd[430]: eth0: DHCP lease lost Oct 29 20:03:56.835707 systemd-networkd[430]: eth0: DHCPv6 lease lost Oct 29 20:03:56.835000 audit: BPF prog-id=18 op=UNLOAD Oct 29 20:03:56.836701 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 29 20:03:56.836827 systemd[1]: Stopped Network Configuration. Oct 29 20:03:56.838461 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 29 20:03:56.838492 systemd[1]: Closed Network Service Netlink Socket. Oct 29 20:03:56.840254 systemd[1]: Stopping Network Cleanup... Oct 29 20:03:56.844000 audit: BPF prog-id=14 op=UNLOAD Oct 29 20:03:56.840967 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 29 20:03:56.841030 systemd[1]: Stopped Apply Kernel Variables. Oct 29 20:03:56.842437 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 29 20:03:56.848169 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 29 20:03:56.848286 systemd[1]: Stopped Network Cleanup. Oct 29 20:03:56.851364 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 29 20:03:56.851488 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 29 20:03:56.853403 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 29 20:03:56.853441 systemd[1]: Closed udev Control Socket. Oct 29 20:03:56.854747 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 29 20:03:56.854780 systemd[1]: Closed udev Kernel Socket. Oct 29 20:03:56.856154 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 29 20:03:56.856196 systemd[1]: Stopped dracut pre-udev hook. Oct 29 20:03:56.857441 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 29 20:03:56.857485 systemd[1]: Stopped dracut cmdline hook. Oct 29 20:03:56.858961 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 29 20:03:56.859006 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 29 20:03:56.861105 systemd[1]: Starting Cleanup udev Database... Oct 29 20:03:56.861995 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 29 20:03:56.863118 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 29 20:03:56.863176 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 29 20:03:56.864673 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 29 20:03:56.864720 systemd[1]: Stopped Create List of Static Device Nodes. Oct 29 20:03:56.866058 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 20:03:56.875000 audit: BPF prog-id=11 op=UNLOAD Oct 29 20:03:56.866103 systemd[1]: Stopped Setup Virtual Console. Oct 29 20:03:56.867711 systemd[1]: rngd.service: Deactivated successfully. Oct 29 20:03:56.867823 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 29 20:03:56.869270 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 29 20:03:56.869377 systemd[1]: Finished Cleanup udev Database. Oct 29 20:03:56.879000 audit: BPF prog-id=15 op=UNLOAD Oct 29 20:03:56.870437 systemd[1]: Reached target Switch Root. Oct 29 20:03:56.872358 systemd[1]: Starting Switch Root... Oct 29 20:03:56.877409 systemd[1]: Switching root. Oct 29 20:03:56.887942 systemd-journald[279]: Journal stopped Oct 29 20:03:59.016186 systemd-journald[279]: Received SIGTERM from PID 1 (systemd). Oct 29 20:03:59.016239 kernel: SELinux: policy capability network_peer_controls=1 Oct 29 20:03:59.016250 kernel: SELinux: policy capability open_perms=1 Oct 29 20:03:59.016260 kernel: SELinux: policy capability extended_socket_class=1 Oct 29 20:03:59.016270 kernel: SELinux: policy capability always_check_network=0 Oct 29 20:03:59.016279 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 29 20:03:59.016288 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 29 20:03:59.016297 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 29 20:03:59.016307 systemd[1]: Successfully loaded SELinux policy in 34.022ms. Oct 29 20:03:59.016326 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.557ms. Oct 29 20:03:59.016339 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:03:59.016351 systemd[1]: Detected virtualization kvm. Oct 29 20:03:59.016361 systemd[1]: Detected architecture arm64. Oct 29 20:03:59.016371 systemd[1]: Detected first boot. Oct 29 20:03:59.016381 systemd[1]: Initializing machine ID from VM UUID. Oct 29 20:03:59.016391 systemd[1]: Populated /etc with preset unit settings. Oct 29 20:03:59.016403 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:03:59.016423 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:03:59.016434 kernel: kauditd_printk_skb: 24 callbacks suppressed Oct 29 20:03:59.016444 kernel: audit: type=1334 audit(1761768238.903:35): prog-id=21 op=LOAD Oct 29 20:03:59.016453 kernel: audit: type=1334 audit(1761768238.903:36): prog-id=22 op=LOAD Oct 29 20:03:59.016463 kernel: audit: type=1334 audit(1761768238.904:37): prog-id=23 op=LOAD Oct 29 20:03:59.016472 kernel: audit: type=1334 audit(1761768238.904:38): prog-id=16 op=UNLOAD Oct 29 20:03:59.016481 kernel: audit: type=1334 audit(1761768238.904:39): prog-id=17 op=UNLOAD Oct 29 20:03:59.016491 kernel: audit: type=1334 audit(1761768238.905:40): prog-id=24 op=LOAD Oct 29 20:03:59.016501 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 29 20:03:59.016511 kernel: audit: type=1334 audit(1761768238.905:41): prog-id=21 op=UNLOAD Oct 29 20:03:59.016523 kernel: audit: type=1334 audit(1761768238.906:42): prog-id=25 op=LOAD Oct 29 20:03:59.016534 kernel: audit: type=1334 audit(1761768238.906:43): prog-id=26 op=LOAD Oct 29 20:03:59.016543 kernel: audit: type=1334 audit(1761768238.906:44): prog-id=22 op=UNLOAD Oct 29 20:03:59.016553 systemd[1]: Stopped Switch Root. Oct 29 20:03:59.016564 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 29 20:03:59.016574 systemd[1]: Created slice Slice /system/addon-config. Oct 29 20:03:59.016584 systemd[1]: Created slice Slice /system/addon-run. Oct 29 20:03:59.016594 systemd[1]: Created slice Slice /system/getty. Oct 29 20:03:59.016605 systemd[1]: Created slice Slice /system/modprobe. Oct 29 20:03:59.016615 systemd[1]: Created slice Slice /system/serial-getty. Oct 29 20:03:59.016625 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 29 20:03:59.016635 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 29 20:03:59.016668 systemd[1]: Created slice User and Session Slice. Oct 29 20:03:59.016681 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 29 20:03:59.016691 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 29 20:03:59.016701 systemd[1]: Set up automount Boot partition Automount Point. Oct 29 20:03:59.016711 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 29 20:03:59.016723 systemd[1]: Stopped target Switch Root. Oct 29 20:03:59.016733 systemd[1]: Stopped target Initrd File Systems. Oct 29 20:03:59.016743 systemd[1]: Stopped target Initrd Root File System. Oct 29 20:03:59.016754 systemd[1]: Reached target Remote Encrypted Volumes. Oct 29 20:03:59.016767 systemd[1]: Reached target Remote File Systems. Oct 29 20:03:59.016779 systemd[1]: Reached target Slice Units. Oct 29 20:03:59.016791 systemd[1]: Reached target Swaps. Oct 29 20:03:59.016810 systemd[1]: Reached target Verify torcx succeeded. Oct 29 20:03:59.016821 systemd[1]: Reached target Local Verity Protected Volumes. Oct 29 20:03:59.016831 systemd[1]: Listening on Process Core Dump Socket. Oct 29 20:03:59.016843 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 29 20:03:59.016853 systemd[1]: Listening on Network Service Netlink Socket. Oct 29 20:03:59.016864 systemd[1]: Listening on udev Control Socket. Oct 29 20:03:59.016875 systemd[1]: Listening on udev Kernel Socket. Oct 29 20:03:59.016885 systemd[1]: Mounting Huge Pages File System... Oct 29 20:03:59.016899 systemd[1]: Mounting POSIX Message Queue File System... Oct 29 20:03:59.016914 systemd[1]: Mounting External Media Directory... Oct 29 20:03:59.016924 systemd[1]: Mounting Kernel Debug File System... Oct 29 20:03:59.016933 systemd[1]: Mounting Kernel Trace File System... Oct 29 20:03:59.016943 systemd[1]: Mounting Temporary Directory /tmp... Oct 29 20:03:59.016954 systemd[1]: Starting Create missing system files... Oct 29 20:03:59.016964 systemd[1]: Starting Create List of Static Device Nodes... Oct 29 20:03:59.016974 systemd[1]: Starting Load Kernel Module configfs... Oct 29 20:03:59.016984 systemd[1]: Starting Load Kernel Module drm... Oct 29 20:03:59.016993 systemd[1]: Starting Load Kernel Module fuse... Oct 29 20:03:59.017024 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 29 20:03:59.017036 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 29 20:03:59.017046 systemd[1]: Stopped File System Check on Root Device. Oct 29 20:03:59.017057 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 29 20:03:59.017070 systemd[1]: Stopped systemd-fsck-usr.service. Oct 29 20:03:59.017080 systemd[1]: Stopped Journal Service. Oct 29 20:03:59.017091 kernel: fuse: init (API version 7.32) Oct 29 20:03:59.017101 systemd[1]: Starting Journal Service... Oct 29 20:03:59.017111 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 29 20:03:59.017121 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 29 20:03:59.017132 systemd[1]: Starting Apply Kernel Variables... Oct 29 20:03:59.017142 systemd[1]: Starting Coldplug All udev Devices... Oct 29 20:03:59.017152 systemd[1]: verity-setup.service: Deactivated successfully. Oct 29 20:03:59.017162 systemd[1]: Stopped verity-setup.service. Oct 29 20:03:59.017174 systemd-journald[801]: Journal started Oct 29 20:03:59.017212 systemd-journald[801]: Runtime Journal (/run/log/journal/a7820ab79e50450a9913c8d57cfc46ba) is 6.0M, max 48.5M, 42.4M free. Oct 29 20:03:56.952000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 29 20:03:56.982000 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:03:56.982000 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:03:56.982000 audit: BPF prog-id=19 op=LOAD Oct 29 20:03:56.982000 audit: BPF prog-id=19 op=UNLOAD Oct 29 20:03:56.982000 audit: BPF prog-id=20 op=LOAD Oct 29 20:03:56.982000 audit: BPF prog-id=20 op=UNLOAD Oct 29 20:03:57.016000 audit[750]: AVC avc: denied { associate } for pid=750 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Oct 29 20:03:58.903000 audit: BPF prog-id=21 op=LOAD Oct 29 20:03:58.903000 audit: BPF prog-id=22 op=LOAD Oct 29 20:03:58.904000 audit: BPF prog-id=23 op=LOAD Oct 29 20:03:58.904000 audit: BPF prog-id=16 op=UNLOAD Oct 29 20:03:58.904000 audit: BPF prog-id=17 op=UNLOAD Oct 29 20:03:58.905000 audit: BPF prog-id=24 op=LOAD Oct 29 20:03:58.905000 audit: BPF prog-id=21 op=UNLOAD Oct 29 20:03:58.906000 audit: BPF prog-id=25 op=LOAD Oct 29 20:03:58.906000 audit: BPF prog-id=26 op=LOAD Oct 29 20:03:58.906000 audit: BPF prog-id=22 op=UNLOAD Oct 29 20:03:58.906000 audit: BPF prog-id=23 op=UNLOAD Oct 29 20:03:58.922000 audit: BPF prog-id=24 op=UNLOAD Oct 29 20:03:59.001000 audit: BPF prog-id=27 op=LOAD Oct 29 20:03:59.002000 audit: BPF prog-id=28 op=LOAD Oct 29 20:03:59.002000 audit: BPF prog-id=29 op=LOAD Oct 29 20:03:59.002000 audit: BPF prog-id=25 op=UNLOAD Oct 29 20:03:59.002000 audit: BPF prog-id=26 op=UNLOAD Oct 29 20:03:59.014000 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:03:58.894087 systemd[1]: Queued start job for default target Multi-User System. Oct 29 20:03:57.014986 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" 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:03:58.907976 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 29 20:03:57.015290 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 29 20:03:57.015310 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 29 20:03:57.015441 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 29 20:03:57.015453 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 29 20:03:57.015485 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 29 20:03:57.015499 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 29 20:03:57.015735 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 29 20:03:57.015773 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 29 20:03:57.015788 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 29 20:03:57.016158 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" 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:03:57.016190 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" 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:03:59.018799 systemd[1]: Started Journal Service. Oct 29 20:03:57.016211 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" 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:03:57.016227 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" 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:03:57.016247 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" 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:03:57.016262 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:57Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 29 20:03:58.722088 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:58Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 29 20:03:58.722366 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:58Z" 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:03:58.722471 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:58Z" 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:03:58.722596 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:58Z" 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:03:58.722676 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:58Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 29 20:03:58.722738 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2025-10-29T20:03:58Z" 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:03:59.019280 systemd[1]: Mounted Huge Pages File System. Oct 29 20:03:59.020150 systemd[1]: Mounted POSIX Message Queue File System. Oct 29 20:03:59.021085 systemd[1]: Mounted External Media Directory. Oct 29 20:03:59.021930 systemd[1]: Mounted Kernel Debug File System. Oct 29 20:03:59.022772 systemd[1]: Mounted Kernel Trace File System. Oct 29 20:03:59.023583 systemd[1]: Mounted Temporary Directory /tmp. Oct 29 20:03:59.024728 systemd[1]: Finished Create missing system files. Oct 29 20:03:59.025871 systemd[1]: Finished Create List of Static Device Nodes. Oct 29 20:03:59.026962 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 29 20:03:59.027149 systemd[1]: Finished Load Kernel Module configfs. Oct 29 20:03:59.028234 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 29 20:03:59.028408 systemd[1]: Finished Load Kernel Module drm. Oct 29 20:03:59.029394 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 29 20:03:59.029568 systemd[1]: Finished Load Kernel Module fuse. Oct 29 20:03:59.030710 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 29 20:03:59.031907 systemd[1]: Finished Apply Kernel Variables. Oct 29 20:03:59.040827 systemd[1]: Mounting FUSE Control File System... Oct 29 20:03:59.042455 systemd[1]: Mounting Kernel Configuration File System... Oct 29 20:03:59.043280 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 29 20:03:59.044668 systemd[1]: Starting Rebuild Hardware Database... Oct 29 20:03:59.046383 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 29 20:03:59.047314 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 29 20:03:59.048374 systemd[1]: Starting Load/Save Random Seed... Oct 29 20:03:59.050822 systemd-journald[801]: Time spent on flushing to /var/log/journal/a7820ab79e50450a9913c8d57cfc46ba is 8.222ms for 777 entries. Oct 29 20:03:59.050822 systemd-journald[801]: System Journal (/var/log/journal/a7820ab79e50450a9913c8d57cfc46ba) is 8.0M, max 203.0M, 195.0M free. Oct 29 20:03:59.050209 systemd[1]: Starting Create System Users... Oct 29 20:03:59.053275 systemd[1]: Mounted FUSE Control File System. Oct 29 20:03:59.054700 systemd[1]: Mounted Kernel Configuration File System. Oct 29 20:03:59.058032 systemd[1]: Finished Load/Save Random Seed. Oct 29 20:03:59.059005 systemd[1]: Reached target First Boot Complete. Oct 29 20:03:59.071037 systemd[1]: Finished Coldplug All udev Devices. Oct 29 20:03:59.072186 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 29 20:03:59.074169 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 29 20:03:59.076228 systemd-sysusers[813]: Creating group sgx with gid 999. Oct 29 20:03:59.077077 systemd-sysusers[813]: Creating group systemd-oom with gid 998. Oct 29 20:03:59.077596 systemd-sysusers[813]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Oct 29 20:03:59.078403 systemd-sysusers[813]: Creating group systemd-timesync with gid 997. Oct 29 20:03:59.078946 systemd-sysusers[813]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Oct 29 20:03:59.079591 systemd-sysusers[813]: Creating group systemd-coredump with gid 996. Oct 29 20:03:59.080149 systemd-sysusers[813]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Oct 29 20:03:59.089363 systemd[1]: Finished Create System Users. Oct 29 20:03:59.098760 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 29 20:03:59.113083 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 29 20:03:59.340873 systemd[1]: Finished Rebuild Hardware Database. Oct 29 20:03:59.349000 audit: BPF prog-id=30 op=LOAD Oct 29 20:03:59.349000 audit: BPF prog-id=31 op=LOAD Oct 29 20:03:59.349000 audit: BPF prog-id=32 op=LOAD Oct 29 20:03:59.349000 audit: BPF prog-id=12 op=UNLOAD Oct 29 20:03:59.349000 audit: BPF prog-id=13 op=UNLOAD Oct 29 20:03:59.351119 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 29 20:03:59.374053 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 29 20:03:59.378000 audit: BPF prog-id=33 op=LOAD Oct 29 20:03:59.379923 systemd[1]: Starting Network Configuration... Oct 29 20:03:59.407813 systemd-udevd[827]: Using default interface naming scheme 'v249'. Oct 29 20:03:59.408396 systemd-networkd[834]: lo: Link UP Oct 29 20:03:59.408405 systemd-networkd[834]: lo: Gained carrier Oct 29 20:03:59.408786 systemd-networkd[834]: Enumeration completed Oct 29 20:03:59.408913 systemd[1]: Started Network Configuration. Oct 29 20:03:59.437312 systemd-networkd[834]: eth0: Link UP Oct 29 20:03:59.438067 udevadm[817]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 29 20:03:59.447763 systemd-networkd[834]: eth0: Gained carrier Oct 29 20:03:59.460834 systemd-networkd[834]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 29 20:03:59.466951 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 29 20:03:59.477797 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 29 20:03:59.485941 lvm[846]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 29 20:03:59.512668 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 29 20:03:59.513676 systemd[1]: Reached target Local Encrypted Volumes. Oct 29 20:03:59.523699 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 29 20:03:59.527057 lvm[847]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 29 20:03:59.555736 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 29 20:03:59.556716 systemd[1]: Reached target Preparation for Local File Systems. Oct 29 20:03:59.557631 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 29 20:03:59.557676 systemd[1]: Reached target Containers. Oct 29 20:03:59.567986 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 29 20:03:59.580132 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 29 20:03:59.582260 systemd[1]: Mounting /usr/share/oem... Oct 29 20:03:59.588096 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 29 20:03:59.588149 kernel: BTRFS info (device vda6): has skinny extents Oct 29 20:03:59.590333 systemd[1]: Mounted /usr/share/oem. Oct 29 20:03:59.591109 systemd[1]: Reached target Local File Systems. Oct 29 20:03:59.603712 systemd[1]: Starting Rebuild Dynamic Linker Cache... Oct 29 20:03:59.604898 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 29 20:03:59.604939 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 29 20:03:59.605945 systemd[1]: Starting Commit a transient machine-id on disk... Oct 29 20:03:59.607813 systemd[1]: Starting Create Volatile Files and Directories... Oct 29 20:03:59.615423 systemd-tmpfiles[872]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 29 20:03:59.616867 systemd-tmpfiles[872]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 29 20:03:59.620831 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 29 20:03:59.621854 systemd[1]: Finished Commit a transient machine-id on disk. Oct 29 20:03:59.659471 systemd-tmpfiles[872]: Detected autofs mount point /boot during canonicalization of /boot. Oct 29 20:03:59.659485 systemd-tmpfiles[872]: Skipping /boot Oct 29 20:03:59.664347 systemd-tmpfiles[872]: Detected autofs mount point /boot during canonicalization of /boot. Oct 29 20:03:59.664366 systemd-tmpfiles[872]: Skipping /boot Oct 29 20:03:59.684682 systemd[1]: Finished Rebuild Dynamic Linker Cache. Oct 29 20:03:59.697695 systemd[1]: Finished Create Volatile Files and Directories. Oct 29 20:03:59.699761 systemd[1]: Starting Load Security Auditing Rules... Oct 29 20:03:59.701516 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 29 20:03:59.703969 systemd[1]: Starting Rebuild Journal Catalog... Oct 29 20:03:59.704000 audit: BPF prog-id=34 op=LOAD Oct 29 20:03:59.706457 systemd[1]: Starting Network Name Resolution... Oct 29 20:03:59.707000 audit: BPF prog-id=35 op=LOAD Oct 29 20:03:59.709248 systemd[1]: Starting Network Time Synchronization... Oct 29 20:03:59.711611 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 29 20:03:59.713398 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 29 20:03:59.714729 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 29 20:03:59.725057 systemd[1]: Finished Rebuild Journal Catalog. Oct 29 20:03:59.726171 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 29 20:03:59.728210 systemd[1]: Starting Update is Completed... Oct 29 20:03:59.733689 systemd[1]: Finished Update is Completed. Oct 29 20:03:59.736000 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:03:59.736971 augenrules[895]: No rules Oct 29 20:03:59.737695 systemd[1]: Finished Load Security Auditing Rules. Oct 29 20:03:59.749045 systemd[1]: Started Network Time Synchronization. Oct 29 20:03:59.749765 systemd-timesyncd[883]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 29 20:03:59.750133 systemd[1]: Reached target System Initialization. Oct 29 20:03:59.751072 systemd[1]: Started Watch for update engine configuration changes. Oct 29 20:03:59.751775 systemd-resolved[882]: Positive Trust Anchors: Oct 29 20:03:59.751968 systemd-resolved[882]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 20:03:59.752037 systemd-resolved[882]: 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:03:59.752091 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 29 20:03:59.752962 systemd-resolved[882]: Defaulting to hostname 'linux'. Oct 29 20:03:59.753299 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 29 20:03:59.754211 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 29 20:03:59.754242 systemd[1]: Reached target Path Units. Oct 29 20:03:59.754974 systemd[1]: Reached target System Time Set. Oct 29 20:03:59.755838 systemd[1]: Started Daily Log Rotation. Oct 29 20:03:59.756612 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 29 20:03:59.757598 systemd[1]: Reached target Timer Units. Oct 29 20:03:59.758732 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 29 20:03:59.767397 systemd[1]: Starting Docker Socket for the API... Oct 29 20:03:59.770514 systemd[1]: Listening on OpenSSH Server Socket. Oct 29 20:03:59.771815 systemd[1]: Started Network Name Resolution. Oct 29 20:03:59.772686 systemd[1]: Listening on Docker Socket for the API. Oct 29 20:03:59.773515 systemd[1]: Reached target Network. Oct 29 20:03:59.774222 systemd[1]: Reached target Host and Network Name Lookups. Oct 29 20:03:59.775124 systemd[1]: Reached target Socket Units. Oct 29 20:03:59.775836 systemd[1]: Reached target Basic System. Oct 29 20:03:59.776542 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 29 20:03:59.776571 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 29 20:03:59.777580 systemd[1]: Started D-Bus System Message Bus. Oct 29 20:03:59.781036 systemd[1]: Starting Extend Filesystems... Oct 29 20:03:59.781939 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 29 20:03:59.782932 systemd[1]: Starting Generate /run/flatcar/motd... Oct 29 20:03:59.784758 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 29 20:03:59.786844 systemd[1]: Starting Generate sshd host keys... Oct 29 20:03:59.787755 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 29 20:03:59.787795 systemd[1]: Reached target Load system-provided cloud configs. Oct 29 20:03:59.791491 systemd[1]: Starting User Login Management... Oct 29 20:03:59.792438 extend-filesystems[904]: Found vda Oct 29 20:03:59.792438 extend-filesystems[904]: Found vda1 Oct 29 20:03:59.792438 extend-filesystems[904]: Found vda2 Oct 29 20:03:59.792438 extend-filesystems[904]: Found vda3 Oct 29 20:03:59.792438 extend-filesystems[904]: Found usr Oct 29 20:03:59.792438 extend-filesystems[904]: Found vda4 Oct 29 20:03:59.792438 extend-filesystems[904]: Found vda6 Oct 29 20:03:59.792438 extend-filesystems[904]: Found vda7 Oct 29 20:03:59.792438 extend-filesystems[904]: Found vda9 Oct 29 20:03:59.792438 extend-filesystems[904]: Checking size of /dev/vda9 Oct 29 20:03:59.807036 extend-filesystems[904]: Old size kept for /dev/vda9 Oct 29 20:03:59.792565 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 29 20:03:59.793514 systemd[1]: Starting Update Engine... Oct 29 20:03:59.795039 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 29 20:03:59.795069 systemd[1]: Reached target Load user-provided cloud configs. Oct 29 20:03:59.797750 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 29 20:03:59.797982 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 29 20:03:59.809937 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 29 20:03:59.810184 systemd[1]: Finished Extend Filesystems. Oct 29 20:03:59.811681 systemd[1]: motdgen.service: Deactivated successfully. Oct 29 20:03:59.811914 systemd[1]: Finished Generate /run/flatcar/motd. Oct 29 20:03:59.830135 update_engine[916]: I1029 20:03:59.829854 916 main.cc:89] Flatcar Update Engine starting Oct 29 20:03:59.832168 systemd[1]: Started Update Engine. Oct 29 20:03:59.832438 update_engine[916]: I1029 20:03:59.832404 916 update_check_scheduler.cc:74] Next update check in 6m32s Oct 29 20:03:59.833504 systemd-logind[914]: Watching system buttons on /dev/input/event0 (Power Button) Oct 29 20:03:59.833780 systemd-logind[914]: New seat seat0. Oct 29 20:03:59.834397 systemd[1]: Started Cluster reboot manager. Oct 29 20:03:59.840214 systemd[1]: Started User Login Management. Oct 29 20:03:59.862077 locksmithd[928]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 29 20:04:00.730941 systemd-networkd[834]: eth0: Gained IPv6LL Oct 29 20:04:01.140155 sshd_keygen[922]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Oct 29 20:04:01.157768 systemd[1]: Finished Generate sshd host keys. Oct 29 20:04:01.168768 systemd[1]: Starting Generate /run/issue... Oct 29 20:04:01.173142 systemd[1]: issuegen.service: Deactivated successfully. Oct 29 20:04:01.173359 systemd[1]: Finished Generate /run/issue. Oct 29 20:04:01.175335 systemd[1]: Starting Permit User Sessions... Oct 29 20:04:01.180010 systemd[1]: Finished Permit User Sessions. Oct 29 20:04:01.181928 systemd[1]: Started Getty on tty1. Oct 29 20:04:01.183701 systemd[1]: Started Serial Getty on ttyAMA0. Oct 29 20:04:01.184557 systemd[1]: Reached target Login Prompts. Oct 29 20:04:01.185437 systemd[1]: Reached target Multi-User System. Oct 29 20:04:01.187282 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 29 20:04:01.192262 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 29 20:04:01.192485 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 29 20:04:01.193482 systemd[1]: Startup finished in 704ms (kernel) + 2.360s (initrd) + 4.276s (userspace) = 7.341s. Oct 29 20:04:06.159653 systemd[1]: Created slice Slice /system/sshd. Oct 29 20:04:06.160699 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45852). Oct 29 20:04:06.196157 sshd[950]: Accepted publickey for core from 10.0.0.1 port 45852 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:06.197975 sshd[950]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:06.215116 systemd[1]: Created slice User Slice of UID 500. Oct 29 20:04:06.216277 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 29 20:04:06.217897 systemd-logind[914]: New session 1 of user core. Oct 29 20:04:06.222375 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 29 20:04:06.223677 systemd[1]: Starting User Manager for UID 500... Oct 29 20:04:06.225994 systemd[953]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:06.273493 systemd[953]: Queued start job for default target Main User Target. Oct 29 20:04:06.273693 systemd[953]: Reached target Paths. Oct 29 20:04:06.273708 systemd[953]: Reached target Sockets. Oct 29 20:04:06.273719 systemd[953]: Reached target Timers. Oct 29 20:04:06.273729 systemd[953]: Reached target Basic System. Oct 29 20:04:06.273776 systemd[953]: Reached target Main User Target. Oct 29 20:04:06.273789 systemd[953]: Startup finished in 43ms. Oct 29 20:04:06.273856 systemd[1]: Started User Manager for UID 500. Oct 29 20:04:06.282807 systemd[1]: Started Session 1 of User core. Oct 29 20:04:06.340152 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45860). Oct 29 20:04:06.371408 sshd[962]: Accepted publickey for core from 10.0.0.1 port 45860 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:06.372427 sshd[962]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:06.375641 systemd-logind[914]: New session 2 of user core. Oct 29 20:04:06.383842 systemd[1]: Started Session 2 of User core. Oct 29 20:04:06.434665 sshd[962]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:06.447327 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:45860.service: Deactivated successfully. Oct 29 20:04:06.448040 systemd[1]: session-2.scope: Deactivated successfully. Oct 29 20:04:06.448696 systemd-logind[914]: Session 2 logged out. Waiting for processes to exit. Oct 29 20:04:06.449759 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45862). Oct 29 20:04:06.450396 systemd-logind[914]: Removed session 2. Oct 29 20:04:06.480950 sshd[968]: Accepted publickey for core from 10.0.0.1 port 45862 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:06.481940 sshd[968]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:06.484998 systemd-logind[914]: New session 3 of user core. Oct 29 20:04:06.495818 systemd[1]: Started Session 3 of User core. Oct 29 20:04:06.542746 sshd[968]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:06.561397 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:45862.service: Deactivated successfully. Oct 29 20:04:06.562125 systemd[1]: session-3.scope: Deactivated successfully. Oct 29 20:04:06.562744 systemd-logind[914]: Session 3 logged out. Waiting for processes to exit. Oct 29 20:04:06.564130 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45878). Oct 29 20:04:06.564836 systemd-logind[914]: Removed session 3. Oct 29 20:04:06.595597 sshd[975]: Accepted publickey for core from 10.0.0.1 port 45878 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:06.596508 sshd[975]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:06.599190 systemd-logind[914]: New session 4 of user core. Oct 29 20:04:06.610795 systemd[1]: Started Session 4 of User core. Oct 29 20:04:06.660718 sshd[975]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:06.667599 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:45878.service: Deactivated successfully. Oct 29 20:04:06.668438 systemd[1]: session-4.scope: Deactivated successfully. Oct 29 20:04:06.669134 systemd-logind[914]: Session 4 logged out. Waiting for processes to exit. Oct 29 20:04:06.670766 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45894). Oct 29 20:04:06.671433 systemd-logind[914]: Removed session 4. Oct 29 20:04:06.701762 sshd[981]: Accepted publickey for core from 10.0.0.1 port 45894 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:06.702605 sshd[981]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:06.705209 systemd-logind[914]: New session 5 of user core. Oct 29 20:04:06.715835 systemd[1]: Started Session 5 of User core. Oct 29 20:04:06.770667 sudo[984]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 29 20:04:06.771152 sudo[984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:04:06.780558 sudo[984]: pam_unix(sudo:session): session closed for user root Oct 29 20:04:06.782574 sshd[981]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:06.796242 dbus-daemon[903]: [system] Reloaded configuration Oct 29 20:04:06.796689 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45902). Oct 29 20:04:06.799100 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:45894.service: Deactivated successfully. Oct 29 20:04:06.799808 systemd[1]: session-5.scope: Deactivated successfully. Oct 29 20:04:06.800466 systemd-logind[914]: Session 5 logged out. Waiting for processes to exit. Oct 29 20:04:06.801232 systemd-logind[914]: Removed session 5. Oct 29 20:04:06.828578 sshd[987]: Accepted publickey for core from 10.0.0.1 port 45902 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:06.830032 sshd[987]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:06.832683 systemd-logind[914]: New session 6 of user core. Oct 29 20:04:06.842803 systemd[1]: Started Session 6 of User core. Oct 29 20:04:06.892663 sudo[993]: 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:04:06.892878 sudo[993]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:04:06.895126 sudo[993]: pam_unix(sudo:session): session closed for user root Oct 29 20:04:06.898656 sudo[992]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 29 20:04:06.898853 sudo[992]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:04:06.918698 systemd[1]: Stopping Load Security Auditing Rules... Oct 29 20:04:06.919000 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:04:06.919925 auditctl[996]: No rules Oct 29 20:04:06.920200 systemd[1]: audit-rules.service: Deactivated successfully. Oct 29 20:04:06.920441 systemd[1]: Stopped Load Security Auditing Rules. Oct 29 20:04:06.921839 systemd[1]: Starting Load Security Auditing Rules... Oct 29 20:04:06.922091 kernel: kauditd_printk_skb: 17 callbacks suppressed Oct 29 20:04:06.922132 kernel: audit: type=1305 audit(1761768246.919:62): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 29 20:04:06.936590 augenrules[1013]: No rules Oct 29 20:04:06.937307 systemd[1]: Finished Load Security Auditing Rules. Oct 29 20:04:06.938224 sudo[992]: pam_unix(sudo:session): session closed for user root Oct 29 20:04:06.939377 sshd[987]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:06.947559 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:45902.service: Deactivated successfully. Oct 29 20:04:06.948135 systemd[1]: session-6.scope: Deactivated successfully. Oct 29 20:04:06.948751 systemd-logind[914]: Session 6 logged out. Waiting for processes to exit. Oct 29 20:04:06.949819 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45916). Oct 29 20:04:06.950475 systemd-logind[914]: Removed session 6. Oct 29 20:04:06.982796 sshd[1019]: Accepted publickey for core from 10.0.0.1 port 45916 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:06.983986 sshd[1019]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:06.985663 kernel: audit: type=1006 audit(1761768246.982:63): pid=1019 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:04:06.987813 systemd-logind[914]: New session 7 of user core. Oct 29 20:04:07.001844 systemd[1]: Started Session 7 of User core. Oct 29 20:04:07.050705 sudo[1022]: 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:04:09.700455 update_engine[1270]: Oct 29 20:04:09.700455 update_engine[1270]: Oct 29 20:04:09.700455 update_engine[1270]: Oct 29 20:04:09.700455 update_engine[1270]: Oct 29 20:04:09.700455 update_engine[1270]: Oct 29 20:04:09.700455 update_engine[1270]: Oct 29 20:04:09.700455 update_engine[1270]: Oct 29 20:04:09.700455 update_engine[1270]: Oct 29 20:04:09.700455 update_engine[1270]: I1029 20:04:09.700210 1270 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 29 20:04:09.701293 systemd-logind[914]: Session 24 logged out. Waiting for processes to exit. Oct 29 20:04:09.703095 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:59490). Oct 29 20:04:09.706513 systemd-logind[914]: Removed session 24. Oct 29 20:04:09.707158 update_engine[1270]: I1029 20:04:09.706903 1270 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 29 20:04:09.707158 update_engine[1270]: I1029 20:04:09.707116 1270 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 29 20:04:09.709257 update_engine[1270]: I1029 20:04:09.708961 1270 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 29 20:04:09.709257 update_engine[1270]: I1029 20:04:09.709043 1270 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Oct 29 20:04:09.709257 update_engine[1270]: I1029 20:04:09.709050 1270 omaha_request_action.cc:619] Omaha request response: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.709257 update_engine[1270]: Oct 29 20:04:09.714661 update_engine[1270]: I1029 20:04:09.714489 1270 omaha_request_action.cc:447] Omaha Response manifest version = Oct 29 20:04:09.714661 update_engine[1270]: I1029 20:04:09.714514 1270 omaha_request_action.cc:470] Found 1 url(s) Oct 29 20:04:09.714661 update_engine[1270]: I1029 20:04:09.714526 1270 omaha_request_action.cc:506] Processing first of 1 package(s) Oct 29 20:04:09.714661 update_engine[1270]: I1029 20:04:09.714529 1270 omaha_request_action.cc:513] Omaha Response package name = update.gz Oct 29 20:04:09.714661 update_engine[1270]: I1029 20:04:09.714532 1270 omaha_request_action.cc:529] Url0: http://10.0.0.5:34567/packages/update.gz Oct 29 20:04:09.714661 update_engine[1270]: I1029 20:04:09.714540 1270 omaha_request_action.cc:541] Payload size = 439328019 bytes Oct 29 20:04:09.714661 update_engine[1270]: I1029 20:04:09.714550 1270 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Oct 29 20:04:09.714661 update_engine[1270]: I1029 20:04:09.714560 1270 payload_state.cc:51] Resetting all persisted state as this is a new response Oct 29 20:04:09.714661 update_engine[1270]: I1029 20:04:09.714563 1270 payload_state.cc:360] Current Response Signature = Oct 29 20:04:09.714661 update_engine[1270]: NumURLs = 1 Oct 29 20:04:09.714661 update_engine[1270]: Url0 = http://10.0.0.5:34567/packages/update.gz Oct 29 20:04:09.714661 update_engine[1270]: Payload Size = 439328019 Oct 29 20:04:09.714661 update_engine[1270]: Payload Sha256 Hash = JprWN+czonR3c0MyWAyU2g4RVVt99zqV4E+IEkT3wn8= Oct 29 20:04:09.714661 update_engine[1270]: Is Delta Payload = 0 Oct 29 20:04:09.714661 update_engine[1270]: Max Failure Count Per Url = 10 Oct 29 20:04:09.714661 update_engine[1270]: Disable Payload Backoff = 1 Oct 29 20:04:09.714969 update_engine[1270]: I1029 20:04:09.714679 1270 payload_state.cc:381] Payload Attempt Number = 0 Oct 29 20:04:09.714969 update_engine[1270]: I1029 20:04:09.714716 1270 payload_state.cc:404] Current URL Index = 0 Oct 29 20:04:09.714969 update_engine[1270]: I1029 20:04:09.714747 1270 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Oct 29 20:04:09.714969 update_engine[1270]: I1029 20:04:09.714774 1270 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Oct 29 20:04:09.714969 update_engine[1270]: I1029 20:04:09.714777 1270 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 29 20:04:09.714969 update_engine[1270]: I1029 20:04:09.714809 1270 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Oct 29 20:04:09.714969 update_engine[1270]: I1029 20:04:09.714824 1270 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Oct 29 20:04:09.714969 update_engine[1270]: I1029 20:04:09.714829 1270 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Oct 29 20:04:09.714969 update_engine[1270]: I1029 20:04:09.714845 1270 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Oct 29 20:04:09.714969 update_engine[1270]: E1029 20:04:09.714850 1270 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Oct 29 20:04:09.715307 update_engine[1270]: I1029 20:04:09.715291 1270 omaha_response_handler_action.cc:85] Using this install plan: Oct 29 20:04:09.715307 update_engine[1270]: I1029 20:04:09.715305 1270 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.5: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:04:09.715393 update_engine[1270]: I1029 20:04:09.715381 1270 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Oct 29 20:04:09.716388 update_engine[1270]: I1029 20:04:09.716367 1270 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Oct 29 20:04:09.740511 sshd[1292]: Accepted publickey for core from 10.0.0.1 port 59490 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:09.741729 sshd[1292]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:09.745393 systemd-logind[914]: New session 25 of user core. Oct 29 20:04:09.750817 systemd[1]: Started Session 25 of User core. Oct 29 20:04:09.810639 sshd[1292]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:09.813109 systemd[1]: sshd@24-10.0.0.6:22-10.0.0.1:59490.service: Deactivated successfully. Oct 29 20:04:09.813884 systemd[1]: session-25.scope: Deactivated successfully. Oct 29 20:04:09.814508 systemd-logind[914]: Session 25 logged out. Waiting for processes to exit. Oct 29 20:04:09.815250 systemd-logind[914]: Removed session 25. Oct 29 20:04:11.544695 update_engine[1270]: I1029 20:04:11.544656 1270 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Oct 29 20:04:11.544695 update_engine[1270]: I1029 20:04:11.544696 1270 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Oct 29 20:04:11.606086 update_engine[1270]: E1029 20:04:11.606001 1270 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Oct 29 20:04:11.606086 update_engine[1270]: I1029 20:04:11.606045 1270 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Oct 29 20:04:11.606086 update_engine[1270]: I1029 20:04:11.606050 1270 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Oct 29 20:04:11.606086 update_engine[1270]: I1029 20:04:11.606053 1270 update_attempter.cc:302] Processing Done. Oct 29 20:04:11.606086 update_engine[1270]: E1029 20:04:11.606098 1270 update_attempter.cc:615] Update failed. Oct 29 20:04:11.606086 update_engine[1270]: I1029 20:04:11.606103 1270 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Oct 29 20:04:11.606086 update_engine[1270]: I1029 20:04:11.606107 1270 payload_state.cc:276] Incrementing the URL failure count Oct 29 20:04:11.606086 update_engine[1270]: I1029 20:04:11.606110 1270 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 29 20:04:11.606422 update_engine[1270]: I1029 20:04:11.606353 1270 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 29 20:04:11.606422 update_engine[1270]: I1029 20:04:11.606375 1270 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.5:34567/v1/update Oct 29 20:04:11.606422 update_engine[1270]: I1029 20:04:11.606380 1270 omaha_request_action.cc:269] Request: Oct 29 20:04:11.606422 update_engine[1270]: Oct 29 20:04:11.606422 update_engine[1270]: Oct 29 20:04:11.606422 update_engine[1270]: Oct 29 20:04:11.606422 update_engine[1270]: Oct 29 20:04:11.606422 update_engine[1270]: Oct 29 20:04:11.606422 update_engine[1270]: Oct 29 20:04:11.606422 update_engine[1270]: I1029 20:04:11.606384 1270 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Oct 29 20:04:11.606597 update_engine[1270]: I1029 20:04:11.606438 1270 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Oct 29 20:04:11.606597 update_engine[1270]: I1029 20:04:11.606539 1270 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Oct 29 20:04:11.747288 update_engine[1270]: I1029 20:04:11.747238 1270 libcurl_http_fetcher.cc:248] HTTP response code: 200 Oct 29 20:04:11.747381 update_engine[1270]: I1029 20:04:11.747324 1270 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Oct 29 20:04:11.747381 update_engine[1270]: I1029 20:04:11.747331 1270 omaha_request_action.cc:619] Omaha request response: Oct 29 20:04:11.747381 update_engine[1270]: Oct 29 20:04:11.747381 update_engine[1270]: Oct 29 20:04:11.747381 update_engine[1270]: Oct 29 20:04:11.747381 update_engine[1270]: Oct 29 20:04:11.747381 update_engine[1270]: Oct 29 20:04:11.747381 update_engine[1270]: Oct 29 20:04:11.747381 update_engine[1270]: E1029 20:04:11.747344 1270 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Oct 29 20:04:11.747381 update_engine[1270]: I1029 20:04:11.747349 1270 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 29 20:04:11.747381 update_engine[1270]: I1029 20:04:11.747351 1270 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 29 20:04:11.747381 update_engine[1270]: I1029 20:04:11.747354 1270 update_attempter.cc:302] Processing Done. Oct 29 20:04:11.747381 update_engine[1270]: I1029 20:04:11.747359 1270 update_attempter.cc:306] Error event sent. Oct 29 20:04:19.758277 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39812). Oct 29 20:04:19.792064 sshd[1305]: Accepted publickey for core from 10.0.0.1 port 39812 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:19.795108 kernel: kauditd_printk_skb: 287 callbacks suppressed Oct 29 20:04:19.795156 kernel: audit: type=1006 audit(1761768259.791:359): pid=1305 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:04:19.795589 sshd[1305]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:19.798029 systemd-logind[914]: New session 26 of user core. Oct 29 20:04:19.805778 systemd[1]: Started Session 26 of User core. Oct 29 20:04:19.861542 sshd[1305]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:19.871614 systemd[1]: sshd@25-10.0.0.6:22-10.0.0.1:39812.service: Deactivated successfully. Oct 29 20:04:19.872250 systemd[1]: session-26.scope: Deactivated successfully. Oct 29 20:04:19.872804 systemd-logind[914]: Session 26 logged out. Waiting for processes to exit. Oct 29 20:04:19.873811 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39824). Oct 29 20:04:19.874382 systemd-logind[914]: Removed session 26. Oct 29 20:04:19.904835 sshd[1312]: Accepted publickey for core from 10.0.0.1 port 39824 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:19.907059 sshd[1312]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:19.907669 kernel: audit: type=1006 audit(1761768259.905:360): pid=1312 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:04:19.909467 systemd-logind[914]: New session 27 of user core. Oct 29 20:04:19.920765 systemd[1]: Started Session 27 of User core. Oct 29 20:04:19.974350 sshd[1312]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:19.985013 systemd[1]: session-27.scope: Deactivated successfully. Oct 29 20:04:19.985521 systemd[1]: sshd@26-10.0.0.6:22-10.0.0.1:39824.service: Deactivated successfully. Oct 29 20:04:19.986316 systemd-logind[914]: Session 27 logged out. Waiting for processes to exit. Oct 29 20:04:19.987272 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39836). Oct 29 20:04:19.987871 systemd-logind[914]: Removed session 27. Oct 29 20:04:20.019009 sshd[1320]: Accepted publickey for core from 10.0.0.1 port 39836 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:20.020986 sshd[1320]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:20.022675 kernel: audit: type=1006 audit(1761768260.019:361): pid=1320 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:04:20.023404 systemd-logind[914]: New session 28 of user core. Oct 29 20:04:20.031848 systemd[1]: Started Session 28 of User core. Oct 29 20:04:20.079905 sshd[1320]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:20.092219 systemd[1]: sshd@27-10.0.0.6:22-10.0.0.1:39836.service: Deactivated successfully. Oct 29 20:04:20.092749 systemd[1]: session-28.scope: Deactivated successfully. Oct 29 20:04:20.093276 systemd-logind[914]: Session 28 logged out. Waiting for processes to exit. Oct 29 20:04:20.094234 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39842). Oct 29 20:04:20.094803 systemd-logind[914]: Removed session 28. Oct 29 20:04:20.125552 sshd[1326]: Accepted publickey for core from 10.0.0.1 port 39842 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:20.128661 kernel: audit: type=1006 audit(1761768260.124:362): pid=1326 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:04:20.128729 sshd[1326]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:20.131122 systemd-logind[914]: New session 29 of user core. Oct 29 20:04:20.141790 systemd[1]: Started Session 29 of User core. Oct 29 20:04:20.189306 sshd[1326]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:20.201278 systemd[1]: sshd@28-10.0.0.6:22-10.0.0.1:39842.service: Deactivated successfully. Oct 29 20:04:20.201801 systemd[1]: session-29.scope: Deactivated successfully. Oct 29 20:04:20.202333 systemd-logind[914]: Session 29 logged out. Waiting for processes to exit. Oct 29 20:04:20.203336 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39848). Oct 29 20:04:20.203920 systemd-logind[914]: Removed session 29. Oct 29 20:04:20.235187 sshd[1332]: Accepted publickey for core from 10.0.0.1 port 39848 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:20.236293 sshd[1332]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:20.238674 kernel: audit: type=1006 audit(1761768260.234:363): pid=1332 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:04:20.238850 systemd-logind[914]: New session 30 of user core. Oct 29 20:04:20.247864 systemd[1]: Started Session 30 of User core. Oct 29 20:04:20.297857 sudo[1336]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Oct 29 20:04:20.298803 sudo[1336]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:04:20.304732 systemd[1]: sshd.socket: Deactivated successfully. Oct 29 20:04:20.305080 systemd[1]: Closed OpenSSH Server Socket. Oct 29 20:04:20.306186 sudo[1336]: pam_unix(sudo:session): session closed for user root Oct 29 20:04:20.309713 sudo[1335]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Oct 29 20:04:20.310144 sudo[1335]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:04:20.324267 systemd[1]: Stopping Session 1 of User core... Oct 29 20:04:20.325447 systemd[1]: Stopping Session 30 of User core... Oct 29 20:04:20.325626 sshd[950]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:20.325822 sshd[1332]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:20.326530 systemd[1]: Removed slice Slice /system/addon-config. Oct 29 20:04:20.327732 systemd[1]: Removed slice Slice /system/addon-run. Oct 29 20:04:20.328811 sudo[1335]: pam_unix(sudo:session): session closed for user root Oct 29 20:04:20.328819 systemd[1]: Removed slice Slice /system/modprobe. Oct 29 20:04:20.329987 systemd[1]: Removed slice Slice /system/system-cloudinit. Oct 29 20:04:20.330971 systemd[1]: Stopped target Multi-User System. Oct 29 20:04:20.331760 systemd[1]: Stopped target Login Prompts. Oct 29 20:04:20.332494 systemd[1]: Stopped target Containers. Oct 29 20:04:20.333255 systemd[1]: Stopped target Host and Network Name Lookups. Oct 29 20:04:20.334285 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 29 20:04:20.335184 systemd[1]: Stopped target Timer Units. Oct 29 20:04:20.335903 systemd[1]: logrotate.timer: Deactivated successfully. Oct 29 20:04:20.335947 systemd[1]: Stopped Daily Log Rotation. Oct 29 20:04:20.336613 systemd[1]: mdadm.timer: Deactivated successfully. Oct 29 20:04:20.336660 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Oct 29 20:04:20.337628 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Oct 29 20:04:20.337684 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Oct 29 20:04:20.338580 systemd[1]: Stopped target System Time Set. Oct 29 20:04:20.339638 systemd[1]: Stopped target Load user-provided cloud configs. Oct 29 20:04:20.340555 systemd[1]: Stopped target Load system-provided cloud configs. Oct 29 20:04:20.341575 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 29 20:04:20.341674 systemd[1]: Closed Process Core Dump Socket. Oct 29 20:04:20.347077 systemd[1]: Unmounting Boot partition... Oct 29 20:04:20.348226 systemd[1]: Stopping Getty on tty1... Oct 29 20:04:20.348980 systemd[1]: Stopping Serial Getty on ttyAMA0... Oct 29 20:04:20.349894 systemd[1]: Stopping OpenSSH per-connection server daemon... Oct 29 20:04:20.350782 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:39848)... Oct 29 20:04:20.351633 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Oct 29 20:04:20.351784 systemd[1]: Stopped Commit a transient machine-id on disk. Oct 29 20:04:20.352768 systemd[1]: Stopped target First Boot Complete. Oct 29 20:04:20.354575 systemd[1]: Stopping Load/Save Random Seed... Oct 29 20:04:20.355588 systemd[1]: Stopping Update Engine... Oct 29 20:04:20.359727 systemd[1]: getty@tty1.service: Deactivated successfully. Oct 29 20:04:20.359925 systemd[1]: Stopped Getty on tty1. Oct 29 20:04:20.361002 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Oct 29 20:04:20.361188 systemd[1]: Stopped Serial Getty on ttyAMA0. Oct 29 20:04:20.362436 systemd[1]: sshd@0-10.0.0.6:22-10.0.0.1:45852.service: Deactivated successfully. Oct 29 20:04:20.362626 systemd[1]: Stopped OpenSSH per-connection server daemon. Oct 29 20:04:20.363943 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Oct 29 20:04:20.364014 systemd[1]: update-engine.service: Failed with result 'exit-code'. Oct 29 20:04:20.364256 systemd[1]: Stopped Update Engine. Oct 29 20:04:20.364977 systemd[1]: update-engine.service: Consumed 2.386s CPU time. Oct 29 20:04:20.365196 systemd[1]: sshd@29-10.0.0.6:22-10.0.0.1:39848.service: Deactivated successfully. Oct 29 20:04:20.365378 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:39848). Oct 29 20:04:20.377411 systemd[1]: systemd-random-seed.service: Deactivated successfully. Oct 29 20:04:20.377625 systemd[1]: Stopped Load/Save Random Seed. Oct 29 20:04:20.378679 systemd[1]: session-30.scope: Deactivated successfully. Oct 29 20:04:20.378907 systemd[1]: Stopped Session 30 of User core. Oct 29 20:04:20.379986 systemd[1]: boot.mount: Deactivated successfully. Oct 29 20:04:20.380225 systemd[1]: Unmounted Boot partition. Oct 29 20:04:20.381124 systemd[1]: session-1.scope: Deactivated successfully. Oct 29 20:04:20.381350 systemd[1]: Stopped Session 1 of User core. Oct 29 20:04:20.382824 systemd-logind[914]: Session 1 logged out. Waiting for processes to exit. Oct 29 20:04:20.383738 systemd-logind[914]: Session 30 logged out. Waiting for processes to exit. Oct 29 20:04:20.383984 systemd[1]: Removed slice Slice /system/getty. Oct 29 20:04:20.385050 systemd[1]: Removed slice Slice /system/serial-getty. Oct 29 20:04:20.386348 systemd[1]: Removed slice Slice /system/sshd. Oct 29 20:04:20.387187 systemd[1]: sshd-keygen.service: Deactivated successfully. Oct 29 20:04:20.387283 systemd[1]: Stopped Generate sshd host keys. Oct 29 20:04:20.388100 systemd[1]: sshd-keygen.service: Consumed 1.388s CPU time. Oct 29 20:04:20.388139 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Oct 29 20:04:20.388248 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Oct 29 20:04:20.389488 systemd[1]: Stopping User Login Management... Oct 29 20:04:20.390353 systemd[1]: Stopping User Manager for UID 500... Oct 29 20:04:20.391220 systemd[953]: Stopped target Main User Target. Oct 29 20:04:20.391235 systemd[953]: Stopped target Basic System. Oct 29 20:04:20.391244 systemd[953]: Stopped target Paths. Oct 29 20:04:20.391252 systemd[953]: Stopped target Sockets. Oct 29 20:04:20.391269 systemd[953]: Reached target Shutdown. Oct 29 20:04:20.391276 systemd[953]: Stopped target Timers. Oct 29 20:04:20.391382 systemd[953]: Finished Exit the Session. Oct 29 20:04:20.391404 systemd[953]: Reached target Exit the Session. Oct 29 20:04:20.392458 systemd-logind[914]: Removed session 30. Oct 29 20:04:20.393522 systemd[1]: user@500.service: Deactivated successfully. Oct 29 20:04:20.393724 systemd[1]: Stopped User Manager for UID 500. Oct 29 20:04:20.395515 systemd[1]: Stopping User Runtime Directory /run/user/500... Oct 29 20:04:20.400675 systemd[1]: run-user-500.mount: Deactivated successfully. Oct 29 20:04:20.400752 systemd[1]: Unmounted /run/user/500. Oct 29 20:04:20.401847 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Oct 29 20:04:20.402064 systemd[1]: Stopped User Runtime Directory /run/user/500. Oct 29 20:04:20.403725 systemd[1]: Removed slice User Slice of UID 500. Oct 29 20:04:20.405273 systemd[1]: Stopping D-Bus System Message Bus... Oct 29 20:04:20.406809 systemd[1]: Stopping Permit User Sessions... Oct 29 20:04:20.408280 systemd[1]: dbus.service: Deactivated successfully. Oct 29 20:04:20.408528 systemd[1]: Stopped D-Bus System Message Bus. Oct 29 20:04:20.409576 systemd[1]: systemd-logind.service: Deactivated successfully. Oct 29 20:04:20.409853 systemd[1]: Stopped User Login Management. Oct 29 20:04:20.411167 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Oct 29 20:04:20.411381 systemd[1]: Stopped Permit User Sessions. Oct 29 20:04:20.412218 systemd[1]: Stopped target Basic System. Oct 29 20:04:20.412964 systemd[1]: Stopped target Network. Oct 29 20:04:20.413586 systemd[1]: Stopped target Path Units. Oct 29 20:04:20.414321 systemd[1]: motdgen.path: Deactivated successfully. Oct 29 20:04:20.414000 audit: BPF prog-id=54 op=UNLOAD Oct 29 20:04:20.415663 kernel: audit: type=1334 audit(1761768260.414:364): prog-id=54 op=UNLOAD Oct 29 20:04:20.417700 systemd[1]: Stopped Watch for update engine configuration changes. Oct 29 20:04:20.418775 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Oct 29 20:04:20.423708 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 29 20:04:20.424725 systemd[1]: Stopped target Remote File Systems. Oct 29 20:04:20.425458 systemd[1]: Stopped target Slice Units. Oct 29 20:04:20.426452 systemd[1]: Removed slice User and Session Slice. Oct 29 20:04:20.427298 systemd[1]: Stopped target Socket Units. Oct 29 20:04:20.428072 systemd[1]: dbus.socket: Deactivated successfully. Oct 29 20:04:20.428125 systemd[1]: Closed D-Bus System Message Bus Socket. Oct 29 20:04:20.429053 systemd[1]: docker.socket: Deactivated successfully. Oct 29 20:04:20.429284 systemd[1]: Closed Docker Socket for the API. Oct 29 20:04:20.430087 systemd[1]: Stopped target System Initialization. Oct 29 20:04:20.430899 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Oct 29 20:04:20.431022 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Oct 29 20:04:20.432071 systemd[1]: Stopped target Local Verity Protected Volumes. Oct 29 20:04:20.445373 systemd[1]: Stopping Load Security Auditing Rules... Oct 29 20:04:20.446381 systemd[1]: Stopping Network Name Resolution... Oct 29 20:04:20.447323 systemd[1]: Stopping Network Time Synchronization... Oct 29 20:04:20.448133 systemd[1]: systemd-update-done.service: Deactivated successfully. Oct 29 20:04:20.448245 systemd[1]: Stopped Update is Completed. Oct 29 20:04:20.448706 auditctl[1352]: No rules Oct 29 20:04:20.449006 systemd[1]: ldconfig.service: Deactivated successfully. Oct 29 20:04:20.449060 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Oct 29 20:04:20.449891 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Oct 29 20:04:20.449943 systemd[1]: Stopped Rebuild Hardware Database. Oct 29 20:04:20.450724 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Oct 29 20:04:20.450778 systemd[1]: Stopped Rebuild Journal Catalog. Oct 29 20:04:20.452276 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Oct 29 20:04:20.454807 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 29 20:04:20.455071 systemd[1]: Stopped Network Name Resolution. Oct 29 20:04:20.456092 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Oct 29 20:04:20.456329 systemd[1]: Stopped Network Time Synchronization. Oct 29 20:04:20.457461 systemd[1]: audit-rules.service: Deactivated successfully. Oct 29 20:04:20.457695 systemd[1]: Stopped Load Security Auditing Rules. Oct 29 20:04:20.459916 systemd[1]: Stopping Network Configuration... Oct 29 20:04:20.460846 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Oct 29 20:04:20.461054 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Oct 29 20:04:20.462638 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 29 20:04:20.462753 systemd[1]: Stopped Create Volatile Files and Directories. Oct 29 20:04:20.463639 systemd[1]: Stopped target Local File Systems. Oct 29 20:04:20.466675 systemd-networkd[834]: eth0: DHCPv6 lease lost Oct 29 20:04:20.478000 audit: BPF prog-id=53 op=UNLOAD Oct 29 20:04:20.478000 audit: BPF prog-id=60 op=UNLOAD Oct 29 20:04:20.479581 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Oct 29 20:04:20.480359 kernel: audit: type=1334 audit(1761768260.478:365): prog-id=53 op=UNLOAD Oct 29 20:04:20.480394 kernel: audit: type=1334 audit(1761768260.478:366): prog-id=60 op=UNLOAD Oct 29 20:04:20.481799 systemd[1]: Unmounting External Media Directory... Oct 29 20:04:20.483416 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Oct 29 20:04:20.485144 systemd[1]: Unmounting /run/torcx/unpack... Oct 29 20:04:20.486293 systemd[1]: Unmounting Temporary Directory /tmp... Oct 29 20:04:20.487599 systemd[1]: Unmounting /usr/share/oem... Oct 29 20:04:20.489108 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Oct 29 20:04:20.491930 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 29 20:04:20.492185 systemd[1]: Stopped Network Configuration. Oct 29 20:04:20.493099 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 29 20:04:20.493324 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Oct 29 20:04:20.494577 systemd[1]: media.mount: Deactivated successfully. Oct 29 20:04:20.494836 systemd[1]: Unmounted External Media Directory. Oct 29 20:04:20.495736 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Oct 29 20:04:20.495950 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Oct 29 20:04:20.497181 systemd[1]: tmp.mount: Deactivated successfully. Oct 29 20:04:20.497448 systemd[1]: Unmounted Temporary Directory /tmp. Oct 29 20:04:20.506843 systemd[1]: usr-share-oem.mount: Deactivated successfully. Oct 29 20:04:20.507100 systemd[1]: Unmounted /usr/share/oem. Oct 29 20:04:20.507963 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Oct 29 20:04:20.508181 systemd[1]: Unmounted /run/torcx/unpack. Oct 29 20:04:20.509153 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Oct 29 20:04:20.509374 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Oct 29 20:04:20.509000 audit: BPF prog-id=61 op=UNLOAD Oct 29 20:04:20.510812 systemd[1]: Stopped target Swaps. Oct 29 20:04:20.511668 kernel: audit: type=1334 audit(1761768260.509:367): prog-id=61 op=UNLOAD Oct 29 20:04:20.512235 systemd[1]: Reached target Unmount All Filesystems. Oct 29 20:04:20.513105 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 29 20:04:20.513166 systemd[1]: Closed Network Service Netlink Socket. Oct 29 20:04:20.513991 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Oct 29 20:04:20.514054 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Oct 29 20:04:20.515269 systemd[1]: Removed slice Slice /system/systemd-fsck. Oct 29 20:04:20.516147 systemd[1]: Stopped target Preparation for Local File Systems. Oct 29 20:04:20.517099 systemd[1]: lvm2-activation.service: Deactivated successfully. Oct 29 20:04:20.517165 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 29 20:04:20.518041 systemd[1]: Stopped target Local Encrypted Volumes. Oct 29 20:04:20.518905 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 29 20:04:20.518943 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 29 20:04:20.519936 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Oct 29 20:04:20.523999 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Oct 29 20:04:20.525027 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Oct 29 20:04:20.525098 systemd[1]: Stopped Activation of LVM2 logical volumes. Oct 29 20:04:20.525983 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 29 20:04:20.526038 systemd[1]: Stopped Apply Kernel Variables. Oct 29 20:04:20.526819 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 29 20:04:20.526883 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 29 20:04:20.527738 systemd[1]: systemd-sysusers.service: Deactivated successfully. Oct 29 20:04:20.527794 systemd[1]: Stopped Create System Users. Oct 29 20:04:20.528513 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Oct 29 20:04:20.528563 systemd[1]: Stopped Remount Root and Kernel File Systems. Oct 29 20:04:20.529518 systemd[1]: Reached target System Shutdown. Oct 29 20:04:20.530287 systemd[1]: Reached target Late Shutdown Services. Oct 29 20:04:20.531172 systemd[1]: systemd-reboot.service: Deactivated successfully. Oct 29 20:04:20.531210 systemd[1]: Finished System Reboot. Oct 29 20:04:20.531889 systemd[1]: Reached target System Reboot. Oct 29 20:04:20.532563 systemd[1]: Shutting down. Oct 29 20:04:20.533000 audit: BPF prog-id=56 op=UNLOAD Oct 29 20:04:20.533000 audit: BPF prog-id=55 op=UNLOAD Oct 29 20:04:20.533000 audit: BPF prog-id=59 op=UNLOAD Oct 29 20:04:20.533000 audit: BPF prog-id=58 op=UNLOAD Oct 29 20:04:20.533000 audit: BPF prog-id=57 op=UNLOAD Oct 29 20:04:20.536670 kernel: audit: type=1334 audit(1761768260.533:368): prog-id=56 op=UNLOAD Oct 29 20:04:20.535000 audit: BPF prog-id=64 op=UNLOAD Oct 29 20:04:20.535000 audit: BPF prog-id=63 op=UNLOAD Oct 29 20:04:20.535000 audit: BPF prog-id=62 op=UNLOAD Oct 29 20:04:20.570682 systemd-shutdown[1]: Syncing filesystems and block devices. Oct 29 20:04:20.578176 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Oct 29 20:04:20.578276 systemd-journald[801]: Journal stopped -- Reboot -- Oct 29 20:04:27.682999 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 29 20:04:27.683016 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:04:27.683024 kernel: efi: EFI v2.70 by EDK II Oct 29 20:04:27.683034 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Oct 29 20:04:27.683039 kernel: efi: seeding entropy pool Oct 29 20:04:27.683044 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 29 20:04:27.683050 kernel: ACPI: Early table checksum verification disabled Oct 29 20:04:27.683055 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 29 20:04:27.683060 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 29 20:04:27.683065 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:04:27.683071 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:04:27.683077 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:04:27.683082 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:04:27.683088 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:04:27.683095 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:04:27.683100 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:04:27.683107 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:04:27.683114 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 20:04:27.683119 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 29 20:04:27.683124 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 29 20:04:27.683129 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:04:27.683134 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Oct 29 20:04:27.683139 kernel: Zone ranges: Oct 29 20:04:27.683145 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:04:27.683150 kernel: DMA32 empty Oct 29 20:04:27.683155 kernel: Normal empty Oct 29 20:04:27.683160 kernel: Movable zone start for each node Oct 29 20:04:27.683166 kernel: Early memory node ranges Oct 29 20:04:27.683171 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Oct 29 20:04:27.683176 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 29 20:04:27.683181 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 29 20:04:27.683187 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 29 20:04:27.683192 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 29 20:04:27.683197 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 29 20:04:27.683202 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 29 20:04:27.683207 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 29 20:04:27.683212 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 29 20:04:27.683217 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 29 20:04:27.683222 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 29 20:04:27.683228 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 20:04:27.683236 kernel: On node 0 totalpages: 643072 Oct 29 20:04:27.683242 kernel: DMA zone: 10048 pages used for memmap Oct 29 20:04:27.683248 kernel: DMA zone: 0 pages reserved Oct 29 20:04:27.683253 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 29 20:04:27.683280 kernel: psci: probing for conduit method from ACPI. Oct 29 20:04:27.683287 kernel: psci: PSCIv1.1 detected in firmware. Oct 29 20:04:27.683292 kernel: psci: Using standard PSCI v0.2 function IDs Oct 29 20:04:27.683298 kernel: psci: Trusted OS migration not required Oct 29 20:04:27.683305 kernel: psci: SMC Calling Convention v1.1 Oct 29 20:04:27.683311 kernel: ACPI: SRAT not present Oct 29 20:04:27.683316 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 29 20:04:27.683322 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 29 20:04:27.683327 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 29 20:04:27.683333 kernel: Detected PIPT I-cache on CPU0 Oct 29 20:04:27.683338 kernel: CPU features: detected: GIC system register CPU interface Oct 29 20:04:27.683344 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 29 20:04:27.683349 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 29 20:04:27.683355 kernel: CPU features: detected: Hardware dirty bit management Oct 29 20:04:27.683360 kernel: CPU features: detected: Spectre-v4 Oct 29 20:04:27.683367 kernel: CPU features: detected: ARM erratum 1418040 Oct 29 20:04:27.683372 kernel: CPU features: detected: Spectre-BHB Oct 29 20:04:27.683378 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 29 20:04:27.683383 kernel: Policy zone: DMA Oct 29 20:04:27.683389 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:04:27.683395 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 29 20:04:27.683401 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 29 20:04:27.683407 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 29 20:04:27.683412 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Oct 29 20:04:27.683418 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 29 20:04:27.683424 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 29 20:04:27.683430 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 29 20:04:27.683436 kernel: rcu: RCU event tracing is enabled. Oct 29 20:04:27.683442 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 29 20:04:27.683448 kernel: Trampoline variant of Tasks RCU enabled. Oct 29 20:04:27.683453 kernel: Tracing variant of Tasks RCU enabled. Oct 29 20:04:27.683459 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 29 20:04:27.683465 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 29 20:04:27.683470 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 29 20:04:27.683475 kernel: GICv3: 256 SPIs implemented Oct 29 20:04:27.683481 kernel: GICv3: 0 Extended SPIs implemented Oct 29 20:04:27.683486 kernel: GICv3: Distributor has no Range Selector support Oct 29 20:04:27.683492 kernel: GICv3: 16 PPIs implemented Oct 29 20:04:27.683532 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 29 20:04:27.683538 kernel: ACPI: SRAT not present Oct 29 20:04:27.683544 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 29 20:04:27.683549 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 29 20:04:27.683555 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 29 20:04:27.683561 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 29 20:04:27.683566 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 29 20:04:27.683571 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:04:27.683577 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 29 20:04:27.683583 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 29 20:04:27.683589 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 29 20:04:27.683594 kernel: arm-pv: using stolen time PV Oct 29 20:04:27.683601 kernel: Console: colour dummy device 80x25 Oct 29 20:04:27.683607 kernel: ACPI: Core revision 20200925 Oct 29 20:04:27.683613 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 29 20:04:27.683619 kernel: pid_max: default: 32768 minimum: 301 Oct 29 20:04:27.683624 kernel: LSM: Security Framework initializing Oct 29 20:04:27.683630 kernel: SELinux: Initializing. Oct 29 20:04:27.683636 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 29 20:04:27.683642 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 29 20:04:27.683648 kernel: rcu: Hierarchical SRCU implementation. Oct 29 20:04:27.683654 kernel: Platform MSI: ITS@0x8080000 domain created Oct 29 20:04:27.683660 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 29 20:04:27.683665 kernel: Remapping and enabling EFI services. Oct 29 20:04:27.683671 kernel: smp: Bringing up secondary CPUs ... Oct 29 20:04:27.683677 kernel: Detected PIPT I-cache on CPU1 Oct 29 20:04:27.683682 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 29 20:04:27.683688 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 29 20:04:27.683694 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:04:27.683700 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 29 20:04:27.683705 kernel: Detected PIPT I-cache on CPU2 Oct 29 20:04:27.683712 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 29 20:04:27.683718 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 29 20:04:27.683724 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:04:27.683730 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 29 20:04:27.683736 kernel: Detected PIPT I-cache on CPU3 Oct 29 20:04:27.683744 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 29 20:04:27.683751 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 29 20:04:27.683757 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 20:04:27.683763 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 29 20:04:27.683769 kernel: smp: Brought up 1 node, 4 CPUs Oct 29 20:04:27.683775 kernel: SMP: Total of 4 processors activated. Oct 29 20:04:27.683781 kernel: CPU features: detected: Privileged Access Never Oct 29 20:04:27.683787 kernel: CPU features: detected: LSE atomic instructions Oct 29 20:04:27.683793 kernel: CPU features: detected: User Access Override Oct 29 20:04:27.683799 kernel: CPU features: detected: 32-bit EL0 Support Oct 29 20:04:27.683805 kernel: CPU features: detected: Common not Private translations Oct 29 20:04:27.683811 kernel: CPU features: detected: RAS Extension Support Oct 29 20:04:27.683818 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 29 20:04:27.683824 kernel: CPU features: detected: CRC32 instructions Oct 29 20:04:27.683831 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 29 20:04:27.683837 kernel: CPU: All CPU(s) started at EL1 Oct 29 20:04:27.683842 kernel: alternatives: patching kernel code Oct 29 20:04:27.683876 kernel: devtmpfs: initialized Oct 29 20:04:27.683884 kernel: KASLR enabled Oct 29 20:04:27.683890 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 29 20:04:27.683896 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 29 20:04:27.683902 kernel: pinctrl core: initialized pinctrl subsystem Oct 29 20:04:27.683908 kernel: SMBIOS 3.0.0 present. Oct 29 20:04:27.683928 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 29 20:04:27.683935 kernel: NET: Registered protocol family 16 Oct 29 20:04:27.683941 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 29 20:04:27.683948 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 29 20:04:27.683956 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 29 20:04:27.683965 kernel: audit: initializing netlink subsys (disabled) Oct 29 20:04:27.683972 kernel: audit: type=2000 audit(0.037:1): state=initialized audit_enabled=0 res=1 Oct 29 20:04:27.683978 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 29 20:04:27.683985 kernel: cpuidle: using governor menu Oct 29 20:04:27.683991 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 29 20:04:27.684013 kernel: ASID allocator initialised with 32768 entries Oct 29 20:04:27.684020 kernel: ACPI: bus type PCI registered Oct 29 20:04:27.684031 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 29 20:04:27.684040 kernel: Serial: AMBA PL011 UART driver Oct 29 20:04:27.684047 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 29 20:04:27.684054 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 29 20:04:27.684060 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 29 20:04:27.684066 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 29 20:04:27.684072 kernel: cryptd: max_cpu_qlen set to 1000 Oct 29 20:04:27.684080 kernel: ACPI: Added _OSI(Module Device) Oct 29 20:04:27.684090 kernel: ACPI: Added _OSI(Processor Device) Oct 29 20:04:27.684097 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 29 20:04:27.684106 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 29 20:04:27.684113 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 29 20:04:27.684119 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 29 20:04:27.684125 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 29 20:04:27.684131 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 29 20:04:27.684137 kernel: ACPI: Interpreter enabled Oct 29 20:04:27.684142 kernel: ACPI: Using GIC for interrupt routing Oct 29 20:04:27.684148 kernel: ACPI: MCFG table detected, 1 entries Oct 29 20:04:27.684155 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 29 20:04:27.684161 kernel: printk: console [ttyAMA0] enabled Oct 29 20:04:27.684168 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 29 20:04:27.684278 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 29 20:04:27.684336 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 29 20:04:27.684388 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 29 20:04:27.684440 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 29 20:04:27.684491 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 29 20:04:27.684513 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 29 20:04:27.684522 kernel: PCI host bridge to bus 0000:00 Oct 29 20:04:27.684587 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 29 20:04:27.684637 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 29 20:04:27.684685 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 29 20:04:27.684733 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 29 20:04:27.684799 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 29 20:04:27.684860 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 29 20:04:27.684917 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 29 20:04:27.684972 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 29 20:04:27.685027 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 29 20:04:27.685082 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 29 20:04:27.685136 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 29 20:04:27.685190 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 29 20:04:27.685238 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 29 20:04:27.685287 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 29 20:04:27.685337 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 29 20:04:27.685345 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 29 20:04:27.685351 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 29 20:04:27.685357 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 29 20:04:27.685363 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 29 20:04:27.685369 kernel: vgaarb: loaded Oct 29 20:04:27.685375 kernel: Registered efivars operations Oct 29 20:04:27.685381 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 29 20:04:27.685388 kernel: VFS: Disk quotas dquot_6.6.0 Oct 29 20:04:27.685395 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 29 20:04:27.685401 kernel: pnp: PnP ACPI init Oct 29 20:04:27.685469 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 29 20:04:27.685594 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 29 20:04:27.685605 kernel: pnp: PnP ACPI: found 1 devices Oct 29 20:04:27.685611 kernel: NET: Registered protocol family 2 Oct 29 20:04:27.685618 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 29 20:04:27.685627 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 29 20:04:27.685634 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 29 20:04:27.685640 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 29 20:04:27.685646 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 29 20:04:27.685652 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 29 20:04:27.685658 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 29 20:04:27.685665 kernel: NET: Registered protocol family 1 Oct 29 20:04:27.685671 kernel: PCI: CLS 0 bytes, default 64 Oct 29 20:04:27.685677 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 29 20:04:27.685684 kernel: kvm [1]: HYP mode not available Oct 29 20:04:27.685690 kernel: Initialise system trusted keyrings Oct 29 20:04:27.685696 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 29 20:04:27.685702 kernel: Key type asymmetric registered Oct 29 20:04:27.685708 kernel: Asymmetric key parser 'x509' registered Oct 29 20:04:27.685714 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 29 20:04:27.685720 kernel: io scheduler mq-deadline registered Oct 29 20:04:27.685726 kernel: io scheduler kyber registered Oct 29 20:04:27.685732 kernel: io scheduler bfq registered Oct 29 20:04:27.685739 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 29 20:04:27.685745 kernel: ACPI: Power Button [PWRB] Oct 29 20:04:27.685751 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 29 20:04:27.685809 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 29 20:04:27.685817 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 29 20:04:27.685823 kernel: msm_serial: driver initialized Oct 29 20:04:27.685829 kernel: random: fast init done Oct 29 20:04:27.685835 kernel: random: crng init done Oct 29 20:04:27.685841 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 29 20:04:27.685847 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 29 20:04:27.685855 kernel: thunder_xcv, ver 1.0 Oct 29 20:04:27.685861 kernel: thunder_bgx, ver 1.0 Oct 29 20:04:27.685867 kernel: nicpf, ver 1.0 Oct 29 20:04:27.685873 kernel: nicvf, ver 1.0 Oct 29 20:04:27.685934 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 29 20:04:27.685985 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-29T20:04:27 UTC (1761768267) Oct 29 20:04:27.685993 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 29 20:04:27.685999 kernel: NET: Registered protocol family 10 Oct 29 20:04:27.686007 kernel: Segment Routing with IPv6 Oct 29 20:04:27.686013 kernel: NET: Registered protocol family 17 Oct 29 20:04:27.686019 kernel: Key type dns_resolver registered Oct 29 20:04:27.686025 kernel: registered taskstats version 1 Oct 29 20:04:27.686031 kernel: Loading compiled-in X.509 certificates Oct 29 20:04:27.686038 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 29 20:04:27.686044 kernel: Key type ._fscrypt registered Oct 29 20:04:27.686050 kernel: Key type .fscrypt registered Oct 29 20:04:27.686056 kernel: Key type fscrypt-provisioning registered Oct 29 20:04:27.686063 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 29 20:04:27.686069 kernel: ima: Allocated hash algorithm: sha1 Oct 29 20:04:27.686075 kernel: ima: No architecture policies found Oct 29 20:04:27.686081 kernel: Freeing unused kernel memory: 34240K Oct 29 20:04:27.686087 kernel: Run /init as init process Oct 29 20:04:27.686093 kernel: with arguments: Oct 29 20:04:27.686099 kernel: /init Oct 29 20:04:27.686105 kernel: with environment: Oct 29 20:04:27.686110 kernel: HOME=/ Oct 29 20:04:27.686116 kernel: TERM=linux Oct 29 20:04:27.686123 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 29 20:04:27.686131 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:04:27.686139 systemd[1]: Detected virtualization kvm. Oct 29 20:04:27.686146 systemd[1]: Detected architecture arm64. Oct 29 20:04:27.686152 systemd[1]: Running in initial RAM disk. Oct 29 20:04:27.686158 systemd[1]: No hostname configured, using default hostname. Oct 29 20:04:27.686164 systemd[1]: Hostname set to . Oct 29 20:04:27.686172 systemd[1]: Initializing machine ID from VM UUID. Oct 29 20:04:27.686179 systemd[1]: Queued start job for default target Initrd Default Target. Oct 29 20:04:27.686185 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 29 20:04:27.686192 systemd[1]: Reached target Local Encrypted Volumes. Oct 29 20:04:27.686198 systemd[1]: Reached target Path Units. Oct 29 20:04:27.686204 systemd[1]: Reached target Slice Units. Oct 29 20:04:27.686211 systemd[1]: Reached target Swaps. Oct 29 20:04:27.686217 systemd[1]: Reached target Timer Units. Oct 29 20:04:27.686225 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 29 20:04:27.686231 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 29 20:04:27.686238 systemd[1]: Listening on Journal Audit Socket. Oct 29 20:04:27.686244 systemd[1]: Listening on Journal Socket (/dev/log). Oct 29 20:04:27.686251 systemd[1]: Listening on Journal Socket. Oct 29 20:04:27.686257 systemd[1]: Listening on udev Control Socket. Oct 29 20:04:27.686263 systemd[1]: Listening on udev Kernel Socket. Oct 29 20:04:27.686270 systemd[1]: Reached target Socket Units. Oct 29 20:04:27.686276 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 29 20:04:27.686284 systemd[1]: Starting Create List of Static Device Nodes... Oct 29 20:04:27.686290 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 29 20:04:27.686297 systemd[1]: Starting Journal Service... Oct 29 20:04:27.686303 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 29 20:04:27.686310 systemd[1]: Starting Apply Kernel Variables... Oct 29 20:04:27.686316 systemd[1]: Starting Setup Virtual Console... Oct 29 20:04:27.686322 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 29 20:04:27.686328 kernel: SCSI subsystem initialized Oct 29 20:04:27.686334 kernel: Loading iSCSI transport class v2.0-870. Oct 29 20:04:27.686340 systemd[1]: Finished Create List of Static Device Nodes. Oct 29 20:04:27.686348 systemd[1]: Finished Apply Kernel Variables. Oct 29 20:04:27.686357 systemd-journald[270]: Journal started Oct 29 20:04:27.686394 systemd-journald[270]: Runtime Journal (/run/log/journal/a7820ab79e50450a9913c8d57cfc46ba) is 6.0M, max 48.5M, 42.4M free. Oct 29 20:04:27.687539 systemd[1]: Started Journal Service. Oct 29 20:04:27.688450 systemd[1]: Finished Setup Virtual Console. Oct 29 20:04:27.689879 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 29 20:04:27.691264 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 29 20:04:27.694417 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 29 20:04:27.705431 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 29 20:04:27.707071 systemd[1]: Starting dracut cmdline hook... Oct 29 20:04:27.715563 dracut-cmdline[290]: dracut-dracut-053 Oct 29 20:04:27.717794 dracut-cmdline[290]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Oct 29 20:04:27.773546 kernel: iscsi: registered transport (tcp) Oct 29 20:04:27.784536 kernel: iscsi: registered transport (qla4xxx) Oct 29 20:04:27.784551 kernel: QLogic iSCSI HBA Driver Oct 29 20:04:27.794350 systemd[1]: Finished dracut cmdline hook. Oct 29 20:04:27.795889 systemd[1]: Starting dracut pre-udev hook... Oct 29 20:04:27.797062 systemd[1]: Starting Open-iSCSI... Oct 29 20:04:27.799345 iscsid[375]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 29 20:04:27.799345 iscsid[375]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Oct 29 20:04:27.799345 iscsid[375]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 29 20:04:27.799345 iscsid[375]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 29 20:04:27.799345 iscsid[375]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 29 20:04:27.799345 iscsid[375]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 29 20:04:27.802867 systemd[1]: Started Open-iSCSI. Oct 29 20:04:27.812343 kernel: device-mapper: uevent: version 1.0.3 Oct 29 20:04:27.812360 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 29 20:04:27.846533 kernel: raid6: neonx8 gen() 13757 MB/s Oct 29 20:04:27.863526 kernel: raid6: neonx8 xor() 10727 MB/s Oct 29 20:04:27.880525 kernel: raid6: neonx4 gen() 13589 MB/s Oct 29 20:04:27.897528 kernel: raid6: neonx4 xor() 11525 MB/s Oct 29 20:04:27.914525 kernel: raid6: neonx2 gen() 12982 MB/s Oct 29 20:04:27.931526 kernel: raid6: neonx2 xor() 9847 MB/s Oct 29 20:04:27.948524 kernel: raid6: neonx1 gen() 10879 MB/s Oct 29 20:04:27.965525 kernel: raid6: neonx1 xor() 8812 MB/s Oct 29 20:04:27.982530 kernel: raid6: int64x8 gen() 6820 MB/s Oct 29 20:04:27.999520 kernel: raid6: int64x8 xor() 3792 MB/s Oct 29 20:04:28.016527 kernel: raid6: int64x4 gen() 6900 MB/s Oct 29 20:04:28.033522 kernel: raid6: int64x4 xor() 3827 MB/s Oct 29 20:04:28.050525 kernel: raid6: int64x2 gen() 6175 MB/s Oct 29 20:04:28.067523 kernel: raid6: int64x2 xor() 3303 MB/s Oct 29 20:04:28.084538 kernel: raid6: int64x1 gen() 5006 MB/s Oct 29 20:04:28.101574 kernel: raid6: int64x1 xor() 2594 MB/s Oct 29 20:04:28.101594 kernel: raid6: using algorithm neonx8 gen() 13757 MB/s Oct 29 20:04:28.101610 kernel: raid6: .... xor() 10727 MB/s, rmw enabled Oct 29 20:04:28.102608 kernel: raid6: using neon recovery algorithm Oct 29 20:04:28.113022 kernel: xor: measuring software checksum speed Oct 29 20:04:28.113035 kernel: 8regs : 17145 MB/sec Oct 29 20:04:28.114020 kernel: 32regs : 20765 MB/sec Oct 29 20:04:28.114875 kernel: arm64_neon : 28180 MB/sec Oct 29 20:04:28.114889 kernel: xor: using function: arm64_neon (28180 MB/sec) Oct 29 20:04:28.160695 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 29 20:04:28.170021 systemd[1]: Finished dracut pre-udev hook. Oct 29 20:04:28.173650 kernel: audit: type=1334 audit(1761768268.170:2): prog-id=6 op=LOAD Oct 29 20:04:28.173668 kernel: audit: type=1334 audit(1761768268.171:3): prog-id=7 op=LOAD Oct 29 20:04:28.173677 kernel: audit: type=1334 audit(1761768268.172:4): prog-id=8 op=LOAD Oct 29 20:04:28.170000 audit: BPF prog-id=6 op=LOAD Oct 29 20:04:28.171000 audit: BPF prog-id=7 op=LOAD Oct 29 20:04:28.172000 audit: BPF prog-id=8 op=LOAD Oct 29 20:04:28.173223 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 29 20:04:28.185044 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 29 20:04:28.186967 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 29 20:04:28.188638 systemd[1]: Starting dracut pre-trigger hook... Oct 29 20:04:28.200609 dracut-pre-trigger[415]: rd.md=0: removing MD RAID activation Oct 29 20:04:28.222678 systemd[1]: Finished dracut pre-trigger hook. Oct 29 20:04:28.224051 systemd[1]: Starting Coldplug All udev Devices... Oct 29 20:04:28.233707 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 29 20:04:28.259151 systemd[1]: Finished Coldplug All udev Devices. Oct 29 20:04:28.260749 systemd[1]: Starting dracut initqueue hook... Oct 29 20:04:28.271260 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 29 20:04:28.271373 kernel: vda: detected capacity change from 0 to 4756340736 Oct 29 20:04:28.283528 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 20:04:28.288833 systemd-udevd[453]: Using default interface naming scheme 'v249'. Oct 29 20:04:28.303528 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (454) Oct 29 20:04:28.303829 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 29 20:04:28.312650 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 29 20:04:28.313704 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 29 20:04:28.315444 systemd[1]: Reached target Initrd Root Device. Oct 29 20:04:28.317567 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 29 20:04:28.321410 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 29 20:04:28.321556 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 29 20:04:28.323288 systemd[1]: Reached target Preparation for Local File Systems. Oct 29 20:04:28.325592 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 29 20:04:28.328558 systemd[1]: Finished dracut initqueue hook. Oct 29 20:04:28.329632 systemd[1]: Reached target Preparation for Remote File Systems. Oct 29 20:04:28.331205 systemd[1]: Reached target Remote Encrypted Volumes. Oct 29 20:04:28.332215 systemd[1]: Reached target Remote File Systems. Oct 29 20:04:28.335124 systemd[1]: Starting dracut pre-mount hook... Oct 29 20:04:28.339541 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 29 20:04:28.343407 systemd[1]: Finished dracut pre-mount hook. Oct 29 20:04:28.345163 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 29 20:04:28.354061 systemd-fsck[504]: ROOT: clean, 640/553792 files, 39961/553472 blocks Oct 29 20:04:28.357814 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 29 20:04:28.359638 systemd[1]: Mounting /sysroot... Oct 29 20:04:28.370752 systemd[1]: Found device /dev/mapper/usr. Oct 29 20:04:28.372094 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 29 20:04:28.374755 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 29 20:04:28.382581 systemd-fsck[517]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 29 20:04:28.382581 systemd-fsck[517]: You must have r/w access to the filesystem or be root Oct 29 20:04:28.385523 systemd-fsck[514]: fsck failed with exit status 8. Oct 29 20:04:28.385548 systemd-fsck[514]: Ignoring error. Oct 29 20:04:28.386220 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 29 20:04:28.388154 systemd[1]: Mounting /sysusr/usr... Oct 29 20:04:28.406452 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 29 20:04:28.406499 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 29 20:04:28.406911 systemd[1]: Mounted /sysroot. Oct 29 20:04:28.407645 systemd[1]: Reached target Initrd Root File System. Oct 29 20:04:28.409403 systemd[1]: Starting Reload Configuration from the Real Root... Oct 29 20:04:28.413653 systemd[1]: Reloading. Oct 29 20:04:28.416520 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 29 20:04:28.419000 audit: BPF prog-id=3 op=UNLOAD Oct 29 20:04:28.420000 audit: BPF prog-id=6 op=UNLOAD Oct 29 20:04:28.421970 kernel: audit: type=1334 audit(1761768268.419:5): prog-id=3 op=UNLOAD Oct 29 20:04:28.421985 kernel: audit: type=1334 audit(1761768268.420:6): prog-id=6 op=UNLOAD Oct 29 20:04:28.494000 audit: BPF prog-id=9 op=LOAD Oct 29 20:04:28.495000 audit: BPF prog-id=10 op=LOAD Oct 29 20:04:28.496515 kernel: audit: type=1334 audit(1761768268.494:7): prog-id=9 op=LOAD Oct 29 20:04:28.496536 kernel: audit: type=1334 audit(1761768268.495:8): prog-id=10 op=LOAD Oct 29 20:04:28.496545 kernel: audit: type=1334 audit(1761768268.495:9): prog-id=11 op=LOAD Oct 29 20:04:28.495000 audit: BPF prog-id=11 op=LOAD Oct 29 20:04:28.496000 audit: BPF prog-id=4 op=UNLOAD Oct 29 20:04:28.498215 kernel: audit: type=1334 audit(1761768268.496:10): prog-id=4 op=UNLOAD Oct 29 20:04:28.496000 audit: BPF prog-id=5 op=UNLOAD Oct 29 20:04:28.496000 audit: BPF prog-id=12 op=LOAD Oct 29 20:04:28.498000 audit: BPF prog-id=13 op=LOAD Oct 29 20:04:28.498000 audit: BPF prog-id=14 op=LOAD Oct 29 20:04:28.498000 audit: BPF prog-id=7 op=UNLOAD Oct 29 20:04:28.498000 audit: BPF prog-id=8 op=UNLOAD Oct 29 20:04:28.502402 systemd[1]: Mounted /sysusr/usr. Oct 29 20:04:28.504353 systemd[1]: Reached target Local File Systems. Oct 29 20:04:28.505254 systemd[1]: Reached target System Initialization. Oct 29 20:04:28.506739 systemd[1]: Reached target Basic System. Oct 29 20:04:28.509423 systemd[1]: Mounting /sysroot/usr... Oct 29 20:04:28.511847 systemd[1]: Mounted /sysroot/usr. Oct 29 20:04:28.520334 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 29 20:04:28.520446 systemd[1]: Finished Reload Configuration from the Real Root. Oct 29 20:04:28.522395 systemd[1]: Reached target Initrd File Systems. Oct 29 20:04:28.523942 systemd[1]: Reached target Initrd Default Target. Oct 29 20:04:28.525407 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 29 20:04:28.526107 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 29 20:04:28.535844 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 29 20:04:28.537368 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 29 20:04:28.542848 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 29 20:04:28.543842 systemd[1]: Stopped target Timer Units. Oct 29 20:04:28.545236 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 29 20:04:28.545341 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 29 20:04:28.546728 systemd[1]: Stopped target Initrd Default Target. Oct 29 20:04:28.548412 systemd[1]: Stopped target Basic System. Oct 29 20:04:28.549916 systemd[1]: Stopped target Initrd Root Device. Oct 29 20:04:28.551351 systemd[1]: Stopped target Path Units. Oct 29 20:04:28.552632 systemd[1]: Stopped target Remote File Systems. Oct 29 20:04:28.554084 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 29 20:04:28.555603 systemd[1]: Stopped target Slice Units. Oct 29 20:04:28.556993 systemd[1]: Stopped target Socket Units. Oct 29 20:04:28.558531 systemd[1]: Stopped target System Initialization. Oct 29 20:04:28.559913 systemd[1]: Stopped target Local File Systems. Oct 29 20:04:28.561284 systemd[1]: Stopped target Preparation for Local File Systems. Oct 29 20:04:28.562965 systemd[1]: Stopped target Swaps. Oct 29 20:04:28.564199 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 29 20:04:28.564296 systemd[1]: Stopped dracut pre-mount hook. Oct 29 20:04:28.565916 systemd[1]: Stopped target Local Encrypted Volumes. Oct 29 20:04:28.567271 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 29 20:04:28.571560 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 29 20:04:28.572672 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 29 20:04:28.572765 systemd[1]: Stopped dracut initqueue hook. Oct 29 20:04:28.576006 iscsid[375]: iscsid shutting down. Oct 29 20:04:28.576009 systemd[1]: Stopping Open-iSCSI... Oct 29 20:04:28.577207 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 29 20:04:28.577319 systemd[1]: Stopped Apply Kernel Variables. Oct 29 20:04:28.578675 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 29 20:04:28.578765 systemd[1]: Stopped Coldplug All udev Devices. Oct 29 20:04:28.580279 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 29 20:04:28.580366 systemd[1]: Stopped dracut pre-trigger hook. Oct 29 20:04:28.581723 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 29 20:04:28.586034 systemd[1]: iscsid.service: Deactivated successfully. Oct 29 20:04:28.586145 systemd[1]: Stopped Open-iSCSI. Oct 29 20:04:28.587632 systemd[1]: iscsid.socket: Deactivated successfully. Oct 29 20:04:28.587677 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 29 20:04:28.589262 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 29 20:04:28.591550 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 29 20:04:28.591661 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 29 20:04:28.593029 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 29 20:04:28.593159 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 29 20:04:28.602000 audit: BPF prog-id=12 op=UNLOAD Oct 29 20:04:28.594706 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 29 20:04:28.594805 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 29 20:04:28.596810 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 29 20:04:28.596860 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 29 20:04:28.598403 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 29 20:04:28.598440 systemd[1]: Closed udev Control Socket. Oct 29 20:04:28.599910 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 29 20:04:28.599940 systemd[1]: Closed udev Kernel Socket. Oct 29 20:04:28.601209 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 29 20:04:28.601246 systemd[1]: Stopped dracut pre-udev hook. Oct 29 20:04:28.603033 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 29 20:04:28.603070 systemd[1]: Stopped dracut cmdline hook. Oct 29 20:04:28.604615 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 29 20:04:28.604653 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 29 20:04:28.607066 systemd[1]: Starting Cleanup udev Database... Oct 29 20:04:28.608039 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 29 20:04:28.609355 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 29 20:04:28.625000 audit: BPF prog-id=9 op=UNLOAD Oct 29 20:04:28.609405 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 29 20:04:28.610927 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 29 20:04:28.610969 systemd[1]: Stopped Create List of Static Device Nodes. Oct 29 20:04:28.612640 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 20:04:28.612678 systemd[1]: Stopped Setup Virtual Console. Oct 29 20:04:28.614146 systemd[1]: rngd.service: Deactivated successfully. Oct 29 20:04:28.614253 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 29 20:04:28.615765 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 29 20:04:28.615872 systemd[1]: Finished Cleanup udev Database. Oct 29 20:04:28.616997 systemd[1]: Reached target Switch Root. Oct 29 20:04:28.618975 systemd[1]: Starting Switch Root... Oct 29 20:04:28.624481 systemd[1]: Switching root. Oct 29 20:04:28.636528 systemd-journald[270]: Journal stopped Oct 29 20:04:30.694101 systemd-journald[270]: Received SIGTERM from PID 1 (n/a). Oct 29 20:04:30.694146 kernel: SELinux: policy capability network_peer_controls=1 Oct 29 20:04:30.694157 kernel: SELinux: policy capability open_perms=1 Oct 29 20:04:30.694166 kernel: SELinux: policy capability extended_socket_class=1 Oct 29 20:04:30.694178 kernel: SELinux: policy capability always_check_network=0 Oct 29 20:04:30.694187 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 29 20:04:30.694196 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 29 20:04:30.694205 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 29 20:04:30.694215 systemd[1]: Successfully loaded SELinux policy in 30.718ms. Oct 29 20:04:30.694233 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 5.967ms. Oct 29 20:04:30.694244 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:04:30.694254 systemd[1]: Detected virtualization kvm. Oct 29 20:04:30.694265 systemd[1]: Detected architecture arm64. Oct 29 20:04:30.694276 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:04:30.694287 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:04:30.694297 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 29 20:04:30.694307 systemd[1]: Stopped Switch Root. Oct 29 20:04:30.694316 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 29 20:04:30.694326 systemd[1]: Created slice Slice /system/addon-config. Oct 29 20:04:30.694337 systemd[1]: Created slice Slice /system/addon-run. Oct 29 20:04:30.694346 systemd[1]: Created slice Slice /system/getty. Oct 29 20:04:30.694356 systemd[1]: Created slice Slice /system/modprobe. Oct 29 20:04:30.694367 systemd[1]: Created slice Slice /system/serial-getty. Oct 29 20:04:30.694376 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 29 20:04:30.694386 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 29 20:04:30.694395 systemd[1]: Created slice User and Session Slice. Oct 29 20:04:30.694405 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 29 20:04:30.694415 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 29 20:04:30.694426 systemd[1]: Set up automount Boot partition Automount Point. Oct 29 20:04:30.694436 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 29 20:04:30.694446 systemd[1]: Stopped target Switch Root. Oct 29 20:04:30.694455 systemd[1]: Stopped target Initrd File Systems. Oct 29 20:04:30.694465 systemd[1]: Stopped target Initrd Root File System. Oct 29 20:04:30.694486 systemd[1]: Reached target Remote Encrypted Volumes. Oct 29 20:04:30.694498 systemd[1]: Reached target Remote File Systems. Oct 29 20:04:30.694518 systemd[1]: Reached target Slice Units. Oct 29 20:04:30.694528 systemd[1]: Reached target Swaps. Oct 29 20:04:30.694538 systemd[1]: Reached target Verify torcx succeeded. Oct 29 20:04:30.694549 systemd[1]: Reached target Local Verity Protected Volumes. Oct 29 20:04:30.694558 systemd[1]: Listening on Process Core Dump Socket. Oct 29 20:04:30.694568 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 29 20:04:30.694578 systemd[1]: Listening on Network Service Netlink Socket. Oct 29 20:04:30.694588 systemd[1]: Listening on udev Control Socket. Oct 29 20:04:30.694598 systemd[1]: Listening on udev Kernel Socket. Oct 29 20:04:30.694608 systemd[1]: Mounting Huge Pages File System... Oct 29 20:04:30.694617 systemd[1]: Mounting POSIX Message Queue File System... Oct 29 20:04:30.694627 systemd[1]: Mounting External Media Directory... Oct 29 20:04:30.694638 systemd[1]: Mounting Kernel Debug File System... Oct 29 20:04:30.694648 systemd[1]: Mounting Kernel Trace File System... Oct 29 20:04:30.694658 systemd[1]: Mounting Temporary Directory /tmp... Oct 29 20:04:30.694667 systemd[1]: Starting Create missing system files... Oct 29 20:04:30.694677 systemd[1]: Starting Create List of Static Device Nodes... Oct 29 20:04:30.694686 systemd[1]: Starting Load Kernel Module configfs... Oct 29 20:04:30.694696 systemd[1]: Starting Load Kernel Module drm... Oct 29 20:04:30.694705 systemd[1]: Starting Load Kernel Module fuse... Oct 29 20:04:30.694715 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 29 20:04:30.694725 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 29 20:04:30.694735 systemd[1]: Stopped File System Check on Root Device. Oct 29 20:04:30.694745 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 29 20:04:30.694755 systemd[1]: Stopped systemd-fsck-usr.service. Oct 29 20:04:30.694764 kernel: fuse: init (API version 7.32) Oct 29 20:04:30.694773 systemd[1]: Stopped Journal Service. Oct 29 20:04:30.694782 systemd[1]: Starting Journal Service... Oct 29 20:04:30.694792 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 29 20:04:30.694803 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 29 20:04:30.694812 systemd[1]: Starting Apply Kernel Variables... Oct 29 20:04:30.694823 systemd[1]: Starting Coldplug All udev Devices... Oct 29 20:04:30.694832 systemd[1]: verity-setup.service: Deactivated successfully. Oct 29 20:04:30.694842 systemd[1]: Stopped verity-setup.service. Oct 29 20:04:30.694852 systemd[1]: Mounted Huge Pages File System. Oct 29 20:04:30.694861 systemd[1]: Mounted POSIX Message Queue File System. Oct 29 20:04:30.694871 systemd[1]: Mounted External Media Directory. Oct 29 20:04:30.694880 systemd[1]: Mounted Kernel Debug File System. Oct 29 20:04:30.694890 systemd[1]: Mounted Kernel Trace File System. Oct 29 20:04:30.694900 systemd[1]: Mounted Temporary Directory /tmp. Oct 29 20:04:30.694909 systemd[1]: Finished Create missing system files. Oct 29 20:04:30.694920 systemd[1]: Finished Create List of Static Device Nodes. Oct 29 20:04:30.694931 systemd-journald[695]: Journal started Oct 29 20:04:30.694966 systemd-journald[695]: Runtime Journal (/run/log/journal/a7820ab79e50450a9913c8d57cfc46ba) is 6.0M, max 48.5M, 42.4M free. Oct 29 20:04:28.702000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 29 20:04:28.727000 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:04:28.727000 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:04:28.728000 audit: BPF prog-id=15 op=LOAD Oct 29 20:04:28.728000 audit: BPF prog-id=15 op=UNLOAD Oct 29 20:04:28.728000 audit: BPF prog-id=16 op=LOAD Oct 29 20:04:28.728000 audit: BPF prog-id=16 op=UNLOAD Oct 29 20:04:28.763000 audit[647]: AVC avc: denied { associate } for pid=647 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:04:30.546000 audit: BPF prog-id=17 op=LOAD Oct 29 20:04:30.546000 audit: BPF prog-id=18 op=LOAD Oct 29 20:04:30.547000 audit: BPF prog-id=19 op=LOAD Oct 29 20:04:30.547000 audit: BPF prog-id=10 op=UNLOAD Oct 29 20:04:30.547000 audit: BPF prog-id=11 op=UNLOAD Oct 29 20:04:30.557000 audit: BPF prog-id=20 op=LOAD Oct 29 20:04:30.557000 audit: BPF prog-id=17 op=UNLOAD Oct 29 20:04:30.557000 audit: BPF prog-id=21 op=LOAD Oct 29 20:04:30.557000 audit: BPF prog-id=22 op=LOAD Oct 29 20:04:30.557000 audit: BPF prog-id=18 op=UNLOAD Oct 29 20:04:30.557000 audit: BPF prog-id=19 op=UNLOAD Oct 29 20:04:30.573000 audit: BPF prog-id=20 op=UNLOAD Oct 29 20:04:30.666000 audit: BPF prog-id=23 op=LOAD Oct 29 20:04:30.666000 audit: BPF prog-id=24 op=LOAD Oct 29 20:04:30.666000 audit: BPF prog-id=25 op=LOAD Oct 29 20:04:30.666000 audit: BPF prog-id=21 op=UNLOAD Oct 29 20:04:30.666000 audit: BPF prog-id=22 op=UNLOAD Oct 29 20:04:30.692000 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:04:30.546661 systemd[1]: Queued start job for default target Multi-User System. Oct 29 20:04:28.762621 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" 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:04:30.558328 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 29 20:04:28.762855 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 29 20:04:28.762873 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 29 20:04:28.763122 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 29 20:04:28.763133 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 29 20:04:28.763163 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 29 20:04:28.763175 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 29 20:04:28.763448 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 29 20:04:28.763481 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 29 20:04:28.763514 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 29 20:04:28.763868 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" 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:04:28.763898 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" 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:04:28.763917 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" 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:04:28.763933 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" 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:04:28.764037 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" 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:04:28.764052 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:28Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 29 20:04:30.460429 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:30Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 29 20:04:30.460731 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:30Z" 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:04:30.460837 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:30Z" 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:04:30.460957 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:30Z" 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:04:30.461051 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:30Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 29 20:04:30.461107 /usr/lib/systemd/system-generators/torcx-generator[647]: time="2025-10-29T20:04:30Z" 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:04:30.696884 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 29 20:04:30.696902 systemd[1]: Finished Load Kernel Module configfs. Oct 29 20:04:30.698876 systemd[1]: Started Journal Service. Oct 29 20:04:30.699380 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 29 20:04:30.699575 systemd[1]: Finished Load Kernel Module drm. Oct 29 20:04:30.700465 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 29 20:04:30.708765 systemd[1]: Finished Load Kernel Module fuse. Oct 29 20:04:30.709817 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 29 20:04:30.710967 systemd[1]: Finished Apply Kernel Variables. Oct 29 20:04:30.713592 systemd[1]: Mounting FUSE Control File System... Oct 29 20:04:30.715188 systemd[1]: Mounting Kernel Configuration File System... Oct 29 20:04:30.716042 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 29 20:04:30.716940 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 29 20:04:30.718673 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 29 20:04:30.719800 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 29 20:04:30.722660 systemd-journald[695]: Time spent on flushing to /var/log/journal/a7820ab79e50450a9913c8d57cfc46ba is 18.055ms for 659 entries. Oct 29 20:04:30.722660 systemd-journald[695]: System Journal (/var/log/journal/a7820ab79e50450a9913c8d57cfc46ba) is 8.0M, max 203.0M, 195.0M free. Oct 29 20:04:30.723600 systemd[1]: Starting Load/Save Random Seed... Oct 29 20:04:30.725543 systemd[1]: Condition check resulted in Create System Users being skipped. Oct 29 20:04:30.726400 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 29 20:04:30.728721 systemd[1]: Mounted FUSE Control File System. Oct 29 20:04:30.729749 systemd[1]: Mounted Kernel Configuration File System. Oct 29 20:04:30.733945 systemd[1]: Finished Coldplug All udev Devices. Oct 29 20:04:30.742311 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 29 20:04:30.743799 systemd[1]: Finished Load/Save Random Seed. Oct 29 20:04:30.744801 systemd[1]: Condition check resulted in First Boot Complete being skipped. Oct 29 20:04:30.754663 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 29 20:04:30.756301 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 29 20:04:30.757000 audit: BPF prog-id=26 op=LOAD Oct 29 20:04:30.757000 audit: BPF prog-id=27 op=LOAD Oct 29 20:04:30.757000 audit: BPF prog-id=28 op=LOAD Oct 29 20:04:30.757000 audit: BPF prog-id=13 op=UNLOAD Oct 29 20:04:30.757000 audit: BPF prog-id=14 op=UNLOAD Oct 29 20:04:30.758632 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 29 20:04:30.781163 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 29 20:04:30.782000 audit: BPF prog-id=29 op=LOAD Oct 29 20:04:30.783783 systemd[1]: Starting Network Configuration... Oct 29 20:04:30.812564 systemd-networkd[716]: lo: Link UP Oct 29 20:04:30.812782 systemd-networkd[716]: lo: Gained carrier Oct 29 20:04:30.813164 systemd-networkd[716]: Enumeration completed Oct 29 20:04:30.813318 systemd[1]: Started Network Configuration. Oct 29 20:04:30.815221 systemd-udevd[718]: Using default interface naming scheme 'v249'. Oct 29 20:04:30.839975 udevadm[706]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 29 20:04:30.853641 systemd-networkd[716]: eth0: Link UP Oct 29 20:04:30.864591 systemd-networkd[716]: eth0: Gained carrier Oct 29 20:04:30.878622 systemd-networkd[716]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Oct 29 20:04:30.886738 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 29 20:04:30.897455 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 29 20:04:30.905175 lvm[735]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 29 20:04:30.928467 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 29 20:04:30.929422 systemd[1]: Reached target Local Encrypted Volumes. Oct 29 20:04:30.943318 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 29 20:04:30.946351 lvm[736]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 29 20:04:30.975409 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 29 20:04:30.976415 systemd[1]: Reached target Preparation for Local File Systems. Oct 29 20:04:30.977436 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 29 20:04:30.977458 systemd[1]: Reached target Containers. Oct 29 20:04:30.988787 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 29 20:04:31.000444 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 29 20:04:31.002465 systemd[1]: Mounting /usr/share/oem... Oct 29 20:04:31.008557 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 29 20:04:31.008618 kernel: BTRFS info (device vda6): has skinny extents Oct 29 20:04:31.010786 systemd[1]: Mounted /usr/share/oem. Oct 29 20:04:31.011535 systemd[1]: Reached target Local File Systems. Oct 29 20:04:31.012356 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Oct 29 20:04:31.012698 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 29 20:04:31.012732 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 29 20:04:31.012760 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 29 20:04:31.025318 systemd[1]: Starting Create Volatile Files and Directories... Oct 29 20:04:31.030906 systemd-tmpfiles[759]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 29 20:04:31.031917 systemd-tmpfiles[759]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 29 20:04:31.060342 systemd-tmpfiles[759]: Detected autofs mount point /boot during canonicalization of /boot. Oct 29 20:04:31.060353 systemd-tmpfiles[759]: Skipping /boot Oct 29 20:04:31.065735 systemd-tmpfiles[759]: Detected autofs mount point /boot during canonicalization of /boot. Oct 29 20:04:31.065752 systemd-tmpfiles[759]: Skipping /boot Oct 29 20:04:31.094205 systemd[1]: Finished Create Volatile Files and Directories. Oct 29 20:04:31.110403 systemd[1]: Starting Load Security Auditing Rules... Oct 29 20:04:31.112130 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 29 20:04:31.113176 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Oct 29 20:04:31.113000 audit: BPF prog-id=30 op=LOAD Oct 29 20:04:31.114686 systemd[1]: Starting Network Name Resolution... Oct 29 20:04:31.116000 audit: BPF prog-id=31 op=LOAD Oct 29 20:04:31.117273 systemd[1]: Starting Network Time Synchronization... Oct 29 20:04:31.118136 systemd[1]: Condition check resulted in Update is Completed being skipped. Oct 29 20:04:31.119104 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 29 20:04:31.120620 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 29 20:04:31.121763 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 29 20:04:31.125236 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 29 20:04:31.135699 augenrules[780]: No rules Oct 29 20:04:31.135000 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:04:31.136595 systemd[1]: Finished Load Security Auditing Rules. Oct 29 20:04:31.154416 systemd[1]: Started Network Time Synchronization. Oct 29 20:04:31.557228 systemd-timesyncd[769]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 29 20:04:31.557388 systemd[1]: Reached target System Initialization. Oct 29 20:04:31.558248 systemd[1]: Started Watch for update engine configuration changes. Oct 29 20:04:31.559390 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 29 20:04:31.560401 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 29 20:04:31.561359 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 29 20:04:31.561384 systemd[1]: Reached target Path Units. Oct 29 20:04:31.561402 systemd-resolved[763]: Positive Trust Anchors: Oct 29 20:04:31.561409 systemd-resolved[763]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 20:04:31.561436 systemd-resolved[763]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Oct 29 20:04:31.562098 systemd[1]: Reached target System Time Set. Oct 29 20:04:31.563099 systemd[1]: Started Daily Log Rotation. Oct 29 20:04:31.563985 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 29 20:04:31.564028 systemd-resolved[763]: Defaulting to hostname 'linux'. Oct 29 20:04:31.565052 systemd[1]: Reached target Timer Units. Oct 29 20:04:31.566144 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 29 20:04:31.580861 systemd[1]: Starting Docker Socket for the API... Oct 29 20:04:31.583816 systemd[1]: Listening on OpenSSH Server Socket. Oct 29 20:04:31.585004 systemd[1]: Started Network Name Resolution. Oct 29 20:04:31.585911 systemd[1]: Listening on Docker Socket for the API. Oct 29 20:04:31.586794 systemd[1]: Reached target Network. Oct 29 20:04:31.587474 systemd[1]: Reached target Host and Network Name Lookups. Oct 29 20:04:31.588328 systemd[1]: Reached target Socket Units. Oct 29 20:04:31.589005 systemd[1]: Reached target Basic System. Oct 29 20:04:31.589780 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 29 20:04:31.589810 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 29 20:04:31.590746 systemd[1]: Started D-Bus System Message Bus. Oct 29 20:04:31.594129 systemd[1]: Starting Extend Filesystems... Oct 29 20:04:31.594990 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 29 20:04:31.596058 systemd[1]: Starting Generate /run/flatcar/motd... Oct 29 20:04:31.598195 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 29 20:04:31.600356 systemd[1]: Starting Generate sshd host keys... Oct 29 20:04:31.601304 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 29 20:04:31.601340 systemd[1]: Reached target Load system-provided cloud configs. Oct 29 20:04:31.604109 systemd[1]: Starting User Login Management... Oct 29 20:04:31.605352 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 29 20:04:31.605968 systemd[1]: Starting Update Engine... Oct 29 20:04:31.607124 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 29 20:04:31.607157 systemd[1]: Reached target Load user-provided cloud configs. Oct 29 20:04:31.608851 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 29 20:04:31.610217 extend-filesystems[789]: Found vda Oct 29 20:04:31.610217 extend-filesystems[789]: Found vda1 Oct 29 20:04:31.610217 extend-filesystems[789]: Found vda2 Oct 29 20:04:31.610217 extend-filesystems[789]: Found vda3 Oct 29 20:04:31.610217 extend-filesystems[789]: Found usr Oct 29 20:04:31.610217 extend-filesystems[789]: Found vda4 Oct 29 20:04:31.610217 extend-filesystems[789]: Found vda6 Oct 29 20:04:31.610217 extend-filesystems[789]: Found vda7 Oct 29 20:04:31.609067 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 29 20:04:31.619809 extend-filesystems[789]: Found vda9 Oct 29 20:04:31.619809 extend-filesystems[789]: Checking size of /dev/vda9 Oct 29 20:04:31.614079 systemd[1]: motdgen.service: Deactivated successfully. Oct 29 20:04:31.614394 systemd[1]: Finished Generate /run/flatcar/motd. Oct 29 20:04:31.630899 extend-filesystems[789]: Old size kept for /dev/vda9 Oct 29 20:04:31.629963 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 29 20:04:31.630212 systemd[1]: Finished Extend Filesystems. Oct 29 20:04:31.640939 systemd-logind[799]: Watching system buttons on /dev/input/event0 (Power Button) Oct 29 20:04:31.641091 systemd-logind[799]: New seat seat0. Oct 29 20:04:31.645138 systemd[1]: Started User Login Management. Oct 29 20:04:31.653551 systemd[1]: Finished Generate sshd host keys. Oct 29 20:04:31.658340 systemd[1]: Starting Generate /run/issue... Oct 29 20:04:31.663605 systemd[1]: issuegen.service: Deactivated successfully. Oct 29 20:04:31.663806 systemd[1]: Finished Generate /run/issue. Oct 29 20:04:31.664655 update_engine[802]: I1029 20:04:31.663877 802 main.cc:89] Flatcar Update Engine starting Oct 29 20:04:31.665486 update_engine[802]: I1029 20:04:31.665470 802 payload_state.cc:360] Current Response Signature = Oct 29 20:04:31.665486 update_engine[802]: NumURLs = 1 Oct 29 20:04:31.665486 update_engine[802]: Url0 = http://10.0.0.5:34567/packages/update.gz Oct 29 20:04:31.665486 update_engine[802]: Payload Size = 439328019 Oct 29 20:04:31.665486 update_engine[802]: Payload Sha256 Hash = JprWN+czonR3c0MyWAyU2g4RVVt99zqV4E+IEkT3wn8= Oct 29 20:04:31.665486 update_engine[802]: Is Delta Payload = 0 Oct 29 20:04:31.665486 update_engine[802]: Max Failure Count Per Url = 10 Oct 29 20:04:31.665486 update_engine[802]: Disable Payload Backoff = 1 Oct 29 20:04:31.665944 systemd[1]: Starting Permit User Sessions... Oct 29 20:04:31.666065 update_engine[802]: I1029 20:04:31.665884 802 payload_state.cc:381] Payload Attempt Number = 0 Oct 29 20:04:31.666668 update_engine[802]: I1029 20:04:31.666652 802 payload_state.cc:404] Current URL Index = 0 Oct 29 20:04:31.666906 update_engine[802]: I1029 20:04:31.666893 802 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Oct 29 20:04:31.667160 update_engine[802]: I1029 20:04:31.667130 802 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Oct 29 20:04:31.668830 systemd[1]: Started Update Engine. Oct 29 20:04:31.669560 update_engine[802]: I1029 20:04:31.669536 802 update_check_scheduler.cc:74] Next update check in 2m37s Oct 29 20:04:31.670604 systemd[1]: Finished Permit User Sessions. Oct 29 20:04:31.672507 systemd[1]: Started Getty on tty1. Oct 29 20:04:31.674169 systemd[1]: Started Serial Getty on ttyAMA0. Oct 29 20:04:31.675135 systemd[1]: Reached target Login Prompts. Oct 29 20:04:31.676000 systemd[1]: Reached target Multi-User System. Oct 29 20:04:31.677830 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 29 20:04:31.682328 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 29 20:04:31.682529 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 29 20:04:31.683519 systemd[1]: Startup finished in 706ms (kernel) + 1.106s (initrd) + 2.611s (userspace) = 4.425s. Oct 29 20:04:33.114476 systemd-networkd[716]: eth0: Gained IPv6LL Oct 29 20:04:41.420235 systemd[1]: Created slice Slice /system/sshd. Oct 29 20:04:41.421247 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:48236). Oct 29 20:04:41.456921 sshd[829]: Accepted publickey for core from 10.0.0.1 port 48236 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:41.458971 sshd[829]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:41.472742 systemd[1]: Created slice User Slice of UID 500. Oct 29 20:04:41.473710 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 29 20:04:41.475332 systemd-logind[799]: New session 1 of user core. Oct 29 20:04:41.479583 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 29 20:04:41.480684 systemd[1]: Starting User Manager for UID 500... Oct 29 20:04:41.482753 systemd[832]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:41.527960 systemd[832]: Queued start job for default target Main User Target. Oct 29 20:04:41.528108 systemd[832]: Reached target Paths. Oct 29 20:04:41.528122 systemd[832]: Reached target Sockets. Oct 29 20:04:41.528133 systemd[832]: Reached target Timers. Oct 29 20:04:41.528153 systemd[832]: Reached target Basic System. Oct 29 20:04:41.528202 systemd[832]: Reached target Main User Target. Oct 29 20:04:41.528215 systemd[832]: Startup finished in 41ms. Oct 29 20:04:41.528358 systemd[1]: Started User Manager for UID 500. Oct 29 20:04:41.534417 systemd[1]: Started Session 1 of User core. Oct 29 20:04:41.591800 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:48246). Oct 29 20:04:41.624925 sshd[841]: Accepted publickey for core from 10.0.0.1 port 48246 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:41.625821 sshd[841]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:41.628469 systemd-logind[799]: New session 2 of user core. Oct 29 20:04:41.641405 systemd[1]: Started Session 2 of User core. Oct 29 20:04:41.693034 sshd[841]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:41.700676 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:48246.service: Deactivated successfully. Oct 29 20:04:41.701216 systemd[1]: session-2.scope: Deactivated successfully. Oct 29 20:04:41.701791 systemd-logind[799]: Session 2 logged out. Waiting for processes to exit. Oct 29 20:04:41.702678 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:48248). Oct 29 20:04:41.703217 systemd-logind[799]: Removed session 2. Oct 29 20:04:41.734336 sshd[847]: Accepted publickey for core from 10.0.0.1 port 48248 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:41.735213 sshd[847]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:41.737657 systemd-logind[799]: New session 3 of user core. Oct 29 20:04:41.752410 systemd[1]: Started Session 3 of User core. Oct 29 20:04:41.800188 sshd[847]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:41.813821 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:48248.service: Deactivated successfully. Oct 29 20:04:41.814380 systemd[1]: session-3.scope: Deactivated successfully. Oct 29 20:04:41.814969 systemd-logind[799]: Session 3 logged out. Waiting for processes to exit. Oct 29 20:04:41.815897 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:48256). Oct 29 20:04:41.816527 systemd-logind[799]: Removed session 3. Oct 29 20:04:41.847007 sshd[853]: Accepted publickey for core from 10.0.0.1 port 48256 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:41.848192 sshd[853]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:41.850678 systemd-logind[799]: New session 4 of user core. Oct 29 20:04:41.865394 systemd[1]: Started Session 4 of User core. Oct 29 20:04:41.916089 sshd[853]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:41.930901 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:48256.service: Deactivated successfully. Oct 29 20:04:41.931518 systemd[1]: session-4.scope: Deactivated successfully. Oct 29 20:04:41.932112 systemd-logind[799]: Session 4 logged out. Waiting for processes to exit. Oct 29 20:04:41.933461 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:48270). Oct 29 20:04:41.934098 systemd-logind[799]: Removed session 4. Oct 29 20:04:41.964548 sshd[859]: Accepted publickey for core from 10.0.0.1 port 48270 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:41.965674 sshd[859]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:41.968018 systemd-logind[799]: New session 5 of user core. Oct 29 20:04:41.983400 systemd[1]: Started Session 5 of User core. Oct 29 20:04:42.038750 sudo[862]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 29 20:04:42.038957 sudo[862]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:04:42.052299 sudo[862]: pam_unix(sudo:session): session closed for user root Oct 29 20:04:42.053907 sshd[859]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:42.072001 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:48276). Oct 29 20:04:42.074634 dbus-daemon[788]: [system] Reloaded configuration Oct 29 20:04:42.076846 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:48270.service: Deactivated successfully. Oct 29 20:04:42.077445 systemd[1]: session-5.scope: Deactivated successfully. Oct 29 20:04:42.078029 systemd-logind[799]: Session 5 logged out. Waiting for processes to exit. Oct 29 20:04:42.078674 systemd-logind[799]: Removed session 5. Oct 29 20:04:42.103186 sshd[865]: Accepted publickey for core from 10.0.0.1 port 48276 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:42.104321 sshd[865]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:42.106614 systemd-logind[799]: New session 6 of user core. Oct 29 20:04:42.128396 systemd[1]: Started Session 6 of User core. Oct 29 20:04:42.178448 sudo[871]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 29 20:04:42.178662 sudo[871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:04:42.180842 sudo[871]: pam_unix(sudo:session): session closed for user root Oct 29 20:04:42.184462 sudo[870]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 29 20:04:42.184660 sudo[870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 29 20:04:42.199147 systemd[1]: Stopping Load Security Auditing Rules... Oct 29 20:04:42.199000 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:04:42.200334 auditctl[874]: No rules Oct 29 20:04:42.200589 systemd[1]: audit-rules.service: Deactivated successfully. Oct 29 20:04:42.200829 systemd[1]: Stopped Load Security Auditing Rules. Oct 29 20:04:42.202105 systemd[1]: Starting Load Security Auditing Rules... Oct 29 20:04:42.202736 kernel: kauditd_printk_skb: 43 callbacks suppressed Oct 29 20:04:42.202777 kernel: audit: type=1305 audit(1761768282.199:54): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 29 20:04:42.218323 augenrules[891]: No rules Oct 29 20:04:42.218055 sudo[870]: pam_unix(sudo:session): session closed for user root Oct 29 20:04:42.217093 systemd[1]: Finished Load Security Auditing Rules. Oct 29 20:04:42.219059 sshd[865]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:42.221101 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:48276.service: Deactivated successfully. Oct 29 20:04:42.221641 systemd[1]: session-6.scope: Deactivated successfully. Oct 29 20:04:42.222135 systemd-logind[799]: Session 6 logged out. Waiting for processes to exit. Oct 29 20:04:42.223050 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:48280). Oct 29 20:04:42.224562 systemd-logind[799]: Removed session 6. Oct 29 20:04:42.254447 sshd[897]: Accepted publickey for core from 10.0.0.1 port 48280 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:42.256586 sshd[897]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:42.257288 kernel: audit: type=1006 audit(1761768282.255:55): pid=897 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Oct 29 20:04:42.259011 systemd-logind[799]: New session 7 of user core. Oct 29 20:04:42.267392 systemd[1]: Started Session 7 of User core. Oct 29 20:04:42.315544 sshd[897]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:42.323862 systemd[1]: sshd@6-10.0.0.6:22-10.0.0.1:48280.service: Deactivated successfully. Oct 29 20:04:42.324420 systemd[1]: session-7.scope: Deactivated successfully. Oct 29 20:04:42.325026 systemd-logind[799]: Session 7 logged out. Waiting for processes to exit. Oct 29 20:04:42.326000 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:48294). Oct 29 20:04:42.326680 systemd-logind[799]: Removed session 7. Oct 29 20:04:42.357684 sshd[903]: Accepted publickey for core from 10.0.0.1 port 48294 ssh2: RSA SHA256:jhIKK9sC6z9AEem3BcHYOJoyba//qCSPbQRIJr1j09g Oct 29 20:04:42.358734 sshd[903]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 29 20:04:42.360285 kernel: audit: type=1006 audit(1761768282.358:56): pid=903 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Oct 29 20:04:42.361536 systemd-logind[799]: New session 8 of user core. Oct 29 20:04:42.374414 systemd[1]: Started Session 8 of User core. Oct 29 20:04:42.422999 sshd[903]: pam_unix(sshd:session): session closed for user core Oct 29 20:04:42.424735 systemd[1]: sshd@7-10.0.0.6:22-10.0.0.1:48294.service: Deactivated successfully. Oct 29 20:04:42.425335 systemd[1]: session-8.scope: Deactivated successfully. Oct 29 20:04:42.425898 systemd-logind[799]: Session 8 logged out. Waiting for processes to exit. Oct 29 20:04:42.426565 systemd-logind[799]: Removed session 8.