Nov 4 12:41:11.676757 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 4 12:41:11.676774 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 Nov 4 12:41:11.676782 kernel: efi: EFI v2.70 by EDK II Nov 4 12:41:11.676788 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Nov 4 12:41:11.676792 kernel: efi: seeding entropy pool Nov 4 12:41:11.676797 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Nov 4 12:41:11.676803 kernel: ACPI: Early table checksum verification disabled Nov 4 12:41:11.676808 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Nov 4 12:41:11.676813 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 4 12:41:11.676818 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:11.676825 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:11.676830 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:11.676835 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:11.676840 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:11.676846 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:11.676851 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:11.676857 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:11.676863 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:11.676868 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 4 12:41:11.676873 kernel: ACPI: NUMA: Failed to initialise from firmware Nov 4 12:41:11.676879 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:41:11.676884 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Nov 4 12:41:11.676889 kernel: Zone ranges: Nov 4 12:41:11.676894 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:41:11.676899 kernel: DMA32 empty Nov 4 12:41:11.676904 kernel: Normal empty Nov 4 12:41:11.676910 kernel: Movable zone start for each node Nov 4 12:41:11.676916 kernel: Early memory node ranges Nov 4 12:41:11.676921 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Nov 4 12:41:11.676926 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Nov 4 12:41:11.676932 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Nov 4 12:41:11.676937 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Nov 4 12:41:11.676942 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Nov 4 12:41:11.676947 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Nov 4 12:41:11.676953 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Nov 4 12:41:11.676958 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 4 12:41:11.676963 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 4 12:41:11.676968 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 4 12:41:11.676973 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 4 12:41:11.676979 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:41:11.676987 kernel: On node 0 totalpages: 643072 Nov 4 12:41:11.676993 kernel: DMA zone: 10048 pages used for memmap Nov 4 12:41:11.676998 kernel: DMA zone: 0 pages reserved Nov 4 12:41:11.677004 kernel: DMA zone: 643072 pages, LIFO batch:63 Nov 4 12:41:11.677009 kernel: psci: probing for conduit method from ACPI. Nov 4 12:41:11.677015 kernel: psci: PSCIv1.1 detected in firmware. Nov 4 12:41:11.677020 kernel: psci: Using standard PSCI v0.2 function IDs Nov 4 12:41:11.677026 kernel: psci: Trusted OS migration not required Nov 4 12:41:11.677032 kernel: psci: SMC Calling Convention v1.1 Nov 4 12:41:11.677037 kernel: ACPI: SRAT not present Nov 4 12:41:11.677043 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Nov 4 12:41:11.677049 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Nov 4 12:41:11.677054 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 4 12:41:11.677060 kernel: Detected PIPT I-cache on CPU0 Nov 4 12:41:11.677065 kernel: CPU features: detected: GIC system register CPU interface Nov 4 12:41:11.677071 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 4 12:41:11.677076 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 4 12:41:11.677082 kernel: CPU features: detected: Hardware dirty bit management Nov 4 12:41:11.677087 kernel: CPU features: detected: Spectre-v4 Nov 4 12:41:11.677093 kernel: CPU features: detected: ARM erratum 1418040 Nov 4 12:41:11.677099 kernel: CPU features: detected: Spectre-BHB Nov 4 12:41:11.677111 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 4 12:41:11.677117 kernel: Policy zone: DMA Nov 4 12:41:11.677123 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 Nov 4 12:41:11.677129 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 4 12:41:11.677135 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 4 12:41:11.677141 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 4 12:41:11.677147 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Nov 4 12:41:11.677153 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Nov 4 12:41:11.677158 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 4 12:41:11.677165 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 4 12:41:11.677172 kernel: rcu: RCU event tracing is enabled. Nov 4 12:41:11.677177 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 4 12:41:11.677183 kernel: Trampoline variant of Tasks RCU enabled. Nov 4 12:41:11.677189 kernel: Tracing variant of Tasks RCU enabled. Nov 4 12:41:11.677194 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 4 12:41:11.677200 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 4 12:41:11.677205 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 4 12:41:11.677211 kernel: GICv3: 256 SPIs implemented Nov 4 12:41:11.677216 kernel: GICv3: 0 Extended SPIs implemented Nov 4 12:41:11.677222 kernel: GICv3: Distributor has no Range Selector support Nov 4 12:41:11.677227 kernel: GICv3: 16 PPIs implemented Nov 4 12:41:11.677234 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 4 12:41:11.677239 kernel: ACPI: SRAT not present Nov 4 12:41:11.677245 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 4 12:41:11.677250 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Nov 4 12:41:11.677256 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Nov 4 12:41:11.677262 kernel: GICv3: using LPI property table @0x00000000400d0000 Nov 4 12:41:11.677267 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Nov 4 12:41:11.677273 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:41:11.677279 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 4 12:41:11.677284 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 4 12:41:11.677290 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 4 12:41:11.677296 kernel: arm-pv: using stolen time PV Nov 4 12:41:11.677303 kernel: Console: colour dummy device 80x25 Nov 4 12:41:11.677308 kernel: ACPI: Core revision 20200925 Nov 4 12:41:11.677314 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 4 12:41:11.677320 kernel: pid_max: default: 32768 minimum: 301 Nov 4 12:41:11.677326 kernel: LSM: Security Framework initializing Nov 4 12:41:11.677332 kernel: SELinux: Initializing. Nov 4 12:41:11.677338 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:41:11.677343 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:41:11.677349 kernel: rcu: Hierarchical SRCU implementation. Nov 4 12:41:11.677356 kernel: Platform MSI: ITS@0x8080000 domain created Nov 4 12:41:11.677362 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 4 12:41:11.677367 kernel: Remapping and enabling EFI services. Nov 4 12:41:11.677373 kernel: smp: Bringing up secondary CPUs ... Nov 4 12:41:11.677379 kernel: Detected PIPT I-cache on CPU1 Nov 4 12:41:11.677385 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 4 12:41:11.677390 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Nov 4 12:41:11.677396 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:41:11.677402 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 4 12:41:11.677408 kernel: Detected PIPT I-cache on CPU2 Nov 4 12:41:11.677415 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 4 12:41:11.677421 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Nov 4 12:41:11.677427 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:41:11.677433 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 4 12:41:11.677438 kernel: Detected PIPT I-cache on CPU3 Nov 4 12:41:11.677448 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 4 12:41:11.677454 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Nov 4 12:41:11.677461 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:41:11.677467 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 4 12:41:11.677473 kernel: smp: Brought up 1 node, 4 CPUs Nov 4 12:41:11.677479 kernel: SMP: Total of 4 processors activated. Nov 4 12:41:11.677485 kernel: CPU features: detected: Privileged Access Never Nov 4 12:41:11.677491 kernel: CPU features: detected: LSE atomic instructions Nov 4 12:41:11.677497 kernel: CPU features: detected: User Access Override Nov 4 12:41:11.677503 kernel: CPU features: detected: 32-bit EL0 Support Nov 4 12:41:11.677509 kernel: CPU features: detected: Common not Private translations Nov 4 12:41:11.677515 kernel: CPU features: detected: RAS Extension Support Nov 4 12:41:11.677522 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 4 12:41:11.677528 kernel: CPU features: detected: CRC32 instructions Nov 4 12:41:11.677534 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 4 12:41:11.677540 kernel: CPU: All CPU(s) started at EL1 Nov 4 12:41:11.677546 kernel: alternatives: patching kernel code Nov 4 12:41:11.677553 kernel: devtmpfs: initialized Nov 4 12:41:11.677559 kernel: KASLR enabled Nov 4 12:41:11.677565 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 4 12:41:11.677572 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 4 12:41:11.677578 kernel: pinctrl core: initialized pinctrl subsystem Nov 4 12:41:11.677584 kernel: SMBIOS 3.0.0 present. Nov 4 12:41:11.677589 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Nov 4 12:41:11.677595 kernel: NET: Registered protocol family 16 Nov 4 12:41:11.677602 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 4 12:41:11.677608 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 4 12:41:11.677615 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 4 12:41:11.677621 kernel: audit: initializing netlink subsys (disabled) Nov 4 12:41:11.677627 kernel: audit: type=2000 audit(0.031:1): state=initialized audit_enabled=0 res=1 Nov 4 12:41:11.677634 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 4 12:41:11.677640 kernel: cpuidle: using governor menu Nov 4 12:41:11.677646 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 4 12:41:11.677652 kernel: ASID allocator initialised with 32768 entries Nov 4 12:41:11.677657 kernel: ACPI: bus type PCI registered Nov 4 12:41:11.677664 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 4 12:41:11.677671 kernel: Serial: AMBA PL011 UART driver Nov 4 12:41:11.677677 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 4 12:41:11.677683 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 4 12:41:11.677689 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 4 12:41:11.677695 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 4 12:41:11.677701 kernel: cryptd: max_cpu_qlen set to 1000 Nov 4 12:41:11.677707 kernel: ACPI: Added _OSI(Module Device) Nov 4 12:41:11.677713 kernel: ACPI: Added _OSI(Processor Device) Nov 4 12:41:11.677719 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 4 12:41:11.677726 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 4 12:41:11.677732 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 4 12:41:11.677747 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 4 12:41:11.677754 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 4 12:41:11.677760 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 4 12:41:11.677778 kernel: ACPI: Interpreter enabled Nov 4 12:41:11.677784 kernel: ACPI: Using GIC for interrupt routing Nov 4 12:41:11.677790 kernel: ACPI: MCFG table detected, 1 entries Nov 4 12:41:11.677796 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 4 12:41:11.677802 kernel: printk: console [ttyAMA0] enabled Nov 4 12:41:11.677810 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 4 12:41:11.677909 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 4 12:41:11.677967 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 4 12:41:11.678021 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 4 12:41:11.678075 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 4 12:41:11.678139 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 4 12:41:11.678147 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 4 12:41:11.678156 kernel: PCI host bridge to bus 0000:00 Nov 4 12:41:11.678220 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 4 12:41:11.678272 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 4 12:41:11.678322 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 4 12:41:11.678376 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 4 12:41:11.678447 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 4 12:41:11.678509 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 4 12:41:11.678568 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 4 12:41:11.678627 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 4 12:41:11.678684 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:41:11.678748 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:41:11.678806 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 4 12:41:11.678861 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 4 12:41:11.678911 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 4 12:41:11.678961 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 4 12:41:11.679009 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 4 12:41:11.679017 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Nov 4 12:41:11.679023 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Nov 4 12:41:11.679029 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Nov 4 12:41:11.679035 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Nov 4 12:41:11.679041 kernel: vgaarb: loaded Nov 4 12:41:11.679047 kernel: Registered efivars operations Nov 4 12:41:11.679053 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 4 12:41:11.679061 kernel: VFS: Disk quotas dquot_6.6.0 Nov 4 12:41:11.679067 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 4 12:41:11.679073 kernel: pnp: PnP ACPI init Nov 4 12:41:11.679142 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 4 12:41:11.679193 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Nov 4 12:41:11.679201 kernel: pnp: PnP ACPI: found 1 devices Nov 4 12:41:11.679207 kernel: NET: Registered protocol family 2 Nov 4 12:41:11.679214 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 4 12:41:11.679222 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 4 12:41:11.679228 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 4 12:41:11.679234 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 4 12:41:11.679240 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 4 12:41:11.679246 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:41:11.679253 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:41:11.679259 kernel: NET: Registered protocol family 1 Nov 4 12:41:11.679265 kernel: PCI: CLS 0 bytes, default 64 Nov 4 12:41:11.679271 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 4 12:41:11.679278 kernel: kvm [1]: HYP mode not available Nov 4 12:41:11.679284 kernel: Initialise system trusted keyrings Nov 4 12:41:11.679290 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 4 12:41:11.679296 kernel: Key type asymmetric registered Nov 4 12:41:11.679302 kernel: Asymmetric key parser 'x509' registered Nov 4 12:41:11.679308 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 4 12:41:11.679314 kernel: io scheduler mq-deadline registered Nov 4 12:41:11.679320 kernel: io scheduler kyber registered Nov 4 12:41:11.679326 kernel: io scheduler bfq registered Nov 4 12:41:11.679333 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 4 12:41:11.679339 kernel: ACPI: Power Button [PWRB] Nov 4 12:41:11.679345 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Nov 4 12:41:11.679400 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 4 12:41:11.679408 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 4 12:41:11.679415 kernel: msm_serial: driver initialized Nov 4 12:41:11.679421 kernel: random: fast init done Nov 4 12:41:11.679426 kernel: random: crng init done Nov 4 12:41:11.679433 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Nov 4 12:41:11.679439 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Nov 4 12:41:11.679447 kernel: thunder_xcv, ver 1.0 Nov 4 12:41:11.679453 kernel: thunder_bgx, ver 1.0 Nov 4 12:41:11.679459 kernel: nicpf, ver 1.0 Nov 4 12:41:11.679464 kernel: nicvf, ver 1.0 Nov 4 12:41:11.679525 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 4 12:41:11.679577 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-04T12:41:11 UTC (1762260071) Nov 4 12:41:11.679585 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 4 12:41:11.679591 kernel: NET: Registered protocol family 10 Nov 4 12:41:11.679598 kernel: Segment Routing with IPv6 Nov 4 12:41:11.679604 kernel: NET: Registered protocol family 17 Nov 4 12:41:11.679610 kernel: Key type dns_resolver registered Nov 4 12:41:11.679616 kernel: registered taskstats version 1 Nov 4 12:41:11.679622 kernel: Loading compiled-in X.509 certificates Nov 4 12:41:11.679628 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Nov 4 12:41:11.679634 kernel: Key type ._fscrypt registered Nov 4 12:41:11.679640 kernel: Key type .fscrypt registered Nov 4 12:41:11.679646 kernel: Key type fscrypt-provisioning registered Nov 4 12:41:11.679654 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 4 12:41:11.679660 kernel: ima: Allocated hash algorithm: sha1 Nov 4 12:41:11.679666 kernel: ima: No architecture policies found Nov 4 12:41:11.679672 kernel: Freeing unused kernel memory: 34240K Nov 4 12:41:11.679678 kernel: Run /init as init process Nov 4 12:41:11.679684 kernel: with arguments: Nov 4 12:41:11.679690 kernel: /init Nov 4 12:41:11.679696 kernel: with environment: Nov 4 12:41:11.679712 kernel: HOME=/ Nov 4 12:41:11.679718 kernel: TERM=linux Nov 4 12:41:11.679726 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 4 12:41:11.679734 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) Nov 4 12:41:11.679764 systemd[1]: Detected virtualization kvm. Nov 4 12:41:11.679771 systemd[1]: Detected architecture arm64. Nov 4 12:41:11.679777 systemd[1]: Running in initial RAM disk. Nov 4 12:41:11.679784 systemd[1]: No hostname configured, using default hostname. Nov 4 12:41:11.679790 systemd[1]: Hostname set to . Nov 4 12:41:11.679798 systemd[1]: Initializing machine ID from VM UUID. Nov 4 12:41:11.679805 systemd[1]: Queued start job for default target Initrd Default Target. Nov 4 12:41:11.679811 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:41:11.679818 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:41:11.679824 systemd[1]: Reached target Path Units. Nov 4 12:41:11.679830 systemd[1]: Reached target Slice Units. Nov 4 12:41:11.679837 systemd[1]: Reached target Swaps. Nov 4 12:41:11.679843 systemd[1]: Reached target Timer Units. Nov 4 12:41:11.679851 systemd[1]: Listening on Open-iSCSI iscsid Socket. Nov 4 12:41:11.679858 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Nov 4 12:41:11.679864 systemd[1]: Listening on Journal Audit Socket. Nov 4 12:41:11.679871 systemd[1]: Listening on Journal Socket (/dev/log). Nov 4 12:41:11.679877 systemd[1]: Listening on Journal Socket. Nov 4 12:41:11.679883 systemd[1]: Listening on Network Service Netlink Socket. Nov 4 12:41:11.679890 systemd[1]: Listening on udev Control Socket. Nov 4 12:41:11.679897 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:41:11.679903 systemd[1]: Reached target Socket Units. Nov 4 12:41:11.679911 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:41:11.679917 systemd[1]: Finished Network Cleanup. Nov 4 12:41:11.679924 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Nov 4 12:41:11.679930 systemd[1]: Starting Journal Service... Nov 4 12:41:11.679937 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:41:11.679943 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:41:11.679950 systemd[1]: Starting Setup Virtual Console... Nov 4 12:41:11.679956 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:41:11.679963 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:41:11.679969 systemd[1]: Finished Setup Virtual Console. Nov 4 12:41:11.679977 systemd[1]: Starting dracut ask for additional cmdline parameters... Nov 4 12:41:11.679985 systemd-journald[278]: Journal started Nov 4 12:41:11.680019 systemd-journald[278]: Runtime Journal (/run/log/journal/a4c5883c7a7d49bfbad6e7d250c79ca5) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:41:11.682757 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:41:11.683974 systemd[1]: Started Journal Service. Nov 4 12:41:11.684320 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:41:11.692946 systemd[1]: Finished dracut ask for additional cmdline parameters. Nov 4 12:41:11.694530 systemd[1]: Starting dracut cmdline hook... Nov 4 12:41:11.703154 dracut-cmdline[294]: dracut-dracut-053 Nov 4 12:41:11.705388 dracut-cmdline[294]: 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 Nov 4 12:41:11.762766 kernel: SCSI subsystem initialized Nov 4 12:41:11.765749 kernel: Loading iSCSI transport class v2.0-870. Nov 4 12:41:11.771760 kernel: iscsi: registered transport (tcp) Nov 4 12:41:11.782946 kernel: iscsi: registered transport (qla4xxx) Nov 4 12:41:11.782960 kernel: QLogic iSCSI HBA Driver Nov 4 12:41:11.792452 systemd[1]: Finished dracut cmdline hook. Nov 4 12:41:11.793859 systemd[1]: Starting dracut pre-udev hook... Nov 4 12:41:11.805766 kernel: device-mapper: uevent: version 1.0.3 Nov 4 12:41:11.806762 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Nov 4 12:41:11.841779 kernel: raid6: neonx8 gen() 13757 MB/s Nov 4 12:41:11.858771 kernel: raid6: neonx8 xor() 10726 MB/s Nov 4 12:41:11.875780 kernel: raid6: neonx4 gen() 13551 MB/s Nov 4 12:41:11.892772 kernel: raid6: neonx4 xor() 11537 MB/s Nov 4 12:41:11.909773 kernel: raid6: neonx2 gen() 12953 MB/s Nov 4 12:41:11.926775 kernel: raid6: neonx2 xor() 9848 MB/s Nov 4 12:41:11.943773 kernel: raid6: neonx1 gen() 10876 MB/s Nov 4 12:41:11.960771 kernel: raid6: neonx1 xor() 8816 MB/s Nov 4 12:41:11.977774 kernel: raid6: int64x8 gen() 6789 MB/s Nov 4 12:41:11.994772 kernel: raid6: int64x8 xor() 3787 MB/s Nov 4 12:41:12.011774 kernel: raid6: int64x4 gen() 6889 MB/s Nov 4 12:41:12.028773 kernel: raid6: int64x4 xor() 3823 MB/s Nov 4 12:41:12.045771 kernel: raid6: int64x2 gen() 6183 MB/s Nov 4 12:41:12.062770 kernel: raid6: int64x2 xor() 3315 MB/s Nov 4 12:41:12.079770 kernel: raid6: int64x1 gen() 5014 MB/s Nov 4 12:41:12.096841 kernel: raid6: int64x1 xor() 2600 MB/s Nov 4 12:41:12.096862 kernel: raid6: using algorithm neonx8 gen() 13757 MB/s Nov 4 12:41:12.096877 kernel: raid6: .... xor() 10726 MB/s, rmw enabled Nov 4 12:41:12.097918 kernel: raid6: using neon recovery algorithm Nov 4 12:41:12.108161 kernel: xor: measuring software checksum speed Nov 4 12:41:12.108187 kernel: 8regs : 17170 MB/sec Nov 4 12:41:12.109155 kernel: 32regs : 20765 MB/sec Nov 4 12:41:12.110004 kernel: arm64_neon : 29059 MB/sec Nov 4 12:41:12.110018 kernel: xor: using function: arm64_neon (29059 MB/sec) Nov 4 12:41:12.155788 kernel: Btrfs loaded, crc32c=crc32c-generic Nov 4 12:41:12.165053 systemd[1]: Finished dracut pre-udev hook. Nov 4 12:41:12.165000 audit: BPF prog-id=6 op=LOAD Nov 4 12:41:12.166000 audit: BPF prog-id=7 op=LOAD Nov 4 12:41:12.168000 kernel: audit: type=1334 audit(1762260072.165:2): prog-id=6 op=LOAD Nov 4 12:41:12.168022 kernel: audit: type=1334 audit(1762260072.166:3): prog-id=7 op=LOAD Nov 4 12:41:12.168030 kernel: audit: type=1334 audit(1762260072.167:4): prog-id=8 op=LOAD Nov 4 12:41:12.167000 audit: BPF prog-id=8 op=LOAD Nov 4 12:41:12.168329 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:41:12.179246 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:41:12.180921 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:41:12.182518 systemd[1]: Starting dracut pre-trigger hook... Nov 4 12:41:12.188000 audit: BPF prog-id=9 op=LOAD Nov 4 12:41:12.189234 systemd[1]: Starting Network Configuration... Nov 4 12:41:12.191200 kernel: audit: type=1334 audit(1762260072.188:5): prog-id=9 op=LOAD Nov 4 12:41:12.194756 dracut-pre-trigger[422]: rd.md=0: removing MD RAID activation Nov 4 12:41:12.206240 systemd-networkd[431]: lo: Link UP Nov 4 12:41:12.206247 systemd-networkd[431]: lo: Gained carrier Nov 4 12:41:12.206515 systemd-networkd[431]: Enumeration completed Nov 4 12:41:12.207000 audit: BPF prog-id=10 op=LOAD Nov 4 12:41:12.206604 systemd[1]: Started Network Configuration. Nov 4 12:41:12.211804 kernel: audit: type=1334 audit(1762260072.207:6): prog-id=10 op=LOAD Nov 4 12:41:12.208693 systemd[1]: Starting Network Name Resolution... Nov 4 12:41:12.220840 systemd[1]: Finished dracut pre-trigger hook. Nov 4 12:41:12.222194 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:41:12.231629 systemd-udevd[415]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:41:12.237010 systemd-resolved[449]: Positive Trust Anchors: Nov 4 12:41:12.237029 systemd-resolved[449]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 4 12:41:12.237057 systemd-resolved[449]: 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 Nov 4 12:41:12.237326 systemd-resolved[449]: Defaulting to hostname 'linux'. Nov 4 12:41:12.238223 systemd[1]: Started Network Name Resolution. Nov 4 12:41:12.239090 systemd[1]: Reached target Network. Nov 4 12:41:12.239731 systemd[1]: Reached target Host and Network Name Lookups. Nov 4 12:41:12.241297 systemd[1]: Starting iSCSI UserSpace I/O driver... Nov 4 12:41:12.256914 iscsid[483]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:41:12.256914 iscsid[483]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Nov 4 12:41:12.256914 iscsid[483]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 4 12:41:12.256914 iscsid[483]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 4 12:41:12.256914 iscsid[483]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:41:12.256914 iscsid[483]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 4 12:41:12.250221 systemd[1]: Started iSCSI UserSpace I/O driver. Nov 4 12:41:12.251718 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:41:12.253267 systemd[1]: Starting Open-iSCSI... Nov 4 12:41:12.259094 systemd[1]: Started Open-iSCSI. Nov 4 12:41:12.265290 systemd[1]: Starting dracut initqueue hook... Nov 4 12:41:12.283256 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 4 12:41:12.283376 kernel: vda: detected capacity change from 0 to 4756340736 Nov 4 12:41:12.293770 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:41:12.294700 systemd-udevd[469]: Using default interface naming scheme 'v249'. Nov 4 12:41:12.300585 systemd-networkd[431]: eth0: Link UP Nov 4 12:41:12.308382 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Nov 4 12:41:12.310258 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (462) Nov 4 12:41:12.309410 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Nov 4 12:41:12.316149 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Nov 4 12:41:12.318875 systemd[1]: Found device /dev/disk/by-label/ROOT. Nov 4 12:41:12.323005 systemd[1]: Found device /dev/disk/by-label/OEM. Nov 4 12:41:12.324070 systemd[1]: Finished dracut initqueue hook. Nov 4 12:41:12.325298 systemd[1]: Reached target Initrd Root Device. Nov 4 12:41:12.326543 systemd[1]: Reached target Preparation for Remote File Systems. Nov 4 12:41:12.328083 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:41:12.329639 systemd[1]: Reached target Remote File Systems. Nov 4 12:41:12.331778 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Nov 4 12:41:12.333374 systemd[1]: Starting dracut pre-mount hook... Nov 4 12:41:12.340772 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:41:12.341885 systemd[1]: Finished dracut pre-mount hook. Nov 4 12:41:13.331823 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Nov 4 12:41:13.331897 systemd-networkd[431]: eth0: Gained carrier Nov 4 12:41:13.345827 systemd-networkd[431]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Nov 4 12:41:13.349850 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:41:13.349879 disk-uuid[504]: The operation has completed successfully. Nov 4 12:41:13.369213 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 4 12:41:13.369338 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Nov 4 12:41:13.371077 systemd[1]: Starting Ignition (setup)... Nov 4 12:41:13.378761 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 4 12:41:13.378815 kernel: BTRFS info (device vda6): has skinny extents Nov 4 12:41:13.384583 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 4 12:41:13.390613 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 4 12:41:13.390728 systemd[1]: Finished Ignition (setup). Nov 4 12:41:13.392973 systemd[1]: Starting Ignition (disks)... Nov 4 12:41:13.402651 ignition[540]: Ignition v0.36.1-15-gde4e6cc9 Nov 4 12:41:13.402668 ignition[540]: Stage: disks Nov 4 12:41:13.402678 ignition[540]: reading system config file "/usr/lib/ignition/base.ign" Nov 4 12:41:13.402687 ignition[540]: no config at "/usr/lib/ignition/base.ign" Nov 4 12:41:13.402729 ignition[540]: parsed url from cmdline: "" Nov 4 12:41:13.402733 ignition[540]: no config URL provided Nov 4 12:41:13.402756 ignition[540]: reading system config file "/usr/lib/ignition/user.ign" Nov 4 12:41:13.402764 ignition[540]: no config at "/usr/lib/ignition/user.ign" Nov 4 12:41:13.402783 ignition[540]: op(1): [started] loading QEMU firmware config module Nov 4 12:41:13.402788 ignition[540]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 4 12:41:13.404317 ignition[540]: op(1): [finished] loading QEMU firmware config module Nov 4 12:41:13.417805 ignition[540]: parsing config with SHA512: 125018703a8a4647e2e26273fcc4ad3fd287a3deda0300e980fdfef8651c51fdf3b724bd612e1a8290cef6cc7f8e5af5384ace3dc2d1373a66f6d1bb9212eddb Nov 4 12:41:13.419674 ignition[540]: disks: disks passed Nov 4 12:41:13.419682 ignition[540]: Ignition finished successfully Nov 4 12:41:13.420266 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 4 12:41:13.420375 systemd[1]: Finished Ignition (disks). Nov 4 12:41:13.421186 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:41:13.423276 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Nov 4 12:41:13.424986 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Nov 4 12:41:13.433749 systemd-fsck[553]: ROOT: clean, 528/553792 files, 37752/553472 blocks Nov 4 12:41:13.436754 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 4 12:41:13.438573 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Nov 4 12:41:13.440848 systemd[1]: Mounting /sysroot... Nov 4 12:41:13.455858 systemd[1]: Found device /dev/mapper/usr. Nov 4 12:41:13.457804 systemd[1]: Starting File System Check on /dev/mapper/usr... Nov 4 12:41:13.460219 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Nov 4 12:41:13.467031 systemd-fsck[567]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Nov 4 12:41:13.467031 systemd-fsck[567]: You must have r/w access to the filesystem or be root Nov 4 12:41:13.467999 systemd-fsck[564]: fsck failed with exit status 8. Nov 4 12:41:13.468003 systemd-fsck[564]: Ignoring error. Nov 4 12:41:13.472272 systemd[1]: Finished File System Check on /dev/mapper/usr. Nov 4 12:41:13.474997 systemd[1]: Mounting /sysusr/usr... Nov 4 12:41:13.485383 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Nov 4 12:41:13.485419 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Nov 4 12:41:13.485913 systemd[1]: Mounted /sysroot. Nov 4 12:41:13.486609 systemd[1]: Reached target Initrd Root File System. Nov 4 12:41:13.502483 systemd[1]: Mounted /sysusr/usr. Nov 4 12:41:13.503144 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Nov 4 12:41:13.503884 systemd[1]: Reached target Local File Systems. Nov 4 12:41:13.505473 systemd[1]: Reached target System Initialization. Nov 4 12:41:13.507176 systemd[1]: Reached target Basic System. Nov 4 12:41:13.509478 systemd[1]: Mounting /sysroot/usr... Nov 4 12:41:13.511560 systemd[1]: Mounted /sysroot/usr. Nov 4 12:41:13.513519 systemd[1]: Starting Root filesystem setup... Nov 4 12:41:13.538307 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 4 12:41:13.538434 systemd[1]: Finished Root filesystem setup. Nov 4 12:41:13.540646 systemd[1]: Starting Ignition (files)... Nov 4 12:41:13.541923 systemd[1]: Starting /sysroot/boot... Nov 4 12:41:13.544066 ignition[584]: Ignition v0.36.1-15-gde4e6cc9 Nov 4 12:41:13.544086 ignition[584]: Stage: files Nov 4 12:41:13.544105 ignition[584]: reading system config file "/usr/lib/ignition/base.ign" Nov 4 12:41:13.544115 ignition[584]: no config at "/usr/lib/ignition/base.ign" Nov 4 12:41:13.544586 ignition[584]: files: compiled without relabeling support, skipping Nov 4 12:41:13.558567 ignition[584]: files: createUsers: op(1): [started] creating or modifying user "core" Nov 4 12:41:13.558577 ignition[584]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Nov 4 12:41:13.559778 ignition[584]: files: createUsers: op(1): [finished] creating or modifying user "core" Nov 4 12:41:13.559785 ignition[584]: files: createUsers: op(2): [started] adding ssh keys to user "core" Nov 4 12:41:13.561295 systemd[1]: Finished /sysroot/boot. Nov 4 12:41:13.561414 ignition[584]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Nov 4 12:41:13.563220 systemd[1]: ignition-files.service: Deactivated successfully. Nov 4 12:41:13.561436 ignition[584]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Nov 4 12:41:13.563319 systemd[1]: Finished Ignition (files). Nov 4 12:41:13.561725 ignition[584]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Nov 4 12:41:13.564569 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Nov 4 12:41:13.561731 ignition[584]: files: op(4): [started] processing unit "coreos-metadata.service" Nov 4 12:41:13.565206 systemd[1]: Starting Ignition (record completion)... Nov 4 12:41:13.561831 ignition[584]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Nov 4 12:41:13.566854 systemd[1]: Starting Reload Configuration from the Real Root... Nov 4 12:41:13.562185 ignition[584]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Nov 4 12:41:13.579000 audit: BPF prog-id=10 op=UNLOAD Nov 4 12:41:13.580770 kernel: audit: type=1334 audit(1762260073.579:7): prog-id=10 op=UNLOAD Nov 4 12:41:13.570977 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 4 12:41:13.580000 audit: BPF prog-id=9 op=UNLOAD Nov 4 12:41:13.562191 ignition[584]: files: op(4): [finished] processing unit "coreos-metadata.service" Nov 4 12:41:13.584462 kernel: audit: type=1334 audit(1762260073.580:8): prog-id=9 op=UNLOAD Nov 4 12:41:13.584485 kernel: audit: type=1334 audit(1762260073.582:9): prog-id=6 op=UNLOAD Nov 4 12:41:13.582000 audit: BPF prog-id=6 op=UNLOAD Nov 4 12:41:13.571079 systemd[1]: Finished Ignition (record completion). Nov 4 12:41:13.586111 kernel: audit: type=1334 audit(1762260073.584:10): prog-id=3 op=UNLOAD Nov 4 12:41:13.584000 audit: BPF prog-id=3 op=UNLOAD Nov 4 12:41:13.562196 ignition[584]: files: files passed Nov 4 12:41:13.572577 systemd[1]: Reloading. Nov 4 12:41:13.562199 ignition[584]: Ignition finished successfully Nov 4 12:41:13.661000 audit: BPF prog-id=11 op=LOAD Nov 4 12:41:13.662000 audit: BPF prog-id=12 op=LOAD Nov 4 12:41:13.662000 audit: BPF prog-id=13 op=LOAD Nov 4 12:41:13.662000 audit: BPF prog-id=14 op=LOAD Nov 4 12:41:13.662000 audit: BPF prog-id=15 op=LOAD Nov 4 12:41:13.662000 audit: BPF prog-id=7 op=UNLOAD Nov 4 12:41:13.662000 audit: BPF prog-id=8 op=UNLOAD Nov 4 12:41:13.663000 audit: BPF prog-id=16 op=LOAD Nov 4 12:41:13.663000 audit: BPF prog-id=17 op=LOAD Nov 4 12:41:13.663000 audit: BPF prog-id=18 op=LOAD Nov 4 12:41:13.663000 audit: BPF prog-id=4 op=UNLOAD Nov 4 12:41:13.663000 audit: BPF prog-id=5 op=UNLOAD Nov 4 12:41:13.676945 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 4 12:41:13.677056 systemd[1]: Finished Reload Configuration from the Real Root. Nov 4 12:41:13.678916 systemd[1]: Reached target Initrd File Systems. Nov 4 12:41:13.680396 systemd[1]: Reached target Initrd Default Target. Nov 4 12:41:13.681820 systemd[1]: Condition check resulted in dracut mount hook being skipped. Nov 4 12:41:13.682453 systemd[1]: Starting dracut pre-pivot and cleanup hook... Nov 4 12:41:13.692348 systemd[1]: Finished dracut pre-pivot and cleanup hook. Nov 4 12:41:13.693894 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Nov 4 12:41:13.699695 systemd[1]: Stopped target Host and Network Name Lookups. Nov 4 12:41:13.700776 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 4 12:41:13.702403 systemd[1]: Stopped target Timer Units. Nov 4 12:41:13.703717 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 4 12:41:13.703839 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Nov 4 12:41:13.705190 systemd[1]: Stopped target Initrd Default Target. Nov 4 12:41:13.706626 systemd[1]: Stopped target Basic System. Nov 4 12:41:13.708036 systemd[1]: Stopped target Initrd Root Device. Nov 4 12:41:13.709453 systemd[1]: Stopped target Path Units. Nov 4 12:41:13.710649 systemd[1]: Stopped target Remote File Systems. Nov 4 12:41:13.712050 systemd[1]: Stopped target Preparation for Remote File Systems. Nov 4 12:41:13.713493 systemd[1]: Stopped target Slice Units. Nov 4 12:41:13.714781 systemd[1]: Stopped target Socket Units. Nov 4 12:41:13.716289 systemd[1]: Stopped target System Initialization. Nov 4 12:41:13.717629 systemd[1]: Stopped target Local File Systems. Nov 4 12:41:13.718948 systemd[1]: Stopped target Preparation for Local File Systems. Nov 4 12:41:13.720472 systemd[1]: Stopped target Swaps. Nov 4 12:41:13.721667 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 4 12:41:13.721784 systemd[1]: Stopped dracut pre-mount hook. Nov 4 12:41:13.723248 systemd[1]: Stopped target Local Encrypted Volumes. Nov 4 12:41:13.724463 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 4 12:41:13.727784 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 4 12:41:13.728852 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 4 12:41:13.728949 systemd[1]: Stopped dracut initqueue hook. Nov 4 12:41:13.734254 iscsid[483]: iscsid shutting down. Nov 4 12:41:13.730567 systemd[1]: Stopping Open-iSCSI... Nov 4 12:41:13.734214 systemd[1]: Stopping /sysroot/boot... Nov 4 12:41:13.734825 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 4 12:41:13.734953 systemd[1]: Stopped Coldplug All udev Devices. Nov 4 12:41:13.736164 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 4 12:41:13.736251 systemd[1]: Stopped dracut pre-trigger hook. Nov 4 12:41:13.738287 systemd[1]: iscsid.service: Deactivated successfully. Nov 4 12:41:13.738394 systemd[1]: Stopped Open-iSCSI. Nov 4 12:41:13.739970 systemd[1]: iscsid.socket: Deactivated successfully. Nov 4 12:41:13.740015 systemd[1]: Closed Open-iSCSI iscsid Socket. Nov 4 12:41:13.741235 systemd[1]: Stopping iSCSI UserSpace I/O driver... Nov 4 12:41:13.744522 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 4 12:41:13.744623 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Nov 4 12:41:13.746005 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 4 12:41:13.746117 systemd[1]: Stopped iSCSI UserSpace I/O driver. Nov 4 12:41:13.747440 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 4 12:41:13.747539 systemd[1]: Stopped /sysroot/boot. Nov 4 12:41:13.749039 systemd[1]: Stopped target Network. Nov 4 12:41:13.749722 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 4 12:41:13.749802 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Nov 4 12:41:13.751167 systemd[1]: Stopping Network Name Resolution... Nov 4 12:41:13.760000 audit: BPF prog-id=11 op=UNLOAD Nov 4 12:41:13.757583 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 4 12:41:13.757694 systemd[1]: Stopped Network Name Resolution. Nov 4 12:41:13.758824 systemd[1]: Stopping Network Configuration... Nov 4 12:41:13.763893 systemd-networkd[431]: eth0: DHCP lease lost Nov 4 12:41:13.776436 systemd-networkd[431]: eth0: DHCPv6 lease lost Nov 4 12:41:13.778190 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 4 12:41:13.778321 systemd[1]: Stopped Network Configuration. Nov 4 12:41:13.780145 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 4 12:41:13.780175 systemd[1]: Closed Network Service Netlink Socket. Nov 4 12:41:13.781955 systemd[1]: Stopping Network Cleanup... Nov 4 12:41:13.785000 audit: BPF prog-id=12 op=UNLOAD Nov 4 12:41:13.782799 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 4 12:41:13.782863 systemd[1]: Stopped Apply Kernel Variables. Nov 4 12:41:13.784322 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Nov 4 12:41:13.789507 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 4 12:41:13.789621 systemd[1]: Stopped Network Cleanup. Nov 4 12:41:13.792692 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 4 12:41:13.792836 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Nov 4 12:41:13.793996 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 4 12:41:13.796000 audit: BPF prog-id=13 op=UNLOAD Nov 4 12:41:13.794034 systemd[1]: Closed udev Control Socket. Nov 4 12:41:13.795349 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 4 12:41:13.795382 systemd[1]: Closed udev Kernel Socket. Nov 4 12:41:13.796918 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 4 12:41:13.796962 systemd[1]: Stopped dracut pre-udev hook. Nov 4 12:41:13.798487 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 4 12:41:13.798528 systemd[1]: Stopped dracut cmdline hook. Nov 4 12:41:13.799706 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 4 12:41:13.799764 systemd[1]: Stopped dracut ask for additional cmdline parameters. Nov 4 12:41:13.802196 systemd[1]: Starting Cleanup udev Database... Nov 4 12:41:13.803759 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Nov 4 12:41:13.805227 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 4 12:41:13.805285 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 4 12:41:13.806872 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 4 12:41:13.806915 systemd[1]: Stopped Create List of Static Device Nodes. Nov 4 12:41:13.808300 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 4 12:41:13.808345 systemd[1]: Stopped Setup Virtual Console. Nov 4 12:41:13.820000 audit: BPF prog-id=16 op=UNLOAD Nov 4 12:41:13.810071 systemd[1]: rngd.service: Deactivated successfully. Nov 4 12:41:13.810190 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Nov 4 12:41:13.811685 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 4 12:41:13.811799 systemd[1]: Finished Cleanup udev Database. Nov 4 12:41:13.812990 systemd[1]: Reached target Switch Root. Nov 4 12:41:13.815045 systemd[1]: Starting Switch Root... Nov 4 12:41:13.819776 systemd[1]: Switching root. Nov 4 12:41:13.839696 systemd-journald[278]: Journal stopped Nov 4 12:41:15.980303 systemd-journald[278]: Received SIGTERM from PID 1 (systemd). Nov 4 12:41:15.980358 kernel: SELinux: policy capability network_peer_controls=1 Nov 4 12:41:15.980371 kernel: SELinux: policy capability open_perms=1 Nov 4 12:41:15.980380 kernel: SELinux: policy capability extended_socket_class=1 Nov 4 12:41:15.980390 kernel: SELinux: policy capability always_check_network=0 Nov 4 12:41:15.980399 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 4 12:41:15.980408 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 4 12:41:15.980421 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 4 12:41:15.980430 systemd[1]: Successfully loaded SELinux policy in 33.344ms. Nov 4 12:41:15.980446 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.243ms. Nov 4 12:41:15.980457 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) Nov 4 12:41:15.980469 systemd[1]: Detected virtualization kvm. Nov 4 12:41:15.980479 systemd[1]: Detected architecture arm64. Nov 4 12:41:15.980498 systemd[1]: Detected first boot. Nov 4 12:41:15.980508 systemd[1]: Initializing machine ID from VM UUID. Nov 4 12:41:15.980519 systemd[1]: Populated /etc with preset unit settings. Nov 4 12:41:15.980530 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. Nov 4 12:41:15.980542 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 4 12:41:15.980553 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 4 12:41:15.980563 systemd[1]: Stopped Switch Root. Nov 4 12:41:15.980573 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 4 12:41:15.980584 systemd[1]: Created slice Slice /system/addon-config. Nov 4 12:41:15.980594 systemd[1]: Created slice Slice /system/addon-run. Nov 4 12:41:15.980603 systemd[1]: Created slice Slice /system/getty. Nov 4 12:41:15.980667 systemd[1]: Created slice Slice /system/modprobe. Nov 4 12:41:15.980681 systemd[1]: Created slice Slice /system/serial-getty. Nov 4 12:41:15.980693 systemd[1]: Created slice Slice /system/system-cloudinit. Nov 4 12:41:15.980704 systemd[1]: Created slice Slice /system/systemd-fsck. Nov 4 12:41:15.980713 systemd[1]: Created slice User and Session Slice. Nov 4 12:41:15.980723 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:41:15.980733 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Nov 4 12:41:15.980756 systemd[1]: Set up automount Boot partition Automount Point. Nov 4 12:41:15.980767 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 4 12:41:15.980777 systemd[1]: Stopped target Switch Root. Nov 4 12:41:15.980787 systemd[1]: Stopped target Initrd File Systems. Nov 4 12:41:15.980799 systemd[1]: Stopped target Initrd Root File System. Nov 4 12:41:15.980809 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:41:15.980819 systemd[1]: Reached target Remote File Systems. Nov 4 12:41:15.980829 systemd[1]: Reached target Slice Units. Nov 4 12:41:15.980838 systemd[1]: Reached target Swaps. Nov 4 12:41:15.980848 systemd[1]: Reached target Verify torcx succeeded. Nov 4 12:41:15.980857 systemd[1]: Reached target Local Verity Protected Volumes. Nov 4 12:41:15.980868 systemd[1]: Listening on Process Core Dump Socket. Nov 4 12:41:15.980879 systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 4 12:41:15.980889 systemd[1]: Listening on Network Service Netlink Socket. Nov 4 12:41:15.980900 systemd[1]: Listening on udev Control Socket. Nov 4 12:41:15.980910 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:41:15.980920 systemd[1]: Mounting Huge Pages File System... Nov 4 12:41:15.980930 systemd[1]: Mounting POSIX Message Queue File System... Nov 4 12:41:15.980939 systemd[1]: Mounting External Media Directory... Nov 4 12:41:15.980951 systemd[1]: Mounting Kernel Debug File System... Nov 4 12:41:15.980961 systemd[1]: Mounting Kernel Trace File System... Nov 4 12:41:15.980970 systemd[1]: Mounting Temporary Directory /tmp... Nov 4 12:41:15.980980 systemd[1]: Starting Create missing system files... Nov 4 12:41:15.980990 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:41:15.981001 systemd[1]: Starting Load Kernel Module configfs... Nov 4 12:41:15.981011 systemd[1]: Starting Load Kernel Module drm... Nov 4 12:41:15.981020 systemd[1]: Starting Load Kernel Module fuse... Nov 4 12:41:15.981030 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Nov 4 12:41:15.981040 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 4 12:41:15.981049 systemd[1]: Stopped File System Check on Root Device. Nov 4 12:41:15.981059 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 4 12:41:15.981069 systemd[1]: Stopped systemd-fsck-usr.service. Nov 4 12:41:15.981084 kernel: fuse: init (API version 7.32) Nov 4 12:41:15.981098 systemd[1]: Stopped Journal Service. Nov 4 12:41:15.981108 kernel: kauditd_printk_skb: 36 callbacks suppressed Nov 4 12:41:15.981117 kernel: audit: type=1334 audit(1762260075.960:47): prog-id=27 op=LOAD Nov 4 12:41:15.981126 kernel: audit: type=1334 audit(1762260075.962:48): prog-id=28 op=LOAD Nov 4 12:41:15.981135 kernel: audit: type=1334 audit(1762260075.963:49): prog-id=29 op=LOAD Nov 4 12:41:15.981144 kernel: audit: type=1334 audit(1762260075.963:50): prog-id=25 op=UNLOAD Nov 4 12:41:15.981153 kernel: audit: type=1334 audit(1762260075.964:51): prog-id=26 op=UNLOAD Nov 4 12:41:15.981162 systemd[1]: Starting Journal Service... Nov 4 12:41:15.981172 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:41:15.981181 systemd[1]: Starting Remount Root and Kernel File Systems... Nov 4 12:41:15.981192 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:41:15.981202 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:41:15.981211 systemd[1]: verity-setup.service: Deactivated successfully. Nov 4 12:41:15.981221 systemd[1]: Stopped verity-setup.service. Nov 4 12:41:15.981231 kernel: audit: type=1305 audit(1762260075.978:52): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Nov 4 12:41:15.981241 systemd-journald[799]: Journal started Nov 4 12:41:15.981279 systemd-journald[799]: Runtime Journal (/run/log/journal/a4c5883c7a7d49bfbad6e7d250c79ca5) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:41:13.904000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 4 12:41:13.933000 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 Nov 4 12:41:13.933000 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 Nov 4 12:41:13.933000 audit: BPF prog-id=19 op=LOAD Nov 4 12:41:13.933000 audit: BPF prog-id=19 op=UNLOAD Nov 4 12:41:13.933000 audit: BPF prog-id=20 op=LOAD Nov 4 12:41:13.933000 audit: BPF prog-id=20 op=UNLOAD Nov 4 12:41:13.967000 audit[748]: AVC avc: denied { associate } for pid=748 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 Nov 4 12:41:15.843000 audit: BPF prog-id=21 op=LOAD Nov 4 12:41:15.843000 audit: BPF prog-id=22 op=LOAD Nov 4 12:41:15.843000 audit: BPF prog-id=23 op=LOAD Nov 4 12:41:15.843000 audit: BPF prog-id=17 op=UNLOAD Nov 4 12:41:15.843000 audit: BPF prog-id=18 op=UNLOAD Nov 4 12:41:15.857000 audit: BPF prog-id=24 op=LOAD Nov 4 12:41:15.857000 audit: BPF prog-id=21 op=UNLOAD Nov 4 12:41:15.857000 audit: BPF prog-id=25 op=LOAD Nov 4 12:41:15.857000 audit: BPF prog-id=26 op=LOAD Nov 4 12:41:15.857000 audit: BPF prog-id=22 op=UNLOAD Nov 4 12:41:15.857000 audit: BPF prog-id=23 op=UNLOAD Nov 4 12:41:15.872000 audit: BPF prog-id=24 op=UNLOAD Nov 4 12:41:15.960000 audit: BPF prog-id=27 op=LOAD Nov 4 12:41:15.962000 audit: BPF prog-id=28 op=LOAD Nov 4 12:41:15.963000 audit: BPF prog-id=29 op=LOAD Nov 4 12:41:15.963000 audit: BPF prog-id=25 op=UNLOAD Nov 4 12:41:15.964000 audit: BPF prog-id=26 op=UNLOAD Nov 4 12:41:15.978000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Nov 4 12:41:15.843586 systemd[1]: Queued start job for default target Multi-User System. Nov 4 12:41:13.966946 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" 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]" Nov 4 12:41:15.859432 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 4 12:41:13.967274 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:41:13.967295 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:41:13.967426 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 4 12:41:13.967437 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 4 12:41:13.967465 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 4 12:41:13.967478 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 4 12:41:13.967664 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 4 12:41:13.967698 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:41:13.967717 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:41:13.968101 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" 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 Nov 4 12:41:13.968132 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" 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 Nov 4 12:41:13.968151 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" 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 Nov 4 12:41:13.968166 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Nov 4 12:41:13.968183 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" 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 Nov 4 12:41:13.968196 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:13Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 4 12:41:15.677057 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:15Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:41:15.677333 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:15Z" 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 Nov 4 12:41:15.677438 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:15Z" 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 Nov 4 12:41:15.677562 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:15Z" 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 Nov 4 12:41:15.677614 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:15Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 4 12:41:15.677671 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:41:15Z" 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 Nov 4 12:41:15.984767 systemd[1]: Started Journal Service. Nov 4 12:41:15.985045 systemd[1]: Mounted Huge Pages File System. Nov 4 12:41:15.985920 systemd[1]: Mounted POSIX Message Queue File System. Nov 4 12:41:15.986883 systemd[1]: Mounted External Media Directory. Nov 4 12:41:15.987759 systemd[1]: Mounted Kernel Debug File System. Nov 4 12:41:15.988632 systemd[1]: Mounted Kernel Trace File System. Nov 4 12:41:15.989611 systemd[1]: Mounted Temporary Directory /tmp. Nov 4 12:41:15.990797 systemd[1]: Finished Create missing system files. Nov 4 12:41:15.991945 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:41:15.993035 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 4 12:41:15.993227 systemd[1]: Finished Load Kernel Module configfs. Nov 4 12:41:15.994257 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 4 12:41:15.994437 systemd[1]: Finished Load Kernel Module drm. Nov 4 12:41:15.995433 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 4 12:41:15.995614 systemd[1]: Finished Load Kernel Module fuse. Nov 4 12:41:15.996792 systemd[1]: Finished Remount Root and Kernel File Systems. Nov 4 12:41:15.997998 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:41:16.019826 systemd[1]: Mounting FUSE Control File System... Nov 4 12:41:16.021605 systemd[1]: Mounting Kernel Configuration File System... Nov 4 12:41:16.022474 systemd[1]: Condition check resulted in Remount Root File System being skipped. Nov 4 12:41:16.023818 systemd[1]: Starting Rebuild Hardware Database... Nov 4 12:41:16.025505 systemd[1]: Starting Flush Journal to Persistent Storage... Nov 4 12:41:16.026483 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Nov 4 12:41:16.027517 systemd[1]: Starting Load/Save Random Seed... Nov 4 12:41:16.030908 systemd-journald[799]: Time spent on flushing to /var/log/journal/a4c5883c7a7d49bfbad6e7d250c79ca5 is 8.122ms for 773 entries. Nov 4 12:41:16.030908 systemd-journald[799]: System Journal (/var/log/journal/a4c5883c7a7d49bfbad6e7d250c79ca5) is 8.0M, max 203.0M, 195.0M free. Nov 4 12:41:16.031256 systemd[1]: Starting Create System Users... Nov 4 12:41:16.034562 systemd[1]: Mounted FUSE Control File System. Nov 4 12:41:16.035637 systemd[1]: Mounted Kernel Configuration File System. Nov 4 12:41:16.036875 systemd[1]: Finished Load/Save Random Seed. Nov 4 12:41:16.037913 systemd[1]: Reached target First Boot Complete. Nov 4 12:41:16.039582 systemd-sysusers[811]: Creating group sgx with gid 999. Nov 4 12:41:16.040357 systemd-sysusers[811]: Creating group systemd-oom with gid 998. Nov 4 12:41:16.040808 systemd-sysusers[811]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Nov 4 12:41:16.041396 systemd-sysusers[811]: Creating group systemd-timesync with gid 997. Nov 4 12:41:16.041847 systemd-sysusers[811]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Nov 4 12:41:16.042280 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:41:16.046571 systemd[1]: Starting Wait for udev To Complete Device Initialization... Nov 4 12:41:16.048141 systemd-sysusers[811]: Creating group systemd-coredump with gid 996. Nov 4 12:41:16.048664 systemd-sysusers[811]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Nov 4 12:41:16.051003 systemd[1]: Finished Flush Journal to Persistent Storage. Nov 4 12:41:16.058175 systemd[1]: Finished Create System Users. Nov 4 12:41:16.059919 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:41:16.073160 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:41:16.269086 systemd[1]: Finished Rebuild Hardware Database. Nov 4 12:41:16.279000 audit: BPF prog-id=30 op=LOAD Nov 4 12:41:16.280000 audit: BPF prog-id=31 op=LOAD Nov 4 12:41:16.282148 kernel: audit: type=1334 audit(1762260076.279:53): prog-id=30 op=LOAD Nov 4 12:41:16.282195 kernel: audit: type=1334 audit(1762260076.280:54): prog-id=31 op=LOAD Nov 4 12:41:16.281000 audit: BPF prog-id=32 op=LOAD Nov 4 12:41:16.283540 kernel: audit: type=1334 audit(1762260076.281:55): prog-id=32 op=LOAD Nov 4 12:41:16.283589 kernel: audit: type=1334 audit(1762260076.282:56): prog-id=14 op=UNLOAD Nov 4 12:41:16.282000 audit: BPF prog-id=14 op=UNLOAD Nov 4 12:41:16.283512 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:41:16.282000 audit: BPF prog-id=15 op=UNLOAD Nov 4 12:41:16.307898 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:41:16.316000 audit: BPF prog-id=33 op=LOAD Nov 4 12:41:16.317861 systemd[1]: Starting Network Configuration... Nov 4 12:41:16.344155 systemd-networkd[835]: lo: Link UP Nov 4 12:41:16.344164 systemd-networkd[835]: lo: Gained carrier Nov 4 12:41:16.344449 systemd-networkd[835]: Enumeration completed Nov 4 12:41:16.344539 systemd[1]: Started Network Configuration. Nov 4 12:41:16.346185 systemd-udevd[833]: Using default interface naming scheme 'v249'. Nov 4 12:41:16.369018 udevadm[814]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Nov 4 12:41:16.376682 systemd-networkd[835]: eth0: Link UP Nov 4 12:41:16.391694 systemd-networkd[835]: eth0: Gained carrier Nov 4 12:41:16.400195 systemd[1]: Finished Wait for udev To Complete Device Initialization. Nov 4 12:41:16.405015 systemd-networkd[835]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Nov 4 12:41:16.416527 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:41:16.425507 lvm[843]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:41:16.456553 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:41:16.458034 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:41:16.467504 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:41:16.471690 lvm[845]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:41:16.493656 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:41:16.495165 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:41:16.496429 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Nov 4 12:41:16.496463 systemd[1]: Reached target Containers. Nov 4 12:41:16.515024 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Nov 4 12:41:16.528067 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Nov 4 12:41:16.530139 systemd[1]: Mounting /usr/share/oem... Nov 4 12:41:16.536124 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 4 12:41:16.536183 kernel: BTRFS info (device vda6): has skinny extents Nov 4 12:41:16.538319 systemd[1]: Mounted /usr/share/oem. Nov 4 12:41:16.539125 systemd[1]: Reached target Local File Systems. Nov 4 12:41:16.562671 systemd[1]: Starting Rebuild Dynamic Linker Cache... Nov 4 12:41:16.564216 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 4 12:41:16.564261 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Nov 4 12:41:16.565224 systemd[1]: Starting Commit a transient machine-id on disk... Nov 4 12:41:16.567164 systemd[1]: Starting Create Volatile Files and Directories... Nov 4 12:41:16.572826 systemd-tmpfiles[870]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 4 12:41:16.573834 systemd-tmpfiles[870]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Nov 4 12:41:16.580998 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 4 12:41:16.581692 systemd[1]: Finished Commit a transient machine-id on disk. Nov 4 12:41:16.600803 systemd-tmpfiles[870]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:41:16.600813 systemd-tmpfiles[870]: Skipping /boot Nov 4 12:41:16.605580 systemd-tmpfiles[870]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:41:16.605596 systemd-tmpfiles[870]: Skipping /boot Nov 4 12:41:16.633341 systemd[1]: Finished Rebuild Dynamic Linker Cache. Nov 4 12:41:16.651905 systemd[1]: Finished Create Volatile Files and Directories. Nov 4 12:41:16.661159 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:41:16.663483 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Nov 4 12:41:16.665703 systemd[1]: Starting Rebuild Journal Catalog... Nov 4 12:41:16.667000 audit: BPF prog-id=34 op=LOAD Nov 4 12:41:16.668590 systemd[1]: Starting Network Name Resolution... Nov 4 12:41:16.670000 audit: BPF prog-id=35 op=LOAD Nov 4 12:41:16.672135 systemd[1]: Starting Network Time Synchronization... Nov 4 12:41:16.673877 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Nov 4 12:41:16.675438 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Nov 4 12:41:16.676792 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Nov 4 12:41:16.680609 systemd[1]: Finished Rebuild Journal Catalog. Nov 4 12:41:16.687724 systemd[1]: Starting Update is Completed... Nov 4 12:41:16.690795 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Nov 4 12:41:16.691000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Nov 4 12:41:16.692153 systemd[1]: Finished Update is Completed. Nov 4 12:41:16.692281 augenrules[893]: No rules Nov 4 12:41:16.693351 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:41:16.716987 systemd-resolved[880]: Positive Trust Anchors: Nov 4 12:41:16.716998 systemd-resolved[880]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 4 12:41:16.717025 systemd-resolved[880]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Nov 4 12:41:16.717611 systemd[1]: Started Network Time Synchronization. Nov 4 12:41:16.717760 systemd-resolved[880]: Defaulting to hostname 'linux'. Nov 4 12:41:16.718304 systemd-timesyncd[881]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Nov 4 12:41:16.718811 systemd[1]: Reached target System Initialization. Nov 4 12:41:16.719825 systemd[1]: Started Watch for update engine configuration changes. Nov 4 12:41:16.720883 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 4 12:41:16.721992 systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 4 12:41:16.722955 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Nov 4 12:41:16.722986 systemd[1]: Reached target Path Units. Nov 4 12:41:16.723705 systemd[1]: Reached target System Time Set. Nov 4 12:41:16.724629 systemd[1]: Started Daily Log Rotation. Nov 4 12:41:16.725554 systemd[1]: Started Weekly check for MD array's redundancy information.. Nov 4 12:41:16.726703 systemd[1]: Reached target Timer Units. Nov 4 12:41:16.727767 systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 4 12:41:16.740664 systemd[1]: Starting Docker Socket for the API... Nov 4 12:41:16.743872 systemd[1]: Listening on OpenSSH Server Socket. Nov 4 12:41:16.745055 systemd[1]: Started Network Name Resolution. Nov 4 12:41:16.745976 systemd[1]: Listening on Docker Socket for the API. Nov 4 12:41:16.746884 systemd[1]: Reached target Network. Nov 4 12:41:16.747576 systemd[1]: Reached target Host and Network Name Lookups. Nov 4 12:41:16.748570 systemd[1]: Reached target Socket Units. Nov 4 12:41:16.749378 systemd[1]: Reached target Basic System. Nov 4 12:41:16.750227 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Nov 4 12:41:16.750258 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Nov 4 12:41:16.751213 systemd[1]: Started D-Bus System Message Bus. Nov 4 12:41:16.754566 systemd[1]: Starting Extend Filesystems... Nov 4 12:41:16.755476 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Nov 4 12:41:16.756492 systemd[1]: Starting Generate /run/flatcar/motd... Nov 4 12:41:16.758422 systemd[1]: Starting Install an ssh key from /proc/cmdline... Nov 4 12:41:16.761216 systemd[1]: Starting Generate sshd host keys... Nov 4 12:41:16.762174 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Nov 4 12:41:16.762204 systemd[1]: Reached target Load system-provided cloud configs. Nov 4 12:41:16.765984 extend-filesystems[902]: Found vda Nov 4 12:41:16.768384 extend-filesystems[902]: Found vda1 Nov 4 12:41:16.768384 extend-filesystems[902]: Found vda2 Nov 4 12:41:16.768384 extend-filesystems[902]: Found vda3 Nov 4 12:41:16.768384 extend-filesystems[902]: Found usr Nov 4 12:41:16.768384 extend-filesystems[902]: Found vda4 Nov 4 12:41:16.768384 extend-filesystems[902]: Found vda6 Nov 4 12:41:16.768384 extend-filesystems[902]: Found vda7 Nov 4 12:41:16.768384 extend-filesystems[902]: Found vda9 Nov 4 12:41:16.768384 extend-filesystems[902]: Checking size of /dev/vda9 Nov 4 12:41:16.766904 systemd[1]: Starting User Login Management... Nov 4 12:41:16.768094 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 4 12:41:16.768689 systemd[1]: Starting Update Engine... Nov 4 12:41:16.770496 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Nov 4 12:41:16.770525 systemd[1]: Reached target Load user-provided cloud configs. Nov 4 12:41:16.772218 systemd[1]: motdgen.service: Deactivated successfully. Nov 4 12:41:16.772434 systemd[1]: Finished Generate /run/flatcar/motd. Nov 4 12:41:16.774872 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 4 12:41:16.775089 systemd[1]: Finished Install an ssh key from /proc/cmdline. Nov 4 12:41:16.785550 extend-filesystems[902]: Old size kept for /dev/vda9 Nov 4 12:41:16.788210 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 4 12:41:16.788557 systemd[1]: Finished Extend Filesystems. Nov 4 12:41:16.805046 systemd-logind[914]: Watching system buttons on /dev/input/event0 (Power Button) Nov 4 12:41:16.805231 systemd-logind[914]: New seat seat0. Nov 4 12:41:16.808427 systemd[1]: Started User Login Management. Nov 4 12:41:16.810741 update_engine[918]: I1104 12:41:16.810468 918 main.cc:89] Flatcar Update Engine starting Nov 4 12:41:16.812946 systemd[1]: Started Update Engine. Nov 4 12:41:16.814040 update_engine[918]: I1104 12:41:16.813767 918 update_check_scheduler.cc:74] Next update check in 11m7s Nov 4 12:41:16.831949 systemd[1]: Started Cluster reboot manager. Nov 4 12:41:16.856364 locksmithd[926]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 4 12:41:17.275513 sshd_keygen[920]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Nov 4 12:41:17.292617 systemd[1]: Finished Generate sshd host keys. Nov 4 12:41:17.312657 systemd[1]: Starting Generate /run/issue... Nov 4 12:41:17.317208 systemd[1]: issuegen.service: Deactivated successfully. Nov 4 12:41:17.317419 systemd[1]: Finished Generate /run/issue. Nov 4 12:41:17.319376 systemd[1]: Starting Permit User Sessions... Nov 4 12:41:17.323887 systemd[1]: Finished Permit User Sessions. Nov 4 12:41:17.325724 systemd[1]: Started Getty on tty1. Nov 4 12:41:17.327476 systemd[1]: Started Serial Getty on ttyAMA0. Nov 4 12:41:17.328508 systemd[1]: Reached target Login Prompts. Nov 4 12:41:17.329413 systemd[1]: Reached target Multi-User System. Nov 4 12:41:17.331308 systemd[1]: Starting Record Runlevel Change in UTMP... Nov 4 12:41:17.335630 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 4 12:41:17.335849 systemd[1]: Finished Record Runlevel Change in UTMP. Nov 4 12:41:17.336787 systemd[1]: Startup finished in 694ms (kernel) + 2.308s (initrd) + 3.467s (userspace) = 6.470s. Nov 4 12:41:18.386178 systemd-networkd[835]: eth0: Gained IPv6LL Nov 4 12:41:23.188981 systemd[1]: Created slice Slice /system/sshd. Nov 4 12:41:23.190328 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40934). Nov 4 12:41:23.225898 sshd[948]: Accepted publickey for core from 10.0.0.1 port 40934 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:23.227476 sshd[948]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:23.245620 systemd[1]: Created slice User Slice of UID 500. Nov 4 12:41:23.247188 systemd[1]: Starting User Runtime Directory /run/user/500... Nov 4 12:41:23.248930 systemd-logind[914]: New session 1 of user core. Nov 4 12:41:23.253223 systemd[1]: Finished User Runtime Directory /run/user/500. Nov 4 12:41:23.254510 systemd[1]: Starting User Manager for UID 500... Nov 4 12:41:23.256501 systemd[951]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:23.305760 systemd[951]: Queued start job for default target Main User Target. Nov 4 12:41:23.305905 systemd[951]: Reached target Paths. Nov 4 12:41:23.305919 systemd[951]: Reached target Sockets. Nov 4 12:41:23.305929 systemd[951]: Reached target Timers. Nov 4 12:41:23.305939 systemd[951]: Reached target Basic System. Nov 4 12:41:23.305982 systemd[951]: Reached target Main User Target. Nov 4 12:41:23.305994 systemd[951]: Startup finished in 46ms. Nov 4 12:41:23.306073 systemd[1]: Started User Manager for UID 500. Nov 4 12:41:23.313226 systemd[1]: Started Session 1 of User core. Nov 4 12:41:23.371491 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40944). Nov 4 12:41:23.402933 sshd[960]: Accepted publickey for core from 10.0.0.1 port 40944 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:23.404009 sshd[960]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:23.406468 systemd-logind[914]: New session 2 of user core. Nov 4 12:41:23.420396 systemd[1]: Started Session 2 of User core. Nov 4 12:41:23.473711 sshd[960]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:23.495228 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:40944.service: Deactivated successfully. Nov 4 12:41:23.495902 systemd[1]: session-2.scope: Deactivated successfully. Nov 4 12:41:23.496620 systemd-logind[914]: Session 2 logged out. Waiting for processes to exit. Nov 4 12:41:23.497837 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40950). Nov 4 12:41:23.498610 systemd-logind[914]: Removed session 2. Nov 4 12:41:23.530025 sshd[966]: Accepted publickey for core from 10.0.0.1 port 40950 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:23.530902 sshd[966]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:23.533348 systemd-logind[914]: New session 3 of user core. Nov 4 12:41:23.543077 systemd[1]: Started Session 3 of User core. Nov 4 12:41:23.591909 sshd[966]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:23.600486 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:40950.service: Deactivated successfully. Nov 4 12:41:23.601122 systemd[1]: session-3.scope: Deactivated successfully. Nov 4 12:41:23.601808 systemd-logind[914]: Session 3 logged out. Waiting for processes to exit. Nov 4 12:41:23.602995 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40952). Nov 4 12:41:23.603699 systemd-logind[914]: Removed session 3. Nov 4 12:41:23.633679 sshd[972]: Accepted publickey for core from 10.0.0.1 port 40952 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:23.634572 sshd[972]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:23.637044 systemd-logind[914]: New session 4 of user core. Nov 4 12:41:23.645851 systemd[1]: Started Session 4 of User core. Nov 4 12:41:23.697664 sshd[972]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:23.716274 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:40952.service: Deactivated successfully. Nov 4 12:41:23.716939 systemd[1]: session-4.scope: Deactivated successfully. Nov 4 12:41:23.717644 systemd-logind[914]: Session 4 logged out. Waiting for processes to exit. Nov 4 12:41:23.718656 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40962). Nov 4 12:41:23.719345 systemd-logind[914]: Removed session 4. Nov 4 12:41:23.749638 sshd[978]: Accepted publickey for core from 10.0.0.1 port 40962 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:23.750793 sshd[978]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:23.753081 systemd-logind[914]: New session 5 of user core. Nov 4 12:41:23.764411 systemd[1]: Started Session 5 of User core. Nov 4 12:41:23.819061 sudo[981]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Nov 4 12:41:23.819256 sudo[981]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:41:23.836436 sudo[981]: pam_unix(sudo:session): session closed for user root Nov 4 12:41:23.838675 sshd[978]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:23.848226 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40970). Nov 4 12:41:23.849448 dbus-daemon[901]: [system] Reloaded configuration Nov 4 12:41:23.852024 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:40962.service: Deactivated successfully. Nov 4 12:41:23.852573 systemd[1]: session-5.scope: Deactivated successfully. Nov 4 12:41:23.853203 systemd-logind[914]: Session 5 logged out. Waiting for processes to exit. Nov 4 12:41:23.853932 systemd-logind[914]: Removed session 5. Nov 4 12:41:23.879747 sshd[984]: Accepted publickey for core from 10.0.0.1 port 40970 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:23.880867 sshd[984]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:23.883136 systemd-logind[914]: New session 6 of user core. Nov 4 12:41:23.895822 systemd[1]: Started Session 6 of User core. Nov 4 12:41:23.947114 sudo[989]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Nov 4 12:41:23.947323 sudo[989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:41:23.949544 sudo[989]: pam_unix(sudo:session): session closed for user root Nov 4 12:41:23.952974 sudo[988]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Nov 4 12:41:23.953171 sudo[988]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:41:23.970822 systemd[1]: Stopping Load Security Auditing Rules... Nov 4 12:41:23.970000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 4 12:41:23.972182 auditctl[992]: No rules Nov 4 12:41:23.972936 kernel: kauditd_printk_skb: 5 callbacks suppressed Nov 4 12:41:23.972981 kernel: audit: type=1305 audit(1762260083.970:62): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 4 12:41:23.973217 systemd[1]: audit-rules.service: Deactivated successfully. Nov 4 12:41:23.973445 systemd[1]: Stopped Load Security Auditing Rules. Nov 4 12:41:23.974691 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:41:23.988513 augenrules[1009]: No rules Nov 4 12:41:23.989400 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:41:23.990329 sudo[988]: pam_unix(sudo:session): session closed for user root Nov 4 12:41:23.991320 sshd[984]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:24.003419 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:40970.service: Deactivated successfully. Nov 4 12:41:24.004019 systemd[1]: session-6.scope: Deactivated successfully. Nov 4 12:41:24.004591 systemd-logind[914]: Session 6 logged out. Waiting for processes to exit. Nov 4 12:41:24.005575 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40972). Nov 4 12:41:24.006270 systemd-logind[914]: Removed session 6. Nov 4 12:41:24.038657 sshd[1015]: Accepted publickey for core from 10.0.0.1 port 40972 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:24.039687 sshd[1015]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:24.041750 kernel: audit: type=1006 audit(1762260084.038:63): pid=1015 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Nov 4 12:41:24.043417 systemd-logind[914]: New session 7 of user core. Nov 4 12:41:24.056041 systemd[1]: Started Session 7 of User core. Nov 4 12:41:24.106105 sudo[1019]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/bash -c cat >/etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem </etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem < Nov 4 12:41:26.905474 update_engine[1267]: Nov 4 12:41:26.905474 update_engine[1267]: Nov 4 12:41:26.905474 update_engine[1267]: Nov 4 12:41:26.905474 update_engine[1267]: Nov 4 12:41:26.905474 update_engine[1267]: Nov 4 12:41:26.905474 update_engine[1267]: Nov 4 12:41:26.905474 update_engine[1267]: Nov 4 12:41:26.905474 update_engine[1267]: Nov 4 12:41:26.905474 update_engine[1267]: I1104 12:41:26.905472 1267 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Nov 4 12:41:26.909448 update_engine[1267]: I1104 12:41:26.909408 1267 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Nov 4 12:41:26.909805 update_engine[1267]: I1104 12:41:26.909734 1267 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Nov 4 12:41:26.911667 update_engine[1267]: I1104 12:41:26.911410 1267 libcurl_http_fetcher.cc:248] HTTP response code: 200 Nov 4 12:41:26.911667 update_engine[1267]: I1104 12:41:26.911492 1267 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Nov 4 12:41:26.911667 update_engine[1267]: I1104 12:41:26.911501 1267 omaha_request_action.cc:619] Omaha request response: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.911667 update_engine[1267]: Nov 4 12:41:26.916634 update_engine[1267]: I1104 12:41:26.916530 1267 omaha_request_action.cc:447] Omaha Response manifest version = Nov 4 12:41:26.916634 update_engine[1267]: I1104 12:41:26.916561 1267 omaha_request_action.cc:470] Found 1 url(s) Nov 4 12:41:26.916634 update_engine[1267]: I1104 12:41:26.916574 1267 omaha_request_action.cc:506] Processing first of 1 package(s) Nov 4 12:41:26.916634 update_engine[1267]: I1104 12:41:26.916577 1267 omaha_request_action.cc:513] Omaha Response package name = update.gz Nov 4 12:41:26.916634 update_engine[1267]: I1104 12:41:26.916580 1267 omaha_request_action.cc:529] Url0: http://10.0.0.5:34567/packages/update.gz Nov 4 12:41:26.916634 update_engine[1267]: I1104 12:41:26.916589 1267 omaha_request_action.cc:541] Payload size = 439965385 bytes Nov 4 12:41:26.916634 update_engine[1267]: I1104 12:41:26.916599 1267 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Nov 4 12:41:26.916634 update_engine[1267]: I1104 12:41:26.916612 1267 payload_state.cc:51] Resetting all persisted state as this is a new response Nov 4 12:41:26.916634 update_engine[1267]: I1104 12:41:26.916616 1267 payload_state.cc:360] Current Response Signature = Nov 4 12:41:26.916634 update_engine[1267]: NumURLs = 1 Nov 4 12:41:26.916634 update_engine[1267]: Url0 = http://10.0.0.5:34567/packages/update.gz Nov 4 12:41:26.916634 update_engine[1267]: Payload Size = 439965385 Nov 4 12:41:26.916634 update_engine[1267]: Payload Sha256 Hash = +42QG3ah2EOUXfyDwaJG/hKpihone22jwnvEw5N2E4k= Nov 4 12:41:26.916634 update_engine[1267]: Is Delta Payload = 0 Nov 4 12:41:26.916634 update_engine[1267]: Max Failure Count Per Url = 10 Nov 4 12:41:26.916634 update_engine[1267]: Disable Payload Backoff = 1 Nov 4 12:41:26.916956 update_engine[1267]: I1104 12:41:26.916703 1267 payload_state.cc:381] Payload Attempt Number = 0 Nov 4 12:41:26.916956 update_engine[1267]: I1104 12:41:26.916754 1267 payload_state.cc:404] Current URL Index = 0 Nov 4 12:41:26.916956 update_engine[1267]: I1104 12:41:26.916785 1267 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Nov 4 12:41:26.916956 update_engine[1267]: I1104 12:41:26.916815 1267 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Nov 4 12:41:26.916956 update_engine[1267]: I1104 12:41:26.916819 1267 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Nov 4 12:41:26.916956 update_engine[1267]: I1104 12:41:26.916851 1267 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Nov 4 12:41:26.916956 update_engine[1267]: I1104 12:41:26.916869 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Nov 4 12:41:26.916956 update_engine[1267]: I1104 12:41:26.916873 1267 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Nov 4 12:41:26.916956 update_engine[1267]: I1104 12:41:26.916888 1267 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Nov 4 12:41:26.916956 update_engine[1267]: E1104 12:41:26.916893 1267 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Nov 4 12:41:26.917353 update_engine[1267]: I1104 12:41:26.917337 1267 omaha_response_handler_action.cc:85] Using this install plan: Nov 4 12:41:26.917353 update_engine[1267]: I1104 12:41:26.917347 1267 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.5:34567/packages/update.gz, payload size: 439965385, payload hash: +42QG3ah2EOUXfyDwaJG/hKpihone22jwnvEw5N2E4k=, 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 Nov 4 12:41:26.917438 update_engine[1267]: I1104 12:41:26.917420 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Nov 4 12:41:26.918634 update_engine[1267]: I1104 12:41:26.918594 1267 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Nov 4 12:41:26.975109 sshd[1280]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:26.978398 systemd[1]: sshd@24-10.0.0.6:22-10.0.0.1:41112.service: Deactivated successfully. Nov 4 12:41:26.979226 systemd[1]: session-25.scope: Deactivated successfully. Nov 4 12:41:26.979940 systemd-logind[914]: Session 25 logged out. Waiting for processes to exit. Nov 4 12:41:26.980663 systemd-logind[914]: Removed session 25. Nov 4 12:41:28.665217 update_engine[1267]: I1104 12:41:28.665176 1267 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Nov 4 12:41:28.665217 update_engine[1267]: I1104 12:41:28.665217 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Nov 4 12:41:28.730573 update_engine[1267]: E1104 12:41:28.730518 1267 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Nov 4 12:41:28.730573 update_engine[1267]: I1104 12:41:28.730561 1267 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Nov 4 12:41:28.730573 update_engine[1267]: I1104 12:41:28.730566 1267 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Nov 4 12:41:28.730573 update_engine[1267]: I1104 12:41:28.730569 1267 update_attempter.cc:302] Processing Done. Nov 4 12:41:28.730826 update_engine[1267]: E1104 12:41:28.730613 1267 update_attempter.cc:615] Update failed. Nov 4 12:41:28.730826 update_engine[1267]: I1104 12:41:28.730618 1267 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Nov 4 12:41:28.730826 update_engine[1267]: I1104 12:41:28.730623 1267 payload_state.cc:276] Incrementing the URL failure count Nov 4 12:41:28.730826 update_engine[1267]: I1104 12:41:28.730625 1267 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Nov 4 12:41:28.730905 update_engine[1267]: I1104 12:41:28.730870 1267 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Nov 4 12:41:28.730905 update_engine[1267]: I1104 12:41:28.730896 1267 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.5:34567/v1/update Nov 4 12:41:28.730905 update_engine[1267]: I1104 12:41:28.730901 1267 omaha_request_action.cc:269] Request: Nov 4 12:41:28.730905 update_engine[1267]: Nov 4 12:41:28.730905 update_engine[1267]: Nov 4 12:41:28.730905 update_engine[1267]: Nov 4 12:41:28.730905 update_engine[1267]: Nov 4 12:41:28.730905 update_engine[1267]: Nov 4 12:41:28.730905 update_engine[1267]: Nov 4 12:41:28.730905 update_engine[1267]: I1104 12:41:28.730904 1267 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Nov 4 12:41:28.731093 update_engine[1267]: I1104 12:41:28.730976 1267 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Nov 4 12:41:28.731093 update_engine[1267]: I1104 12:41:28.731078 1267 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Nov 4 12:41:28.920940 update_engine[1267]: I1104 12:41:28.920821 1267 libcurl_http_fetcher.cc:248] HTTP response code: 200 Nov 4 12:41:28.920940 update_engine[1267]: I1104 12:41:28.920921 1267 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Nov 4 12:41:28.920940 update_engine[1267]: I1104 12:41:28.920930 1267 omaha_request_action.cc:619] Omaha request response: Nov 4 12:41:28.920940 update_engine[1267]: Nov 4 12:41:28.920940 update_engine[1267]: Nov 4 12:41:28.920940 update_engine[1267]: Nov 4 12:41:28.920940 update_engine[1267]: Nov 4 12:41:28.920940 update_engine[1267]: Nov 4 12:41:28.920940 update_engine[1267]: Nov 4 12:41:28.920940 update_engine[1267]: E1104 12:41:28.920946 1267 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Nov 4 12:41:28.921216 update_engine[1267]: I1104 12:41:28.920953 1267 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 4 12:41:28.921216 update_engine[1267]: I1104 12:41:28.920955 1267 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 4 12:41:28.921216 update_engine[1267]: I1104 12:41:28.920958 1267 update_attempter.cc:302] Processing Done. Nov 4 12:41:28.921216 update_engine[1267]: I1104 12:41:28.920964 1267 update_attempter.cc:306] Error event sent. Nov 4 12:41:36.908706 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:46368). Nov 4 12:41:36.946360 sshd[1300]: Accepted publickey for core from 10.0.0.1 port 46368 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:36.948167 kernel: kauditd_printk_skb: 287 callbacks suppressed Nov 4 12:41:36.948223 kernel: audit: type=1006 audit(1762260096.946:359): pid=1300 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=26 res=1 Nov 4 12:41:36.948755 sshd[1300]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:36.951472 systemd-logind[914]: New session 26 of user core. Nov 4 12:41:36.965079 systemd[1]: Started Session 26 of User core. Nov 4 12:41:37.021692 sshd[1300]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:37.038383 systemd[1]: sshd@25-10.0.0.6:22-10.0.0.1:46368.service: Deactivated successfully. Nov 4 12:41:37.039064 systemd[1]: session-26.scope: Deactivated successfully. Nov 4 12:41:37.039604 systemd-logind[914]: Session 26 logged out. Waiting for processes to exit. Nov 4 12:41:37.040606 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:46372). Nov 4 12:41:37.041260 systemd-logind[914]: Removed session 26. Nov 4 12:41:37.076975 sshd[1307]: Accepted publickey for core from 10.0.0.1 port 46372 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:37.078409 sshd[1307]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:37.080788 kernel: audit: type=1006 audit(1762260097.076:360): pid=1307 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=27 res=1 Nov 4 12:41:37.081112 systemd-logind[914]: New session 27 of user core. Nov 4 12:41:37.097117 systemd[1]: Started Session 27 of User core. Nov 4 12:41:37.154203 sshd[1307]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:37.179495 systemd[1]: sshd@26-10.0.0.6:22-10.0.0.1:46372.service: Deactivated successfully. Nov 4 12:41:37.180064 systemd[1]: session-27.scope: Deactivated successfully. Nov 4 12:41:37.180692 systemd-logind[914]: Session 27 logged out. Waiting for processes to exit. Nov 4 12:41:37.181687 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:46388). Nov 4 12:41:37.182413 systemd-logind[914]: Removed session 27. Nov 4 12:41:37.214218 sshd[1315]: Accepted publickey for core from 10.0.0.1 port 46388 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:37.215305 sshd[1315]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:37.217760 kernel: audit: type=1006 audit(1762260097.214:361): pid=1315 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=28 res=1 Nov 4 12:41:37.219442 systemd-logind[914]: New session 28 of user core. Nov 4 12:41:37.250057 systemd[1]: Started Session 28 of User core. Nov 4 12:41:37.301638 sshd[1315]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:37.309580 systemd[1]: sshd@27-10.0.0.6:22-10.0.0.1:46388.service: Deactivated successfully. Nov 4 12:41:37.310093 systemd[1]: session-28.scope: Deactivated successfully. Nov 4 12:41:37.310686 systemd-logind[914]: Session 28 logged out. Waiting for processes to exit. Nov 4 12:41:37.311675 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:46396). Nov 4 12:41:37.312414 systemd-logind[914]: Removed session 28. Nov 4 12:41:37.343300 sshd[1321]: Accepted publickey for core from 10.0.0.1 port 46396 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:37.344214 sshd[1321]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:37.346764 kernel: audit: type=1006 audit(1762260097.342:362): pid=1321 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=29 res=1 Nov 4 12:41:37.346850 systemd-logind[914]: New session 29 of user core. Nov 4 12:41:37.364948 systemd[1]: Started Session 29 of User core. Nov 4 12:41:37.414576 sshd[1321]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:37.425274 systemd[1]: sshd@28-10.0.0.6:22-10.0.0.1:46396.service: Deactivated successfully. Nov 4 12:41:37.425811 systemd[1]: session-29.scope: Deactivated successfully. Nov 4 12:41:37.426363 systemd-logind[914]: Session 29 logged out. Waiting for processes to exit. Nov 4 12:41:37.427423 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:46400). Nov 4 12:41:37.428266 systemd-logind[914]: Removed session 29. Nov 4 12:41:37.459802 sshd[1327]: Accepted publickey for core from 10.0.0.1 port 46400 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:37.461576 sshd[1327]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:37.463771 kernel: audit: type=1006 audit(1762260097.460:363): pid=1327 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=30 res=1 Nov 4 12:41:37.464168 systemd-logind[914]: New session 30 of user core. Nov 4 12:41:37.481283 systemd[1]: Started Session 30 of User core. Nov 4 12:41:37.534691 sudo[1331]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Nov 4 12:41:37.534927 sudo[1331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:41:37.540514 systemd[1]: sshd.socket: Deactivated successfully. Nov 4 12:41:37.540863 systemd[1]: Closed OpenSSH Server Socket. Nov 4 12:41:37.541801 sudo[1331]: pam_unix(sudo:session): session closed for user root Nov 4 12:41:37.545218 sudo[1330]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Nov 4 12:41:37.545416 sudo[1330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:41:37.559142 systemd[1]: Stopping Session 1 of User core... Nov 4 12:41:37.559475 sshd[948]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:37.560217 systemd[1]: Stopping Session 30 of User core... Nov 4 12:41:37.560634 sudo[1330]: pam_unix(sudo:session): session closed for user root Nov 4 12:41:37.561047 sshd[1327]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:37.561552 systemd[1]: Removed slice Slice /system/addon-config. Nov 4 12:41:37.562977 systemd[1]: Removed slice Slice /system/addon-run. Nov 4 12:41:37.564265 systemd[1]: Removed slice Slice /system/modprobe. Nov 4 12:41:37.565474 systemd[1]: Removed slice Slice /system/system-cloudinit. Nov 4 12:41:37.566566 systemd[1]: Stopped target Multi-User System. Nov 4 12:41:37.567548 systemd[1]: Stopped target Login Prompts. Nov 4 12:41:37.568395 systemd[1]: Stopped target Containers. Nov 4 12:41:37.569202 systemd[1]: Stopped target Host and Network Name Lookups. Nov 4 12:41:37.570265 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 4 12:41:37.571235 systemd[1]: Stopped target Timer Units. Nov 4 12:41:37.572001 systemd[1]: logrotate.timer: Deactivated successfully. Nov 4 12:41:37.572046 systemd[1]: Stopped Daily Log Rotation. Nov 4 12:41:37.572798 systemd[1]: mdadm.timer: Deactivated successfully. Nov 4 12:41:37.572837 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Nov 4 12:41:37.573907 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Nov 4 12:41:37.573947 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Nov 4 12:41:37.574941 systemd[1]: Stopped target System Time Set. Nov 4 12:41:37.575770 systemd[1]: Stopped target Load user-provided cloud configs. Nov 4 12:41:37.577014 systemd[1]: Stopped target Load system-provided cloud configs. Nov 4 12:41:37.578097 systemd[1]: systemd-coredump.socket: Deactivated successfully. Nov 4 12:41:37.578190 systemd[1]: Closed Process Core Dump Socket. Nov 4 12:41:37.579761 systemd[1]: Unmounting Boot partition... Nov 4 12:41:37.580758 systemd[1]: Stopping Getty on tty1... Nov 4 12:41:37.583311 systemd[1]: Stopping Serial Getty on ttyAMA0... Nov 4 12:41:37.584293 systemd[1]: Stopping OpenSSH per-connection server daemon... Nov 4 12:41:37.585246 sshd[1327]: pam_systemd(sshd:session): Failed to release session: Interrupted system call Nov 4 12:41:37.585938 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:46400)... Nov 4 12:41:37.586867 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Nov 4 12:41:37.587017 systemd[1]: Stopped Commit a transient machine-id on disk. Nov 4 12:41:37.588069 systemd[1]: Stopped target First Boot Complete. Nov 4 12:41:37.596663 systemd[1]: Stopping Load/Save Random Seed... Nov 4 12:41:37.597707 systemd[1]: Stopping Update Engine... Nov 4 12:41:37.601231 systemd[1]: getty@tty1.service: Deactivated successfully. Nov 4 12:41:37.601523 systemd[1]: Stopped Getty on tty1. Nov 4 12:41:37.602718 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Nov 4 12:41:37.602924 systemd[1]: Stopped Serial Getty on ttyAMA0. Nov 4 12:41:37.604199 systemd[1]: sshd@0-10.0.0.6:22-10.0.0.1:40934.service: Deactivated successfully. Nov 4 12:41:37.604390 systemd[1]: Stopped OpenSSH per-connection server daemon. Nov 4 12:41:37.605936 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Nov 4 12:41:37.606020 systemd[1]: update-engine.service: Failed with result 'exit-code'. Nov 4 12:41:37.606267 systemd[1]: Stopped Update Engine. Nov 4 12:41:37.607038 systemd[1]: update-engine.service: Consumed 2.436s CPU time. Nov 4 12:41:37.607294 systemd[1]: sshd@29-10.0.0.6:22-10.0.0.1:46400.service: Deactivated successfully. Nov 4 12:41:37.607485 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:46400). Nov 4 12:41:37.620844 systemd[1]: boot.mount: Deactivated successfully. Nov 4 12:41:37.621139 systemd[1]: Unmounted Boot partition. Nov 4 12:41:37.622382 systemd[1]: systemd-random-seed.service: Deactivated successfully. Nov 4 12:41:37.622593 systemd[1]: Stopped Load/Save Random Seed. Nov 4 12:41:37.623629 systemd[1]: session-30.scope: Deactivated successfully. Nov 4 12:41:37.623869 systemd[1]: Stopped Session 30 of User core. Nov 4 12:41:37.624855 systemd[1]: session-1.scope: Deactivated successfully. Nov 4 12:41:37.625109 systemd[1]: Stopped Session 1 of User core. Nov 4 12:41:37.626462 systemd-logind[914]: Session 1 logged out. Waiting for processes to exit. Nov 4 12:41:37.627388 systemd-logind[914]: Session 30 logged out. Waiting for processes to exit. Nov 4 12:41:37.627631 systemd[1]: Removed slice Slice /system/getty. Nov 4 12:41:37.628843 systemd[1]: Removed slice Slice /system/serial-getty. Nov 4 12:41:37.630026 systemd[1]: Removed slice Slice /system/sshd. Nov 4 12:41:37.631101 systemd[1]: sshd-keygen.service: Deactivated successfully. Nov 4 12:41:37.631209 systemd[1]: Stopped Generate sshd host keys. Nov 4 12:41:37.632102 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Nov 4 12:41:37.632221 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Nov 4 12:41:37.633516 systemd[1]: Stopping User Login Management... Nov 4 12:41:37.634478 systemd[1]: Stopping User Manager for UID 500... Nov 4 12:41:37.635863 systemd[951]: Stopped target Main User Target. Nov 4 12:41:37.635889 systemd[951]: Stopped target Basic System. Nov 4 12:41:37.635899 systemd[951]: Stopped target Paths. Nov 4 12:41:37.635908 systemd[951]: Stopped target Sockets. Nov 4 12:41:37.635924 systemd[951]: Reached target Shutdown. Nov 4 12:41:37.635931 systemd[951]: Stopped target Timers. Nov 4 12:41:37.636048 systemd[951]: Finished Exit the Session. Nov 4 12:41:37.636073 systemd[951]: Reached target Exit the Session. Nov 4 12:41:37.636978 systemd-logind[914]: Removed session 30. Nov 4 12:41:37.638291 systemd[1]: user@500.service: Deactivated successfully. Nov 4 12:41:37.638468 systemd[1]: Stopped User Manager for UID 500. Nov 4 12:41:37.640504 systemd[1]: Stopping User Runtime Directory /run/user/500... Nov 4 12:41:37.645748 systemd[1]: run-user-500.mount: Deactivated successfully. Nov 4 12:41:37.645818 systemd[1]: Unmounted /run/user/500. Nov 4 12:41:37.646986 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Nov 4 12:41:37.647189 systemd[1]: Stopped User Runtime Directory /run/user/500. Nov 4 12:41:37.648810 systemd[1]: Removed slice User Slice of UID 500. Nov 4 12:41:37.650384 systemd[1]: Stopping D-Bus System Message Bus... Nov 4 12:41:37.652727 systemd[1]: Stopping Permit User Sessions... Nov 4 12:41:37.653982 systemd[1]: systemd-logind.service: Deactivated successfully. Nov 4 12:41:37.654238 systemd[1]: Stopped User Login Management. Nov 4 12:41:37.656025 systemd[1]: dbus.service: Deactivated successfully. Nov 4 12:41:37.656270 systemd[1]: Stopped D-Bus System Message Bus. Nov 4 12:41:37.657353 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Nov 4 12:41:37.657582 systemd[1]: Stopped Permit User Sessions. Nov 4 12:41:37.658518 systemd[1]: Stopped target Basic System. Nov 4 12:41:37.659323 systemd[1]: Stopped target Network. Nov 4 12:41:37.660045 systemd[1]: Stopped target Path Units. Nov 4 12:41:37.660771 systemd[1]: motdgen.path: Deactivated successfully. Nov 4 12:41:37.663000 audit: BPF prog-id=53 op=UNLOAD Nov 4 12:41:37.666929 kernel: audit: type=1334 audit(1762260097.663:364): prog-id=53 op=UNLOAD Nov 4 12:41:37.665813 systemd[1]: Stopped Watch for update engine configuration changes. Nov 4 12:41:37.667111 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Nov 4 12:41:37.674222 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 4 12:41:37.676154 systemd[1]: Stopped target Remote File Systems. Nov 4 12:41:37.677222 systemd[1]: Stopped target Slice Units. Nov 4 12:41:37.678313 systemd[1]: Removed slice User and Session Slice. Nov 4 12:41:37.679183 systemd[1]: Stopped target Socket Units. Nov 4 12:41:37.679989 systemd[1]: dbus.socket: Deactivated successfully. Nov 4 12:41:37.680044 systemd[1]: Closed D-Bus System Message Bus Socket. Nov 4 12:41:37.681079 systemd[1]: docker.socket: Deactivated successfully. Nov 4 12:41:37.681310 systemd[1]: Closed Docker Socket for the API. Nov 4 12:41:37.682156 systemd[1]: Stopped target System Initialization. Nov 4 12:41:37.683012 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Nov 4 12:41:37.683137 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Nov 4 12:41:37.684230 systemd[1]: Stopped target Local Verity Protected Volumes. Nov 4 12:41:37.686085 systemd[1]: Stopping Load Security Auditing Rules... Nov 4 12:41:37.687071 systemd[1]: Stopping Network Name Resolution... Nov 4 12:41:37.687897 auditctl[1345]: No rules Nov 4 12:41:37.688053 systemd[1]: Stopping Network Time Synchronization... Nov 4 12:41:37.688796 systemd[1]: systemd-update-done.service: Deactivated successfully. Nov 4 12:41:37.688879 systemd[1]: Stopped Update is Completed. Nov 4 12:41:37.689637 systemd[1]: ldconfig.service: Deactivated successfully. Nov 4 12:41:37.689715 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Nov 4 12:41:37.690658 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Nov 4 12:41:37.690747 systemd[1]: Stopped Rebuild Hardware Database. Nov 4 12:41:37.691548 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Nov 4 12:41:37.691616 systemd[1]: Stopped Rebuild Journal Catalog. Nov 4 12:41:37.693305 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Nov 4 12:41:37.695985 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 4 12:41:37.696233 systemd[1]: Stopped Network Name Resolution. Nov 4 12:41:37.697325 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Nov 4 12:41:37.697564 systemd[1]: Stopped Network Time Synchronization. Nov 4 12:41:37.698896 systemd[1]: audit-rules.service: Deactivated successfully. Nov 4 12:41:37.699099 systemd[1]: Stopped Load Security Auditing Rules. Nov 4 12:41:37.699000 audit: BPF prog-id=59 op=UNLOAD Nov 4 12:41:37.701765 kernel: audit: type=1334 audit(1762260097.699:365): prog-id=59 op=UNLOAD Nov 4 12:41:37.702607 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Nov 4 12:41:37.702850 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Nov 4 12:41:37.704486 systemd[1]: Stopping Network Configuration... Nov 4 12:41:37.704000 audit: BPF prog-id=61 op=UNLOAD Nov 4 12:41:37.706135 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 4 12:41:37.706204 systemd[1]: Stopped Create Volatile Files and Directories. Nov 4 12:41:37.706765 kernel: audit: type=1334 audit(1762260097.704:366): prog-id=61 op=UNLOAD Nov 4 12:41:37.707147 systemd[1]: Stopped target Local File Systems. Nov 4 12:41:37.708905 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Nov 4 12:41:37.710309 systemd[1]: Unmounting External Media Directory... Nov 4 12:41:37.710795 systemd-networkd[835]: eth0: DHCPv6 lease lost Nov 4 12:41:37.712007 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Nov 4 12:41:37.713793 systemd[1]: Unmounting /run/torcx/unpack... Nov 4 12:41:37.715017 systemd[1]: Unmounting Temporary Directory /tmp... Nov 4 12:41:37.716327 systemd[1]: Unmounting /usr/share/oem... Nov 4 12:41:37.717889 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Nov 4 12:41:37.720772 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 4 12:41:37.721027 systemd[1]: Stopped Network Configuration. Nov 4 12:41:37.721980 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Nov 4 12:41:37.722212 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Nov 4 12:41:37.723483 systemd[1]: media.mount: Deactivated successfully. Nov 4 12:41:37.723794 systemd[1]: Unmounted External Media Directory. Nov 4 12:41:37.724751 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Nov 4 12:41:37.724976 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Nov 4 12:41:37.726266 systemd[1]: tmp.mount: Deactivated successfully. Nov 4 12:41:37.726520 systemd[1]: Unmounted Temporary Directory /tmp. Nov 4 12:41:37.727682 systemd[1]: usr-share-oem.mount: Deactivated successfully. Nov 4 12:41:37.727933 systemd[1]: Unmounted /usr/share/oem. Nov 4 12:41:37.728844 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Nov 4 12:41:37.729076 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Nov 4 12:41:37.729000 audit: BPF prog-id=60 op=UNLOAD Nov 4 12:41:37.730506 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 4 12:41:37.730561 systemd[1]: Closed Network Service Netlink Socket. Nov 4 12:41:37.731769 kernel: audit: type=1334 audit(1762260097.729:367): prog-id=60 op=UNLOAD Nov 4 12:41:37.732375 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Nov 4 12:41:37.732447 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Nov 4 12:41:37.733752 systemd[1]: Removed slice Slice /system/systemd-fsck. Nov 4 12:41:37.734621 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 4 12:41:37.734696 systemd[1]: Stopped Apply Kernel Variables. Nov 4 12:41:37.735724 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Nov 4 12:41:37.735966 systemd[1]: Unmounted /run/torcx/unpack. Nov 4 12:41:37.736905 systemd[1]: Stopped target Preparation for Local File Systems. Nov 4 12:41:37.738119 systemd[1]: Stopped target Swaps. Nov 4 12:41:37.738811 systemd[1]: Reached target Unmount All Filesystems. Nov 4 12:41:37.739649 systemd[1]: lvm2-activation.service: Deactivated successfully. Nov 4 12:41:37.739724 systemd[1]: Stopped Activation of LVM2 logical volumes. Nov 4 12:41:37.740632 systemd[1]: Stopped target Local Encrypted Volumes. Nov 4 12:41:37.741593 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 4 12:41:37.741632 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 4 12:41:37.742759 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Nov 4 12:41:37.747030 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Nov 4 12:41:37.748169 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Nov 4 12:41:37.748253 systemd[1]: Stopped Activation of LVM2 logical volumes. Nov 4 12:41:37.749231 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 4 12:41:37.749301 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 4 12:41:37.750268 systemd[1]: systemd-sysusers.service: Deactivated successfully. Nov 4 12:41:37.750337 systemd[1]: Stopped Create System Users. Nov 4 12:41:37.751164 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Nov 4 12:41:37.751226 systemd[1]: Stopped Remount Root and Kernel File Systems. Nov 4 12:41:37.752242 systemd[1]: Reached target System Shutdown. Nov 4 12:41:37.753038 systemd[1]: Reached target Late Shutdown Services. Nov 4 12:41:37.753991 systemd[1]: systemd-reboot.service: Deactivated successfully. Nov 4 12:41:37.754035 systemd[1]: Finished System Reboot. Nov 4 12:41:37.754780 systemd[1]: Reached target System Reboot. Nov 4 12:41:37.755539 systemd[1]: Shutting down. Nov 4 12:41:37.757000 audit: BPF prog-id=55 op=UNLOAD Nov 4 12:41:37.757000 audit: BPF prog-id=54 op=UNLOAD Nov 4 12:41:37.757000 audit: BPF prog-id=58 op=UNLOAD Nov 4 12:41:37.757000 audit: BPF prog-id=57 op=UNLOAD Nov 4 12:41:37.757000 audit: BPF prog-id=56 op=UNLOAD Nov 4 12:41:37.758000 audit: BPF prog-id=64 op=UNLOAD Nov 4 12:41:37.758000 audit: BPF prog-id=63 op=UNLOAD Nov 4 12:41:37.758000 audit: BPF prog-id=62 op=UNLOAD Nov 4 12:41:37.759752 kernel: audit: type=1334 audit(1762260097.757:368): prog-id=55 op=UNLOAD Nov 4 12:41:37.792787 systemd-shutdown[1]: Syncing filesystems and block devices. Nov 4 12:41:37.797534 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Nov 4 12:41:37.797591 systemd-journald[799]: Journal stopped -- Reboot -- Nov 4 12:41:45.676470 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 4 12:41:45.676486 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 Nov 4 12:41:45.676494 kernel: efi: EFI v2.70 by EDK II Nov 4 12:41:45.676500 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Nov 4 12:41:45.676504 kernel: efi: seeding entropy pool Nov 4 12:41:45.676509 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Nov 4 12:41:45.676515 kernel: ACPI: Early table checksum verification disabled Nov 4 12:41:45.676520 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Nov 4 12:41:45.676525 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 4 12:41:45.676530 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:45.676536 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:45.676541 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:45.676546 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:45.676551 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:45.676557 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:45.676562 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:45.676569 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:45.676574 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:41:45.676580 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 4 12:41:45.676585 kernel: ACPI: NUMA: Failed to initialise from firmware Nov 4 12:41:45.676590 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:41:45.676595 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Nov 4 12:41:45.676600 kernel: Zone ranges: Nov 4 12:41:45.676605 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:41:45.676610 kernel: DMA32 empty Nov 4 12:41:45.676615 kernel: Normal empty Nov 4 12:41:45.676620 kernel: Movable zone start for each node Nov 4 12:41:45.676627 kernel: Early memory node ranges Nov 4 12:41:45.676632 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Nov 4 12:41:45.676637 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Nov 4 12:41:45.676642 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Nov 4 12:41:45.676647 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Nov 4 12:41:45.676652 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Nov 4 12:41:45.676657 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Nov 4 12:41:45.676662 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Nov 4 12:41:45.676667 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 4 12:41:45.676673 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 4 12:41:45.676678 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 4 12:41:45.676683 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 4 12:41:45.676688 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:41:45.676696 kernel: On node 0 totalpages: 643072 Nov 4 12:41:45.676702 kernel: DMA zone: 10048 pages used for memmap Nov 4 12:41:45.676707 kernel: DMA zone: 0 pages reserved Nov 4 12:41:45.676713 kernel: DMA zone: 643072 pages, LIFO batch:63 Nov 4 12:41:45.676718 kernel: psci: probing for conduit method from ACPI. Nov 4 12:41:45.676724 kernel: psci: PSCIv1.1 detected in firmware. Nov 4 12:41:45.676729 kernel: psci: Using standard PSCI v0.2 function IDs Nov 4 12:41:45.676734 kernel: psci: Trusted OS migration not required Nov 4 12:41:45.676741 kernel: psci: SMC Calling Convention v1.1 Nov 4 12:41:45.676746 kernel: ACPI: SRAT not present Nov 4 12:41:45.676752 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Nov 4 12:41:45.676757 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Nov 4 12:41:45.676763 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 4 12:41:45.676768 kernel: Detected PIPT I-cache on CPU0 Nov 4 12:41:45.676774 kernel: CPU features: detected: GIC system register CPU interface Nov 4 12:41:45.676779 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 4 12:41:45.676784 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 4 12:41:45.676790 kernel: CPU features: detected: Hardware dirty bit management Nov 4 12:41:45.676795 kernel: CPU features: detected: Spectre-v4 Nov 4 12:41:45.676802 kernel: CPU features: detected: ARM erratum 1418040 Nov 4 12:41:45.676807 kernel: CPU features: detected: Spectre-BHB Nov 4 12:41:45.676812 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 4 12:41:45.676818 kernel: Policy zone: DMA Nov 4 12:41:45.676824 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 Nov 4 12:41:45.676830 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 4 12:41:45.676835 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 4 12:41:45.676841 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 4 12:41:45.676847 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Nov 4 12:41:45.676852 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Nov 4 12:41:45.676858 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 4 12:41:45.676864 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 4 12:41:45.676882 kernel: rcu: RCU event tracing is enabled. Nov 4 12:41:45.676888 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 4 12:41:45.676893 kernel: Trampoline variant of Tasks RCU enabled. Nov 4 12:41:45.676899 kernel: Tracing variant of Tasks RCU enabled. Nov 4 12:41:45.676904 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 4 12:41:45.676910 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 4 12:41:45.676915 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 4 12:41:45.676921 kernel: GICv3: 256 SPIs implemented Nov 4 12:41:45.676926 kernel: GICv3: 0 Extended SPIs implemented Nov 4 12:41:45.676932 kernel: GICv3: Distributor has no Range Selector support Nov 4 12:41:45.676937 kernel: GICv3: 16 PPIs implemented Nov 4 12:41:45.676944 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 4 12:41:45.676949 kernel: ACPI: SRAT not present Nov 4 12:41:45.676955 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 4 12:41:45.676960 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Nov 4 12:41:45.676966 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Nov 4 12:41:45.676971 kernel: GICv3: using LPI property table @0x00000000400d0000 Nov 4 12:41:45.676977 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Nov 4 12:41:45.676982 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:41:45.676988 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 4 12:41:45.676994 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 4 12:41:45.676999 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 4 12:41:45.677005 kernel: arm-pv: using stolen time PV Nov 4 12:41:45.677012 kernel: Console: colour dummy device 80x25 Nov 4 12:41:45.677018 kernel: ACPI: Core revision 20200925 Nov 4 12:41:45.677024 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 4 12:41:45.677030 kernel: pid_max: default: 32768 minimum: 301 Nov 4 12:41:45.677035 kernel: LSM: Security Framework initializing Nov 4 12:41:45.677041 kernel: SELinux: Initializing. Nov 4 12:41:45.677047 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:41:45.677052 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:41:45.677058 kernel: rcu: Hierarchical SRCU implementation. Nov 4 12:41:45.677065 kernel: Platform MSI: ITS@0x8080000 domain created Nov 4 12:41:45.677070 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 4 12:41:45.677076 kernel: Remapping and enabling EFI services. Nov 4 12:41:45.677081 kernel: smp: Bringing up secondary CPUs ... Nov 4 12:41:45.677087 kernel: Detected PIPT I-cache on CPU1 Nov 4 12:41:45.677093 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 4 12:41:45.677098 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Nov 4 12:41:45.677104 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:41:45.677110 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 4 12:41:45.677118 kernel: Detected PIPT I-cache on CPU2 Nov 4 12:41:45.677126 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 4 12:41:45.677132 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Nov 4 12:41:45.677138 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:41:45.677144 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 4 12:41:45.677150 kernel: Detected PIPT I-cache on CPU3 Nov 4 12:41:45.677159 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 4 12:41:45.677169 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Nov 4 12:41:45.677177 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:41:45.677185 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 4 12:41:45.677192 kernel: smp: Brought up 1 node, 4 CPUs Nov 4 12:41:45.677198 kernel: SMP: Total of 4 processors activated. Nov 4 12:41:45.677204 kernel: CPU features: detected: Privileged Access Never Nov 4 12:41:45.677210 kernel: CPU features: detected: LSE atomic instructions Nov 4 12:41:45.677217 kernel: CPU features: detected: User Access Override Nov 4 12:41:45.677226 kernel: CPU features: detected: 32-bit EL0 Support Nov 4 12:41:45.677233 kernel: CPU features: detected: Common not Private translations Nov 4 12:41:45.677241 kernel: CPU features: detected: RAS Extension Support Nov 4 12:41:45.677249 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 4 12:41:45.677255 kernel: CPU features: detected: CRC32 instructions Nov 4 12:41:45.677261 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 4 12:41:45.677267 kernel: CPU: All CPU(s) started at EL1 Nov 4 12:41:45.677273 kernel: alternatives: patching kernel code Nov 4 12:41:45.677280 kernel: devtmpfs: initialized Nov 4 12:41:45.677286 kernel: KASLR enabled Nov 4 12:41:45.677292 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 4 12:41:45.677298 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 4 12:41:45.677304 kernel: pinctrl core: initialized pinctrl subsystem Nov 4 12:41:45.677310 kernel: SMBIOS 3.0.0 present. Nov 4 12:41:45.677316 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Nov 4 12:41:45.677322 kernel: NET: Registered protocol family 16 Nov 4 12:41:45.677328 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 4 12:41:45.677340 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 4 12:41:45.677348 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 4 12:41:45.677354 kernel: audit: initializing netlink subsys (disabled) Nov 4 12:41:45.677360 kernel: audit: type=2000 audit(0.032:1): state=initialized audit_enabled=0 res=1 Nov 4 12:41:45.677366 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 4 12:41:45.677372 kernel: cpuidle: using governor menu Nov 4 12:41:45.677378 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 4 12:41:45.677384 kernel: ASID allocator initialised with 32768 entries Nov 4 12:41:45.677390 kernel: ACPI: bus type PCI registered Nov 4 12:41:45.677396 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 4 12:41:45.677403 kernel: Serial: AMBA PL011 UART driver Nov 4 12:41:45.677408 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 4 12:41:45.677414 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 4 12:41:45.677421 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 4 12:41:45.677427 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 4 12:41:45.677433 kernel: cryptd: max_cpu_qlen set to 1000 Nov 4 12:41:45.677439 kernel: ACPI: Added _OSI(Module Device) Nov 4 12:41:45.677445 kernel: ACPI: Added _OSI(Processor Device) Nov 4 12:41:45.677451 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 4 12:41:45.677458 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 4 12:41:45.677464 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 4 12:41:45.677469 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 4 12:41:45.677475 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 4 12:41:45.677481 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 4 12:41:45.677487 kernel: ACPI: Interpreter enabled Nov 4 12:41:45.677493 kernel: ACPI: Using GIC for interrupt routing Nov 4 12:41:45.677499 kernel: ACPI: MCFG table detected, 1 entries Nov 4 12:41:45.677505 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 4 12:41:45.677511 kernel: printk: console [ttyAMA0] enabled Nov 4 12:41:45.677518 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 4 12:41:45.677623 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 4 12:41:45.677679 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 4 12:41:45.677731 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 4 12:41:45.677782 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 4 12:41:45.677834 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 4 12:41:45.677842 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 4 12:41:45.677850 kernel: PCI host bridge to bus 0000:00 Nov 4 12:41:45.677921 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 4 12:41:45.677971 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 4 12:41:45.678019 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 4 12:41:45.678065 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 4 12:41:45.678131 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 4 12:41:45.678193 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 4 12:41:45.678251 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 4 12:41:45.678306 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 4 12:41:45.678370 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:41:45.678426 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:41:45.678485 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 4 12:41:45.678547 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 4 12:41:45.678596 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 4 12:41:45.678646 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 4 12:41:45.678694 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 4 12:41:45.678702 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Nov 4 12:41:45.678709 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Nov 4 12:41:45.678715 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Nov 4 12:41:45.678721 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Nov 4 12:41:45.678727 kernel: vgaarb: loaded Nov 4 12:41:45.678732 kernel: Registered efivars operations Nov 4 12:41:45.678739 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 4 12:41:45.678746 kernel: VFS: Disk quotas dquot_6.6.0 Nov 4 12:41:45.678752 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 4 12:41:45.678758 kernel: pnp: PnP ACPI init Nov 4 12:41:45.678820 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 4 12:41:45.678914 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Nov 4 12:41:45.678925 kernel: pnp: PnP ACPI: found 1 devices Nov 4 12:41:45.678931 kernel: NET: Registered protocol family 2 Nov 4 12:41:45.678937 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 4 12:41:45.678946 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 4 12:41:45.678952 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 4 12:41:45.678958 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 4 12:41:45.678964 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 4 12:41:45.678970 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:41:45.678977 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:41:45.678983 kernel: NET: Registered protocol family 1 Nov 4 12:41:45.678989 kernel: PCI: CLS 0 bytes, default 64 Nov 4 12:41:45.678995 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 4 12:41:45.679002 kernel: kvm [1]: HYP mode not available Nov 4 12:41:45.679008 kernel: Initialise system trusted keyrings Nov 4 12:41:45.679014 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 4 12:41:45.679020 kernel: Key type asymmetric registered Nov 4 12:41:45.679026 kernel: Asymmetric key parser 'x509' registered Nov 4 12:41:45.679032 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 4 12:41:45.679038 kernel: io scheduler mq-deadline registered Nov 4 12:41:45.679044 kernel: io scheduler kyber registered Nov 4 12:41:45.679050 kernel: io scheduler bfq registered Nov 4 12:41:45.679057 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 4 12:41:45.679063 kernel: ACPI: Power Button [PWRB] Nov 4 12:41:45.679069 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Nov 4 12:41:45.679128 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 4 12:41:45.679137 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 4 12:41:45.679143 kernel: msm_serial: driver initialized Nov 4 12:41:45.679149 kernel: random: fast init done Nov 4 12:41:45.679155 kernel: random: crng init done Nov 4 12:41:45.679161 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Nov 4 12:41:45.679167 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Nov 4 12:41:45.679174 kernel: thunder_xcv, ver 1.0 Nov 4 12:41:45.679180 kernel: thunder_bgx, ver 1.0 Nov 4 12:41:45.679186 kernel: nicpf, ver 1.0 Nov 4 12:41:45.679192 kernel: nicvf, ver 1.0 Nov 4 12:41:45.679252 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 4 12:41:45.679302 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-04T12:41:45 UTC (1762260105) Nov 4 12:41:45.679310 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 4 12:41:45.679316 kernel: NET: Registered protocol family 10 Nov 4 12:41:45.679323 kernel: Segment Routing with IPv6 Nov 4 12:41:45.679329 kernel: NET: Registered protocol family 17 Nov 4 12:41:45.679343 kernel: Key type dns_resolver registered Nov 4 12:41:45.679350 kernel: registered taskstats version 1 Nov 4 12:41:45.679356 kernel: Loading compiled-in X.509 certificates Nov 4 12:41:45.679362 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Nov 4 12:41:45.679368 kernel: Key type ._fscrypt registered Nov 4 12:41:45.679374 kernel: Key type .fscrypt registered Nov 4 12:41:45.679380 kernel: Key type fscrypt-provisioning registered Nov 4 12:41:45.679387 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 4 12:41:45.679393 kernel: ima: Allocated hash algorithm: sha1 Nov 4 12:41:45.679399 kernel: ima: No architecture policies found Nov 4 12:41:45.679405 kernel: Freeing unused kernel memory: 34240K Nov 4 12:41:45.679411 kernel: Run /init as init process Nov 4 12:41:45.679417 kernel: with arguments: Nov 4 12:41:45.679423 kernel: /init Nov 4 12:41:45.679428 kernel: with environment: Nov 4 12:41:45.679434 kernel: HOME=/ Nov 4 12:41:45.679440 kernel: TERM=linux Nov 4 12:41:45.679447 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 4 12:41:45.679454 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) Nov 4 12:41:45.679462 systemd[1]: Detected virtualization kvm. Nov 4 12:41:45.679469 systemd[1]: Detected architecture arm64. Nov 4 12:41:45.679475 systemd[1]: Running in initial RAM disk. Nov 4 12:41:45.679482 systemd[1]: No hostname configured, using default hostname. Nov 4 12:41:45.679488 systemd[1]: Hostname set to . Nov 4 12:41:45.679495 systemd[1]: Initializing machine ID from VM UUID. Nov 4 12:41:45.679502 systemd[1]: Queued start job for default target Initrd Default Target. Nov 4 12:41:45.679508 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:41:45.679515 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:41:45.679521 systemd[1]: Reached target Path Units. Nov 4 12:41:45.679527 systemd[1]: Reached target Slice Units. Nov 4 12:41:45.679534 systemd[1]: Reached target Swaps. Nov 4 12:41:45.679540 systemd[1]: Reached target Timer Units. Nov 4 12:41:45.679548 systemd[1]: Listening on Open-iSCSI iscsid Socket. Nov 4 12:41:45.679554 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Nov 4 12:41:45.679561 systemd[1]: Listening on Journal Audit Socket. Nov 4 12:41:45.679567 systemd[1]: Listening on Journal Socket (/dev/log). Nov 4 12:41:45.679573 systemd[1]: Listening on Journal Socket. Nov 4 12:41:45.679580 systemd[1]: Listening on udev Control Socket. Nov 4 12:41:45.679586 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:41:45.679593 systemd[1]: Reached target Socket Units. Nov 4 12:41:45.679599 systemd[1]: Starting iSCSI UserSpace I/O driver... Nov 4 12:41:45.679607 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:41:45.679613 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Nov 4 12:41:45.679619 systemd[1]: Starting Journal Service... Nov 4 12:41:45.679626 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:41:45.679632 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:41:45.679638 systemd[1]: Starting Setup Virtual Console... Nov 4 12:41:45.679644 kernel: SCSI subsystem initialized Nov 4 12:41:45.679651 systemd[1]: Started iSCSI UserSpace I/O driver. Nov 4 12:41:45.679657 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:41:45.679664 kernel: Loading iSCSI transport class v2.0-870. Nov 4 12:41:45.679670 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:41:45.679677 systemd[1]: Finished Setup Virtual Console. Nov 4 12:41:45.679685 systemd-journald[270]: Journal started Nov 4 12:41:45.679721 systemd-journald[270]: Runtime Journal (/run/log/journal/a4c5883c7a7d49bfbad6e7d250c79ca5) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:41:45.681195 systemd[1]: Started Journal Service. Nov 4 12:41:45.681993 systemd[1]: Starting dracut ask for additional cmdline parameters... Nov 4 12:41:45.683384 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:41:45.686347 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:41:45.696225 systemd[1]: Finished dracut ask for additional cmdline parameters. Nov 4 12:41:45.697805 systemd[1]: Starting dracut cmdline hook... Nov 4 12:41:45.706148 dracut-cmdline[292]: dracut-dracut-053 Nov 4 12:41:45.708326 dracut-cmdline[292]: 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 Nov 4 12:41:45.761903 kernel: iscsi: registered transport (tcp) Nov 4 12:41:45.772909 kernel: iscsi: registered transport (qla4xxx) Nov 4 12:41:45.772941 kernel: QLogic iSCSI HBA Driver Nov 4 12:41:45.781657 systemd[1]: Finished dracut cmdline hook. Nov 4 12:41:45.783038 systemd[1]: Starting dracut pre-udev hook... Nov 4 12:41:45.784249 systemd[1]: Starting Open-iSCSI... Nov 4 12:41:45.786505 iscsid[378]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:41:45.786505 iscsid[378]: 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]. Nov 4 12:41:45.786505 iscsid[378]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 4 12:41:45.786505 iscsid[378]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 4 12:41:45.786505 iscsid[378]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:41:45.786505 iscsid[378]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 4 12:41:45.799430 kernel: device-mapper: uevent: version 1.0.3 Nov 4 12:41:45.799447 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Nov 4 12:41:45.790096 systemd[1]: Started Open-iSCSI. Nov 4 12:41:45.832894 kernel: raid6: neonx8 gen() 13768 MB/s Nov 4 12:41:45.849887 kernel: raid6: neonx8 xor() 10730 MB/s Nov 4 12:41:45.866895 kernel: raid6: neonx4 gen() 13584 MB/s Nov 4 12:41:45.883889 kernel: raid6: neonx4 xor() 11553 MB/s Nov 4 12:41:45.900891 kernel: raid6: neonx2 gen() 12984 MB/s Nov 4 12:41:45.917891 kernel: raid6: neonx2 xor() 9819 MB/s Nov 4 12:41:45.934893 kernel: raid6: neonx1 gen() 10895 MB/s Nov 4 12:41:45.951883 kernel: raid6: neonx1 xor() 8820 MB/s Nov 4 12:41:45.968886 kernel: raid6: int64x8 gen() 6817 MB/s Nov 4 12:41:45.985885 kernel: raid6: int64x8 xor() 3787 MB/s Nov 4 12:41:46.002884 kernel: raid6: int64x4 gen() 6887 MB/s Nov 4 12:41:46.019885 kernel: raid6: int64x4 xor() 3826 MB/s Nov 4 12:41:46.036891 kernel: raid6: int64x2 gen() 6172 MB/s Nov 4 12:41:46.053886 kernel: raid6: int64x2 xor() 3298 MB/s Nov 4 12:41:46.070890 kernel: raid6: int64x1 gen() 4999 MB/s Nov 4 12:41:46.087969 kernel: raid6: int64x1 xor() 2598 MB/s Nov 4 12:41:46.087992 kernel: raid6: using algorithm neonx8 gen() 13768 MB/s Nov 4 12:41:46.088008 kernel: raid6: .... xor() 10730 MB/s, rmw enabled Nov 4 12:41:46.089037 kernel: raid6: using neon recovery algorithm Nov 4 12:41:46.099284 kernel: xor: measuring software checksum speed Nov 4 12:41:46.099312 kernel: 8regs : 17159 MB/sec Nov 4 12:41:46.100282 kernel: 32regs : 20755 MB/sec Nov 4 12:41:46.101138 kernel: arm64_neon : 29173 MB/sec Nov 4 12:41:46.101150 kernel: xor: using function: arm64_neon (29173 MB/sec) Nov 4 12:41:46.145889 kernel: Btrfs loaded, crc32c=crc32c-generic Nov 4 12:41:46.155535 systemd[1]: Finished dracut pre-udev hook. Nov 4 12:41:46.156000 audit: BPF prog-id=6 op=LOAD Nov 4 12:41:46.156000 audit: BPF prog-id=7 op=LOAD Nov 4 12:41:46.156000 audit: BPF prog-id=8 op=LOAD Nov 4 12:41:46.157312 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:41:46.160420 kernel: audit: type=1334 audit(1762260106.156:2): prog-id=6 op=LOAD Nov 4 12:41:46.160437 kernel: audit: type=1334 audit(1762260106.156:3): prog-id=7 op=LOAD Nov 4 12:41:46.160450 kernel: audit: type=1334 audit(1762260106.156:4): prog-id=8 op=LOAD Nov 4 12:41:46.169735 systemd-udevd[410]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:41:46.171420 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:41:46.173145 systemd[1]: Starting dracut pre-trigger hook... Nov 4 12:41:46.184973 dracut-pre-trigger[418]: rd.md=0: removing MD RAID activation Nov 4 12:41:46.206344 systemd[1]: Finished dracut pre-trigger hook. Nov 4 12:41:46.207675 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:41:46.216577 systemd-udevd[410]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:41:46.235005 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:41:46.236404 systemd[1]: Starting dracut initqueue hook... Nov 4 12:41:46.250044 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 4 12:41:46.250190 kernel: vda: detected capacity change from 0 to 4756340736 Nov 4 12:41:46.262886 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:41:46.266007 systemd-udevd[471]: Using default interface naming scheme 'v249'. Nov 4 12:41:46.279889 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (457) Nov 4 12:41:46.280845 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Nov 4 12:41:46.281948 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Nov 4 12:41:46.287274 systemd[1]: Found device /dev/disk/by-label/ROOT. Nov 4 12:41:46.293369 systemd[1]: Reached target Initrd Root Device. Nov 4 12:41:46.294785 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Nov 4 12:41:46.296018 systemd[1]: Finished dracut initqueue hook. Nov 4 12:41:46.297663 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 4 12:41:46.297768 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Nov 4 12:41:46.299162 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:41:46.300763 systemd[1]: Reached target Preparation for Remote File Systems. Nov 4 12:41:46.302598 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:41:46.304200 systemd[1]: Reached target Remote File Systems. Nov 4 12:41:46.306315 systemd[1]: Starting dracut pre-mount hook... Nov 4 12:41:46.307590 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Nov 4 12:41:46.315089 systemd[1]: Finished dracut pre-mount hook. Nov 4 12:41:46.316595 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Nov 4 12:41:46.322886 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 4 12:41:46.326514 systemd-fsck[508]: ROOT: clean, 640/553792 files, 39961/553472 blocks Nov 4 12:41:46.330123 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Nov 4 12:41:46.331730 systemd[1]: Mounting /sysroot... Nov 4 12:41:46.342723 systemd[1]: Found device /dev/mapper/usr. Nov 4 12:41:46.344708 systemd[1]: Starting File System Check on /dev/mapper/usr... Nov 4 12:41:46.346446 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Nov 4 12:41:46.354437 systemd-fsck[518]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Nov 4 12:41:46.354437 systemd-fsck[518]: You must have r/w access to the filesystem or be root Nov 4 12:41:46.357267 systemd-fsck[515]: fsck failed with exit status 8. Nov 4 12:41:46.357275 systemd-fsck[515]: Ignoring error. Nov 4 12:41:46.357958 systemd[1]: Finished File System Check on /dev/mapper/usr. Nov 4 12:41:46.359976 systemd[1]: Mounting /sysusr/usr... Nov 4 12:41:46.373269 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Nov 4 12:41:46.373298 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Nov 4 12:41:46.373725 systemd[1]: Mounted /sysroot. Nov 4 12:41:46.374494 systemd[1]: Reached target Initrd Root File System. Nov 4 12:41:46.376325 systemd[1]: Starting Reload Configuration from the Real Root... Nov 4 12:41:46.380280 systemd[1]: Reloading. Nov 4 12:41:46.382000 audit: BPF prog-id=6 op=UNLOAD Nov 4 12:41:46.382000 audit: BPF prog-id=3 op=UNLOAD Nov 4 12:41:46.385099 kernel: audit: type=1334 audit(1762260106.382:5): prog-id=6 op=UNLOAD Nov 4 12:41:46.385128 kernel: audit: type=1334 audit(1762260106.382:6): prog-id=3 op=UNLOAD Nov 4 12:41:46.386752 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Nov 4 12:41:46.464000 audit: BPF prog-id=9 op=LOAD Nov 4 12:41:46.465000 audit: BPF prog-id=10 op=LOAD Nov 4 12:41:46.467338 kernel: audit: type=1334 audit(1762260106.464:7): prog-id=9 op=LOAD Nov 4 12:41:46.467357 kernel: audit: type=1334 audit(1762260106.465:8): prog-id=10 op=LOAD Nov 4 12:41:46.467366 kernel: audit: type=1334 audit(1762260106.466:9): prog-id=11 op=LOAD Nov 4 12:41:46.466000 audit: BPF prog-id=11 op=LOAD Nov 4 12:41:46.466000 audit: BPF prog-id=7 op=UNLOAD Nov 4 12:41:46.468917 kernel: audit: type=1334 audit(1762260106.466:10): prog-id=7 op=UNLOAD Nov 4 12:41:46.466000 audit: BPF prog-id=8 op=UNLOAD Nov 4 12:41:46.467000 audit: BPF prog-id=12 op=LOAD Nov 4 12:41:46.468000 audit: BPF prog-id=13 op=LOAD Nov 4 12:41:46.468000 audit: BPF prog-id=14 op=LOAD Nov 4 12:41:46.468000 audit: BPF prog-id=4 op=UNLOAD Nov 4 12:41:46.468000 audit: BPF prog-id=5 op=UNLOAD Nov 4 12:41:46.469972 systemd[1]: Mounted /sysusr/usr. Nov 4 12:41:46.471935 systemd[1]: Reached target Local File Systems. Nov 4 12:41:46.472748 systemd[1]: Reached target System Initialization. Nov 4 12:41:46.474199 systemd[1]: Reached target Basic System. Nov 4 12:41:46.476829 systemd[1]: Mounting /sysroot/usr... Nov 4 12:41:46.480767 systemd[1]: Mounted /sysroot/usr. Nov 4 12:41:46.486297 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 4 12:41:46.486419 systemd[1]: Finished Reload Configuration from the Real Root. Nov 4 12:41:46.488276 systemd[1]: Reached target Initrd File Systems. Nov 4 12:41:46.489701 systemd[1]: Reached target Initrd Default Target. Nov 4 12:41:46.491163 systemd[1]: Condition check resulted in dracut mount hook being skipped. Nov 4 12:41:46.491777 systemd[1]: Starting dracut pre-pivot and cleanup hook... Nov 4 12:41:46.501243 systemd[1]: Finished dracut pre-pivot and cleanup hook. Nov 4 12:41:46.502752 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Nov 4 12:41:46.508105 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 4 12:41:46.509066 systemd[1]: Stopped target Timer Units. Nov 4 12:41:46.510420 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 4 12:41:46.510525 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Nov 4 12:41:46.511854 systemd[1]: Stopped target Initrd Default Target. Nov 4 12:41:46.513459 systemd[1]: Stopped target Basic System. Nov 4 12:41:46.514805 systemd[1]: Stopped target Initrd Root Device. Nov 4 12:41:46.516264 systemd[1]: Stopped target Path Units. Nov 4 12:41:46.517544 systemd[1]: Stopped target Remote File Systems. Nov 4 12:41:46.518936 systemd[1]: Stopped target Preparation for Remote File Systems. Nov 4 12:41:46.520450 systemd[1]: Stopped target Slice Units. Nov 4 12:41:46.521738 systemd[1]: Stopped target Socket Units. Nov 4 12:41:46.523237 systemd[1]: Stopped target System Initialization. Nov 4 12:41:46.524581 systemd[1]: Stopped target Local File Systems. Nov 4 12:41:46.525920 systemd[1]: Stopped target Preparation for Local File Systems. Nov 4 12:41:46.527496 systemd[1]: Stopped target Swaps. Nov 4 12:41:46.528690 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 4 12:41:46.528788 systemd[1]: Stopped dracut pre-mount hook. Nov 4 12:41:46.530270 systemd[1]: Stopped target Local Encrypted Volumes. Nov 4 12:41:46.531504 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 4 12:41:46.538158 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 4 12:41:46.539814 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 4 12:41:46.539942 systemd[1]: Stopped dracut initqueue hook. Nov 4 12:41:46.543178 iscsid[378]: iscsid shutting down. Nov 4 12:41:46.543229 systemd[1]: Stopping Open-iSCSI... Nov 4 12:41:46.544294 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 4 12:41:46.544415 systemd[1]: Stopped Apply Kernel Variables. Nov 4 12:41:46.545717 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 4 12:41:46.545803 systemd[1]: Stopped Coldplug All udev Devices. Nov 4 12:41:46.547277 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 4 12:41:46.547374 systemd[1]: Stopped dracut pre-trigger hook. Nov 4 12:41:46.551002 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Nov 4 12:41:46.552908 systemd[1]: iscsid.service: Deactivated successfully. Nov 4 12:41:46.553013 systemd[1]: Stopped Open-iSCSI. Nov 4 12:41:46.554476 systemd[1]: iscsid.socket: Deactivated successfully. Nov 4 12:41:46.554520 systemd[1]: Closed Open-iSCSI iscsid Socket. Nov 4 12:41:46.555708 systemd[1]: Stopping iSCSI UserSpace I/O driver... Nov 4 12:41:46.557181 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 4 12:41:46.557292 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Nov 4 12:41:46.558691 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 4 12:41:46.558791 systemd[1]: Stopped iSCSI UserSpace I/O driver. Nov 4 12:41:46.560074 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 4 12:41:46.560166 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Nov 4 12:41:46.562046 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 4 12:41:46.562091 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Nov 4 12:41:46.562901 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 4 12:41:46.562939 systemd[1]: Closed udev Control Socket. Nov 4 12:41:46.564387 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 4 12:41:46.564416 systemd[1]: Closed udev Kernel Socket. Nov 4 12:41:46.565825 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 4 12:41:46.565863 systemd[1]: Stopped dracut pre-udev hook. Nov 4 12:41:46.567272 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 4 12:41:46.567309 systemd[1]: Stopped dracut cmdline hook. Nov 4 12:41:46.568750 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 4 12:41:46.584000 audit: BPF prog-id=9 op=UNLOAD Nov 4 12:41:46.568787 systemd[1]: Stopped dracut ask for additional cmdline parameters. Nov 4 12:41:46.571088 systemd[1]: Starting Cleanup udev Database... Nov 4 12:41:46.572098 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Nov 4 12:41:46.573418 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 4 12:41:46.573474 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 4 12:41:46.588000 audit: BPF prog-id=12 op=UNLOAD Nov 4 12:41:46.574859 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 4 12:41:46.574917 systemd[1]: Stopped Create List of Static Device Nodes. Nov 4 12:41:46.576612 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 4 12:41:46.576652 systemd[1]: Stopped Setup Virtual Console. Nov 4 12:41:46.578067 systemd[1]: rngd.service: Deactivated successfully. Nov 4 12:41:46.578168 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Nov 4 12:41:46.579747 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 4 12:41:46.579842 systemd[1]: Finished Cleanup udev Database. Nov 4 12:41:46.580941 systemd[1]: Reached target Switch Root. Nov 4 12:41:46.582892 systemd[1]: Starting Switch Root... Nov 4 12:41:46.588163 systemd[1]: Switching root. Nov 4 12:41:46.602066 systemd-journald[270]: Journal stopped Nov 4 12:41:48.650980 systemd-journald[270]: Received SIGTERM from PID 1 (systemd). Nov 4 12:41:48.651029 kernel: SELinux: policy capability network_peer_controls=1 Nov 4 12:41:48.651042 kernel: SELinux: policy capability open_perms=1 Nov 4 12:41:48.651056 kernel: SELinux: policy capability extended_socket_class=1 Nov 4 12:41:48.651065 kernel: SELinux: policy capability always_check_network=0 Nov 4 12:41:48.651077 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 4 12:41:48.651086 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 4 12:41:48.651095 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 4 12:41:48.651105 systemd[1]: Successfully loaded SELinux policy in 30.246ms. Nov 4 12:41:48.651118 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.220ms. Nov 4 12:41:48.651129 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) Nov 4 12:41:48.651139 systemd[1]: Detected virtualization kvm. Nov 4 12:41:48.651149 systemd[1]: Detected architecture arm64. Nov 4 12:41:48.651161 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. Nov 4 12:41:48.651172 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 4 12:41:48.651182 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 4 12:41:48.651192 systemd[1]: Stopped Switch Root. Nov 4 12:41:48.651202 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 4 12:41:48.651211 systemd[1]: Created slice Slice /system/addon-config. Nov 4 12:41:48.651221 systemd[1]: Created slice Slice /system/addon-run. Nov 4 12:41:48.651232 systemd[1]: Created slice Slice /system/getty. Nov 4 12:41:48.651243 systemd[1]: Created slice Slice /system/modprobe. Nov 4 12:41:48.651253 systemd[1]: Created slice Slice /system/serial-getty. Nov 4 12:41:48.651262 systemd[1]: Created slice Slice /system/system-cloudinit. Nov 4 12:41:48.651272 systemd[1]: Created slice Slice /system/systemd-fsck. Nov 4 12:41:48.651281 systemd[1]: Created slice User and Session Slice. Nov 4 12:41:48.651291 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:41:48.651301 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Nov 4 12:41:48.651310 systemd[1]: Set up automount Boot partition Automount Point. Nov 4 12:41:48.651330 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 4 12:41:48.651341 systemd[1]: Stopped target Switch Root. Nov 4 12:41:48.651351 systemd[1]: Stopped target Initrd File Systems. Nov 4 12:41:48.651361 systemd[1]: Stopped target Initrd Root File System. Nov 4 12:41:48.651371 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:41:48.651380 systemd[1]: Reached target Remote File Systems. Nov 4 12:41:48.651390 systemd[1]: Reached target Slice Units. Nov 4 12:41:48.651400 systemd[1]: Reached target Swaps. Nov 4 12:41:48.651409 systemd[1]: Reached target Verify torcx succeeded. Nov 4 12:41:48.651419 systemd[1]: Reached target Local Verity Protected Volumes. Nov 4 12:41:48.651430 systemd[1]: Listening on Process Core Dump Socket. Nov 4 12:41:48.651440 systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 4 12:41:48.651450 systemd[1]: Listening on Network Service Netlink Socket. Nov 4 12:41:48.651460 systemd[1]: Listening on udev Control Socket. Nov 4 12:41:48.651470 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:41:48.651479 systemd[1]: Mounting Huge Pages File System... Nov 4 12:41:48.651489 systemd[1]: Mounting POSIX Message Queue File System... Nov 4 12:41:48.651499 systemd[1]: Mounting External Media Directory... Nov 4 12:41:48.651509 systemd[1]: Mounting Kernel Debug File System... Nov 4 12:41:48.651520 systemd[1]: Mounting Kernel Trace File System... Nov 4 12:41:48.651530 systemd[1]: Mounting Temporary Directory /tmp... Nov 4 12:41:48.651539 systemd[1]: Starting Create missing system files... Nov 4 12:41:48.651549 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:41:48.651559 systemd[1]: Starting Load Kernel Module configfs... Nov 4 12:41:48.651571 systemd[1]: Starting Load Kernel Module drm... Nov 4 12:41:48.651581 systemd[1]: Starting Load Kernel Module fuse... Nov 4 12:41:48.651591 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Nov 4 12:41:48.651601 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 4 12:41:48.651611 systemd[1]: Stopped File System Check on Root Device. Nov 4 12:41:48.651633 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 4 12:41:48.651643 systemd[1]: Stopped systemd-fsck-usr.service. Nov 4 12:41:48.651652 systemd[1]: Stopped Journal Service. Nov 4 12:41:48.651661 kernel: fuse: init (API version 7.32) Nov 4 12:41:48.651670 systemd[1]: Starting Journal Service... Nov 4 12:41:48.651681 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:41:48.651690 systemd[1]: Starting Remount Root and Kernel File Systems... Nov 4 12:41:48.651726 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:41:48.651737 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:41:48.651748 systemd[1]: verity-setup.service: Deactivated successfully. Nov 4 12:41:48.651759 systemd[1]: Stopped verity-setup.service. Nov 4 12:41:48.651770 systemd-journald[697]: Journal started Nov 4 12:41:48.651805 systemd-journald[697]: Runtime Journal (/run/log/journal/a4c5883c7a7d49bfbad6e7d250c79ca5) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:41:46.672000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 4 12:41:46.697000 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 Nov 4 12:41:46.697000 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 Nov 4 12:41:46.697000 audit: BPF prog-id=15 op=LOAD Nov 4 12:41:46.697000 audit: BPF prog-id=15 op=UNLOAD Nov 4 12:41:46.698000 audit: BPF prog-id=16 op=LOAD Nov 4 12:41:46.698000 audit: BPF prog-id=16 op=UNLOAD Nov 4 12:41:46.729000 audit[649]: AVC avc: denied { associate } for pid=649 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 Nov 4 12:41:48.517000 audit: BPF prog-id=17 op=LOAD Nov 4 12:41:48.517000 audit: BPF prog-id=18 op=LOAD Nov 4 12:41:48.517000 audit: BPF prog-id=19 op=LOAD Nov 4 12:41:48.517000 audit: BPF prog-id=13 op=UNLOAD Nov 4 12:41:48.517000 audit: BPF prog-id=14 op=UNLOAD Nov 4 12:41:48.531000 audit: BPF prog-id=20 op=LOAD Nov 4 12:41:48.531000 audit: BPF prog-id=17 op=UNLOAD Nov 4 12:41:48.532000 audit: BPF prog-id=21 op=LOAD Nov 4 12:41:48.532000 audit: BPF prog-id=22 op=LOAD Nov 4 12:41:48.532000 audit: BPF prog-id=18 op=UNLOAD Nov 4 12:41:48.532000 audit: BPF prog-id=19 op=UNLOAD Nov 4 12:41:48.533000 audit: BPF prog-id=23 op=LOAD Nov 4 12:41:48.533000 audit: BPF prog-id=20 op=UNLOAD Nov 4 12:41:48.533000 audit: BPF prog-id=24 op=LOAD Nov 4 12:41:48.533000 audit: BPF prog-id=25 op=LOAD Nov 4 12:41:48.533000 audit: BPF prog-id=21 op=UNLOAD Nov 4 12:41:48.533000 audit: BPF prog-id=22 op=UNLOAD Nov 4 12:41:48.541000 audit: BPF prog-id=23 op=UNLOAD Nov 4 12:41:48.636000 audit: BPF prog-id=26 op=LOAD Nov 4 12:41:48.636000 audit: BPF prog-id=27 op=LOAD Nov 4 12:41:48.636000 audit: BPF prog-id=28 op=LOAD Nov 4 12:41:48.636000 audit: BPF prog-id=24 op=UNLOAD Nov 4 12:41:48.636000 audit: BPF prog-id=25 op=UNLOAD Nov 4 12:41:48.649000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Nov 4 12:41:48.517825 systemd[1]: Queued start job for default target Multi-User System. Nov 4 12:41:46.729016 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" 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]" Nov 4 12:41:48.534456 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 4 12:41:46.729238 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:41:46.729263 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:41:46.729519 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 4 12:41:46.729530 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 4 12:41:46.729560 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 4 12:41:46.729573 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 4 12:41:46.729838 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 4 12:41:46.729890 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:41:46.729905 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:41:46.730230 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" 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 Nov 4 12:41:46.730259 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" 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 Nov 4 12:41:48.653392 systemd[1]: Started Journal Service. Nov 4 12:41:46.730278 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" 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 Nov 4 12:41:46.730294 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Nov 4 12:41:46.730393 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" 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 Nov 4 12:41:46.730408 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:46Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 4 12:41:48.424784 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:48Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:41:48.425067 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:48Z" 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 Nov 4 12:41:48.425161 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:48Z" 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 Nov 4 12:41:48.425282 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:48Z" 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 Nov 4 12:41:48.425385 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:48Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 4 12:41:48.425441 /usr/lib/systemd/system-generators/torcx-generator[649]: time="2025-11-04T12:41:48Z" 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 Nov 4 12:41:48.653922 systemd[1]: Mounted Huge Pages File System. Nov 4 12:41:48.654837 systemd[1]: Mounted POSIX Message Queue File System. Nov 4 12:41:48.655791 systemd[1]: Mounted External Media Directory. Nov 4 12:41:48.656757 systemd[1]: Mounted Kernel Debug File System. Nov 4 12:41:48.657690 systemd[1]: Mounted Kernel Trace File System. Nov 4 12:41:48.658624 systemd[1]: Mounted Temporary Directory /tmp. Nov 4 12:41:48.659762 systemd[1]: Finished Create missing system files. Nov 4 12:41:48.660986 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:41:48.662069 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 4 12:41:48.662256 systemd[1]: Finished Load Kernel Module configfs. Nov 4 12:41:48.663307 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 4 12:41:48.663492 systemd[1]: Finished Load Kernel Module drm. Nov 4 12:41:48.664541 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 4 12:41:48.664707 systemd[1]: Finished Load Kernel Module fuse. Nov 4 12:41:48.678524 systemd[1]: Finished Remount Root and Kernel File Systems. Nov 4 12:41:48.680568 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:41:48.683326 systemd[1]: Mounting FUSE Control File System... Nov 4 12:41:48.685055 systemd[1]: Mounting Kernel Configuration File System... Nov 4 12:41:48.685881 systemd[1]: Condition check resulted in Remount Root File System being skipped. Nov 4 12:41:48.686722 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Nov 4 12:41:48.687737 systemd[1]: Starting Flush Journal to Persistent Storage... Nov 4 12:41:48.688735 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Nov 4 12:41:48.689600 systemd[1]: Starting Load/Save Random Seed... Nov 4 12:41:48.692680 systemd-journald[697]: Time spent on flushing to /var/log/journal/a4c5883c7a7d49bfbad6e7d250c79ca5 is 11.862ms for 666 entries. Nov 4 12:41:48.692680 systemd-journald[697]: System Journal (/var/log/journal/a4c5883c7a7d49bfbad6e7d250c79ca5) is 8.0M, max 203.0M, 195.0M free. Nov 4 12:41:48.708000 audit: BPF prog-id=29 op=LOAD Nov 4 12:41:48.708000 audit: BPF prog-id=30 op=LOAD Nov 4 12:41:48.708000 audit: BPF prog-id=31 op=LOAD Nov 4 12:41:48.708000 audit: BPF prog-id=10 op=UNLOAD Nov 4 12:41:48.708000 audit: BPF prog-id=11 op=UNLOAD Nov 4 12:41:48.690524 systemd[1]: Condition check resulted in Create System Users being skipped. Nov 4 12:41:48.691447 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:41:48.693135 systemd[1]: Mounted FUSE Control File System. Nov 4 12:41:48.695169 systemd[1]: Mounted Kernel Configuration File System. Nov 4 12:41:48.698487 systemd[1]: Finished Load/Save Random Seed. Nov 4 12:41:48.699855 systemd[1]: Condition check resulted in First Boot Complete being skipped. Nov 4 12:41:48.700608 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:41:48.706689 systemd[1]: Starting Wait for udev To Complete Device Initialization... Nov 4 12:41:48.708006 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:41:48.710296 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:41:48.717469 systemd[1]: Finished Flush Journal to Persistent Storage. Nov 4 12:41:48.734464 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:41:48.736000 audit: BPF prog-id=32 op=LOAD Nov 4 12:41:48.737682 systemd[1]: Starting Network Configuration... Nov 4 12:41:48.764932 systemd-udevd[712]: Using default interface naming scheme 'v249'. Nov 4 12:41:48.766150 systemd-networkd[723]: lo: Link UP Nov 4 12:41:48.766163 systemd-networkd[723]: lo: Gained carrier Nov 4 12:41:48.766468 systemd-networkd[723]: Enumeration completed Nov 4 12:41:48.766557 systemd[1]: Started Network Configuration. Nov 4 12:41:48.795162 udevadm[709]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Nov 4 12:41:48.796539 systemd-networkd[723]: eth0: Link UP Nov 4 12:41:48.805522 systemd-networkd[723]: eth0: Gained carrier Nov 4 12:41:48.811052 systemd[1]: Finished Wait for udev To Complete Device Initialization. Nov 4 12:41:48.825040 systemd-networkd[723]: eth0: DHCPv4 address 10.0.0.6/16 via 10.0.0.1 Nov 4 12:41:48.838458 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:41:48.846568 lvm[738]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:41:48.876537 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:41:48.878015 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:41:48.890768 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:41:48.893848 lvm[739]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:41:48.917684 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:41:48.919190 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:41:48.920477 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Nov 4 12:41:48.920509 systemd[1]: Reached target Containers. Nov 4 12:41:48.942073 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Nov 4 12:41:48.953301 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Nov 4 12:41:48.955350 systemd[1]: Mounting /usr/share/oem... Nov 4 12:41:48.961280 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 4 12:41:48.961343 kernel: BTRFS info (device vda6): has skinny extents Nov 4 12:41:48.963410 systemd[1]: Mounted /usr/share/oem. Nov 4 12:41:48.964200 systemd[1]: Reached target Local File Systems. Nov 4 12:41:48.965069 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Nov 4 12:41:48.965400 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 4 12:41:48.965436 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Nov 4 12:41:48.965462 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Nov 4 12:41:48.966299 systemd[1]: Starting Create Volatile Files and Directories... Nov 4 12:41:48.971814 systemd-tmpfiles[762]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 4 12:41:48.972841 systemd-tmpfiles[762]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Nov 4 12:41:48.999907 systemd-tmpfiles[762]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:41:48.999917 systemd-tmpfiles[762]: Skipping /boot Nov 4 12:41:49.005131 systemd-tmpfiles[762]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:41:49.005149 systemd-tmpfiles[762]: Skipping /boot Nov 4 12:41:49.033165 systemd[1]: Finished Create Volatile Files and Directories. Nov 4 12:41:49.050750 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:41:49.052587 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Nov 4 12:41:49.053735 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Nov 4 12:41:49.053000 audit: BPF prog-id=33 op=LOAD Nov 4 12:41:49.055166 systemd[1]: Starting Network Name Resolution... Nov 4 12:41:49.055000 audit: BPF prog-id=34 op=LOAD Nov 4 12:41:49.057214 systemd[1]: Starting Network Time Synchronization... Nov 4 12:41:49.058719 systemd[1]: Condition check resulted in Update is Completed being skipped. Nov 4 12:41:49.059614 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Nov 4 12:41:49.061085 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Nov 4 12:41:49.062252 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Nov 4 12:41:49.066939 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Nov 4 12:41:49.081000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Nov 4 12:41:49.082187 augenrules[783]: No rules Nov 4 12:41:49.083016 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:41:49.095547 systemd-resolved[766]: Positive Trust Anchors: Nov 4 12:41:49.095560 systemd-resolved[766]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 4 12:41:49.095588 systemd-resolved[766]: 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 Nov 4 12:41:49.096293 systemd-resolved[766]: Defaulting to hostname 'linux'. Nov 4 12:41:49.098404 systemd-timesyncd[772]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Nov 4 12:41:49.104561 systemd[1]: Started Network Name Resolution. Nov 4 12:41:49.105847 systemd[1]: Started Network Time Synchronization. Nov 4 12:41:49.106960 systemd[1]: Reached target Network. Nov 4 12:41:49.107681 systemd[1]: Reached target Host and Network Name Lookups. Nov 4 12:41:49.108706 systemd[1]: Reached target System Initialization. Nov 4 12:41:49.109728 systemd[1]: Started Watch for update engine configuration changes. Nov 4 12:41:49.110857 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 4 12:41:49.111943 systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 4 12:41:49.112925 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Nov 4 12:41:49.112954 systemd[1]: Reached target Path Units. Nov 4 12:41:49.113676 systemd[1]: Reached target System Time Set. Nov 4 12:41:49.114703 systemd[1]: Started Daily Log Rotation. Nov 4 12:41:49.115573 systemd[1]: Started Weekly check for MD array's redundancy information.. Nov 4 12:41:49.116706 systemd[1]: Reached target Timer Units. Nov 4 12:41:49.117758 systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 4 12:41:49.139895 systemd[1]: Starting Docker Socket for the API... Nov 4 12:41:49.143489 systemd[1]: Listening on OpenSSH Server Socket. Nov 4 12:41:49.144741 systemd[1]: Listening on Docker Socket for the API. Nov 4 12:41:49.145704 systemd[1]: Reached target Socket Units. Nov 4 12:41:49.146513 systemd[1]: Reached target Basic System. Nov 4 12:41:49.147336 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Nov 4 12:41:49.147364 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Nov 4 12:41:49.148229 systemd[1]: Started D-Bus System Message Bus. Nov 4 12:41:49.151581 systemd[1]: Starting Extend Filesystems... Nov 4 12:41:49.152456 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Nov 4 12:41:49.153457 systemd[1]: Starting Generate /run/flatcar/motd... Nov 4 12:41:49.155403 systemd[1]: Starting Install an ssh key from /proc/cmdline... Nov 4 12:41:49.157821 systemd[1]: Starting Generate sshd host keys... Nov 4 12:41:49.158732 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Nov 4 12:41:49.158771 systemd[1]: Reached target Load system-provided cloud configs. Nov 4 12:41:49.162310 systemd[1]: Starting User Login Management... Nov 4 12:41:49.163553 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 4 12:41:49.164136 systemd[1]: Starting Update Engine... Nov 4 12:41:49.165008 extend-filesystems[792]: Found vda Nov 4 12:41:49.165711 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Nov 4 12:41:49.165734 systemd[1]: Reached target Load user-provided cloud configs. Nov 4 12:41:49.167359 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 4 12:41:49.167570 systemd[1]: Finished Install an ssh key from /proc/cmdline. Nov 4 12:41:49.168243 extend-filesystems[792]: Found vda1 Nov 4 12:41:49.168243 extend-filesystems[792]: Found vda2 Nov 4 12:41:49.168243 extend-filesystems[792]: Found vda3 Nov 4 12:41:49.168243 extend-filesystems[792]: Found usr Nov 4 12:41:49.168243 extend-filesystems[792]: Found vda4 Nov 4 12:41:49.168243 extend-filesystems[792]: Found vda6 Nov 4 12:41:49.168243 extend-filesystems[792]: Found vda7 Nov 4 12:41:49.168243 extend-filesystems[792]: Found vda9 Nov 4 12:41:49.168243 extend-filesystems[792]: Checking size of /dev/vda9 Nov 4 12:41:49.188227 extend-filesystems[792]: Old size kept for /dev/vda9 Nov 4 12:41:49.179357 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 4 12:41:49.179617 systemd[1]: Finished Extend Filesystems. Nov 4 12:41:49.181734 systemd[1]: motdgen.service: Deactivated successfully. Nov 4 12:41:49.182019 systemd[1]: Finished Generate /run/flatcar/motd. Nov 4 12:41:49.198717 systemd-logind[803]: Watching system buttons on /dev/input/event0 (Power Button) Nov 4 12:41:49.198883 systemd-logind[803]: New seat seat0. Nov 4 12:41:49.205923 systemd[1]: Started User Login Management. Nov 4 12:41:49.214791 update_engine[804]: I1104 12:41:49.214543 804 main.cc:89] Flatcar Update Engine starting Nov 4 12:41:49.215673 update_engine[804]: I1104 12:41:49.215644 804 payload_state.cc:360] Current Response Signature = Nov 4 12:41:49.215673 update_engine[804]: NumURLs = 1 Nov 4 12:41:49.215673 update_engine[804]: Url0 = http://10.0.0.5:34567/packages/update.gz Nov 4 12:41:49.215673 update_engine[804]: Payload Size = 439965385 Nov 4 12:41:49.215673 update_engine[804]: Payload Sha256 Hash = +42QG3ah2EOUXfyDwaJG/hKpihone22jwnvEw5N2E4k= Nov 4 12:41:49.215673 update_engine[804]: Is Delta Payload = 0 Nov 4 12:41:49.215673 update_engine[804]: Max Failure Count Per Url = 10 Nov 4 12:41:49.215673 update_engine[804]: Disable Payload Backoff = 1 Nov 4 12:41:49.215857 systemd[1]: Finished Generate sshd host keys. Nov 4 12:41:49.215932 update_engine[804]: I1104 12:41:49.215857 804 payload_state.cc:381] Payload Attempt Number = 0 Nov 4 12:41:49.216794 update_engine[804]: I1104 12:41:49.216764 804 payload_state.cc:404] Current URL Index = 0 Nov 4 12:41:49.216970 update_engine[804]: I1104 12:41:49.216956 804 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Nov 4 12:41:49.217165 update_engine[804]: I1104 12:41:49.217123 804 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Nov 4 12:41:49.218939 update_engine[804]: I1104 12:41:49.218914 804 update_check_scheduler.cc:74] Next update check in 8m15s Nov 4 12:41:49.230723 systemd[1]: Starting Generate /run/issue... Nov 4 12:41:49.231897 systemd[1]: Started Update Engine. Nov 4 12:41:49.235247 systemd[1]: issuegen.service: Deactivated successfully. Nov 4 12:41:49.235471 systemd[1]: Finished Generate /run/issue. Nov 4 12:41:49.237516 systemd[1]: Starting Permit User Sessions... Nov 4 12:41:49.241586 systemd[1]: Finished Permit User Sessions. Nov 4 12:41:49.243721 systemd[1]: Started Getty on tty1. Nov 4 12:41:49.245616 systemd[1]: Started Serial Getty on ttyAMA0. Nov 4 12:41:49.246655 systemd[1]: Reached target Login Prompts. Nov 4 12:41:49.247671 systemd[1]: Reached target Multi-User System. Nov 4 12:41:49.249634 systemd[1]: Starting Record Runlevel Change in UTMP... Nov 4 12:41:49.254115 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 4 12:41:49.254331 systemd[1]: Finished Record Runlevel Change in UTMP. Nov 4 12:41:49.255389 systemd[1]: Startup finished in 695ms (kernel) + 1.076s (initrd) + 2.615s (userspace) = 4.387s. Nov 4 12:41:50.019164 systemd-networkd[723]: eth0: Gained IPv6LL Nov 4 12:41:58.778378 systemd[1]: Created slice Slice /system/sshd. Nov 4 12:41:58.779397 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33484). Nov 4 12:41:58.814919 sshd[831]: Accepted publickey for core from 10.0.0.1 port 33484 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:58.816993 sshd[831]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:58.840051 systemd[1]: Created slice User Slice of UID 500. Nov 4 12:41:58.841471 systemd[1]: Starting User Runtime Directory /run/user/500... Nov 4 12:41:58.843268 systemd-logind[803]: New session 1 of user core. Nov 4 12:41:58.847477 systemd[1]: Finished User Runtime Directory /run/user/500. Nov 4 12:41:58.848673 systemd[1]: Starting User Manager for UID 500... Nov 4 12:41:58.850657 systemd[834]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:58.894475 systemd[834]: Queued start job for default target Main User Target. Nov 4 12:41:58.894608 systemd[834]: Reached target Paths. Nov 4 12:41:58.894621 systemd[834]: Reached target Sockets. Nov 4 12:41:58.894631 systemd[834]: Reached target Timers. Nov 4 12:41:58.894641 systemd[834]: Reached target Basic System. Nov 4 12:41:58.894722 systemd[1]: Started User Manager for UID 500. Nov 4 12:41:58.895285 systemd[834]: Reached target Main User Target. Nov 4 12:41:58.895314 systemd[834]: Startup finished in 41ms. Nov 4 12:41:58.912095 systemd[1]: Started Session 1 of User core. Nov 4 12:41:58.971231 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33498). Nov 4 12:41:59.004661 sshd[843]: Accepted publickey for core from 10.0.0.1 port 33498 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:59.006240 sshd[843]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:59.008684 systemd-logind[803]: New session 2 of user core. Nov 4 12:41:59.020832 systemd[1]: Started Session 2 of User core. Nov 4 12:41:59.073432 sshd[843]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:59.086235 systemd[1]: sshd@1-10.0.0.6:22-10.0.0.1:33498.service: Deactivated successfully. Nov 4 12:41:59.086762 systemd[1]: session-2.scope: Deactivated successfully. Nov 4 12:41:59.087312 systemd-logind[803]: Session 2 logged out. Waiting for processes to exit. Nov 4 12:41:59.088139 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33506). Nov 4 12:41:59.088798 systemd-logind[803]: Removed session 2. Nov 4 12:41:59.120373 sshd[849]: Accepted publickey for core from 10.0.0.1 port 33506 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:59.121921 sshd[849]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:59.124643 systemd-logind[803]: New session 3 of user core. Nov 4 12:41:59.147482 systemd[1]: Started Session 3 of User core. Nov 4 12:41:59.198479 sshd[849]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:59.214581 systemd[1]: sshd@2-10.0.0.6:22-10.0.0.1:33506.service: Deactivated successfully. Nov 4 12:41:59.215215 systemd[1]: session-3.scope: Deactivated successfully. Nov 4 12:41:59.215823 systemd-logind[803]: Session 3 logged out. Waiting for processes to exit. Nov 4 12:41:59.216907 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33520). Nov 4 12:41:59.217504 systemd-logind[803]: Removed session 3. Nov 4 12:41:59.247329 sshd[855]: Accepted publickey for core from 10.0.0.1 port 33520 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:59.248462 sshd[855]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:59.251054 systemd-logind[803]: New session 4 of user core. Nov 4 12:41:59.260978 systemd[1]: Started Session 4 of User core. Nov 4 12:41:59.310893 sshd[855]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:59.321638 systemd[1]: sshd@3-10.0.0.6:22-10.0.0.1:33520.service: Deactivated successfully. Nov 4 12:41:59.322144 systemd[1]: session-4.scope: Deactivated successfully. Nov 4 12:41:59.322701 systemd-logind[803]: Session 4 logged out. Waiting for processes to exit. Nov 4 12:41:59.323612 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33522). Nov 4 12:41:59.324936 systemd-logind[803]: Removed session 4. Nov 4 12:41:59.356907 sshd[861]: Accepted publickey for core from 10.0.0.1 port 33522 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:59.358101 sshd[861]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:59.360376 systemd-logind[803]: New session 5 of user core. Nov 4 12:41:59.369122 systemd[1]: Started Session 5 of User core. Nov 4 12:41:59.426119 sudo[864]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Nov 4 12:41:59.426322 sudo[864]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:41:59.440062 sudo[864]: pam_unix(sudo:session): session closed for user root Nov 4 12:41:59.442207 sshd[861]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:59.455289 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36232). Nov 4 12:41:59.457780 dbus-daemon[791]: [system] Reloaded configuration Nov 4 12:41:59.460179 systemd[1]: sshd@4-10.0.0.6:22-10.0.0.1:33522.service: Deactivated successfully. Nov 4 12:41:59.460727 systemd[1]: session-5.scope: Deactivated successfully. Nov 4 12:41:59.461359 systemd-logind[803]: Session 5 logged out. Waiting for processes to exit. Nov 4 12:41:59.462182 systemd-logind[803]: Removed session 5. Nov 4 12:41:59.486304 sshd[867]: Accepted publickey for core from 10.0.0.1 port 36232 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:59.487127 sshd[867]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:59.489354 systemd-logind[803]: New session 6 of user core. Nov 4 12:41:59.509816 systemd[1]: Started Session 6 of User core. Nov 4 12:41:59.561835 sudo[872]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Nov 4 12:41:59.562077 sudo[872]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:41:59.564080 sudo[872]: pam_unix(sudo:session): session closed for user root Nov 4 12:41:59.567398 sudo[871]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Nov 4 12:41:59.567590 sudo[871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:41:59.591931 systemd[1]: Stopping Load Security Auditing Rules... Nov 4 12:41:59.592000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 4 12:41:59.594144 kernel: kauditd_printk_skb: 49 callbacks suppressed Nov 4 12:41:59.594179 kernel: audit: type=1305 audit(1762260119.592:60): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 4 12:41:59.594809 auditctl[875]: No rules Nov 4 12:41:59.594574 systemd[1]: audit-rules.service: Deactivated successfully. Nov 4 12:41:59.594800 systemd[1]: Stopped Load Security Auditing Rules. Nov 4 12:41:59.596068 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:41:59.609968 augenrules[892]: No rules Nov 4 12:41:59.610583 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:41:59.611288 sudo[871]: pam_unix(sudo:session): session closed for user root Nov 4 12:41:59.612277 sshd[867]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:59.623073 systemd[1]: sshd@5-10.0.0.6:22-10.0.0.1:36232.service: Deactivated successfully. Nov 4 12:41:59.623736 systemd[1]: session-6.scope: Deactivated successfully. Nov 4 12:41:59.624349 systemd-logind[803]: Session 6 logged out. Waiting for processes to exit. Nov 4 12:41:59.625183 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36236). Nov 4 12:41:59.625917 systemd-logind[803]: Removed session 6. Nov 4 12:41:59.656219 sshd[898]: Accepted publickey for core from 10.0.0.1 port 36236 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:59.657043 sshd[898]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:59.658879 kernel: audit: type=1006 audit(1762260119.655:61): pid=898 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Nov 4 12:41:59.659729 systemd-logind[803]: New session 7 of user core. Nov 4 12:41:59.683331 systemd[1]: Started Session 7 of User core. Nov 4 12:41:59.730666 sshd[898]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:59.741613 systemd[1]: sshd@6-10.0.0.6:22-10.0.0.1:36236.service: Deactivated successfully. Nov 4 12:41:59.742182 systemd[1]: session-7.scope: Deactivated successfully. Nov 4 12:41:59.742752 systemd-logind[803]: Session 7 logged out. Waiting for processes to exit. Nov 4 12:41:59.743622 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:36250). Nov 4 12:41:59.744330 systemd-logind[803]: Removed session 7. Nov 4 12:41:59.777498 sshd[904]: Accepted publickey for core from 10.0.0.1 port 36250 ssh2: RSA SHA256:o/K2LGYejRVCewKC/d/pANaMiEwcX4501Db3H7Kv/T4 Nov 4 12:41:59.778506 sshd[904]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:41:59.780883 kernel: audit: type=1006 audit(1762260119.777:62): pid=904 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Nov 4 12:41:59.781047 systemd-logind[803]: New session 8 of user core. Nov 4 12:41:59.792192 systemd[1]: Started Session 8 of User core. Nov 4 12:41:59.843773 sshd[904]: pam_unix(sshd:session): session closed for user core Nov 4 12:41:59.845971 systemd[1]: sshd@7-10.0.0.6:22-10.0.0.1:36250.service: Deactivated successfully. Nov 4 12:41:59.846559 systemd[1]: session-8.scope: Deactivated successfully. Nov 4 12:41:59.847111 systemd-logind[803]: Session 8 logged out. Waiting for processes to exit. Nov 4 12:41:59.847791 systemd-logind[803]: Removed session 8.