Nov 7 23:49:01.677511 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 7 23:49:01.677527 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 7 23:49:01.677536 kernel: efi: EFI v2.70 by EDK II Nov 7 23:49:01.677541 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82d018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Nov 7 23:49:01.677546 kernel: efi: seeding entropy pool Nov 7 23:49:01.677551 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Nov 7 23:49:01.677558 kernel: ACPI: Early table checksum verification disabled Nov 7 23:49:01.677563 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Nov 7 23:49:01.677568 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 7 23:49:01.677573 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:01.677580 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:01.677585 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:01.677597 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:01.677604 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:01.677610 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:01.677616 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:01.677623 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:01.677628 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:01.677634 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 7 23:49:01.677639 kernel: ACPI: NUMA: Failed to initialise from firmware Nov 7 23:49:01.677645 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 7 23:49:01.677650 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Nov 7 23:49:01.677655 kernel: Zone ranges: Nov 7 23:49:01.677660 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 7 23:49:01.677666 kernel: DMA32 empty Nov 7 23:49:01.677671 kernel: Normal empty Nov 7 23:49:01.677687 kernel: Movable zone start for each node Nov 7 23:49:01.677696 kernel: Early memory node ranges Nov 7 23:49:01.677701 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Nov 7 23:49:01.677707 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Nov 7 23:49:01.677712 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Nov 7 23:49:01.677717 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Nov 7 23:49:01.677722 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Nov 7 23:49:01.677728 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Nov 7 23:49:01.677733 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Nov 7 23:49:01.677738 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 7 23:49:01.677743 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 7 23:49:01.677749 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 7 23:49:01.677754 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 7 23:49:01.677759 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 7 23:49:01.677768 kernel: On node 0 totalpages: 643072 Nov 7 23:49:01.677773 kernel: DMA zone: 10048 pages used for memmap Nov 7 23:49:01.677779 kernel: DMA zone: 0 pages reserved Nov 7 23:49:01.677784 kernel: DMA zone: 643072 pages, LIFO batch:63 Nov 7 23:49:01.677790 kernel: psci: probing for conduit method from ACPI. Nov 7 23:49:01.677796 kernel: psci: PSCIv1.1 detected in firmware. Nov 7 23:49:01.677801 kernel: psci: Using standard PSCI v0.2 function IDs Nov 7 23:49:01.677807 kernel: psci: Trusted OS migration not required Nov 7 23:49:01.677813 kernel: psci: SMC Calling Convention v1.1 Nov 7 23:49:01.677819 kernel: ACPI: SRAT not present Nov 7 23:49:01.677824 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Nov 7 23:49:01.677830 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Nov 7 23:49:01.677835 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 7 23:49:01.677841 kernel: Detected PIPT I-cache on CPU0 Nov 7 23:49:01.677846 kernel: CPU features: detected: GIC system register CPU interface Nov 7 23:49:01.677852 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 7 23:49:01.677857 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 7 23:49:01.677863 kernel: CPU features: detected: Hardware dirty bit management Nov 7 23:49:01.677869 kernel: CPU features: detected: Spectre-v4 Nov 7 23:49:01.677875 kernel: CPU features: detected: ARM erratum 1418040 Nov 7 23:49:01.677881 kernel: CPU features: detected: Spectre-BHB Nov 7 23:49:01.677886 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 7 23:49:01.677892 kernel: Policy zone: DMA Nov 7 23:49:01.677898 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 7 23:49:01.677905 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 7 23:49:01.677910 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 7 23:49:01.677916 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 7 23:49:01.677922 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Nov 7 23:49:01.677928 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Nov 7 23:49:01.677933 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 7 23:49:01.677940 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 7 23:49:01.677946 kernel: rcu: RCU event tracing is enabled. Nov 7 23:49:01.677952 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 7 23:49:01.677957 kernel: Trampoline variant of Tasks RCU enabled. Nov 7 23:49:01.677963 kernel: Tracing variant of Tasks RCU enabled. Nov 7 23:49:01.677969 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 7 23:49:01.677974 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 7 23:49:01.677980 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 7 23:49:01.677985 kernel: GICv3: 256 SPIs implemented Nov 7 23:49:01.677991 kernel: GICv3: 0 Extended SPIs implemented Nov 7 23:49:01.677996 kernel: GICv3: Distributor has no Range Selector support Nov 7 23:49:01.678001 kernel: GICv3: 16 PPIs implemented Nov 7 23:49:01.678009 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 7 23:49:01.678014 kernel: ACPI: SRAT not present Nov 7 23:49:01.678019 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 7 23:49:01.678025 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Nov 7 23:49:01.678031 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Nov 7 23:49:01.678036 kernel: GICv3: using LPI property table @0x00000000400d0000 Nov 7 23:49:01.678042 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Nov 7 23:49:01.678047 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 7 23:49:01.678053 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 7 23:49:01.678059 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 7 23:49:01.678065 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 7 23:49:01.678071 kernel: arm-pv: using stolen time PV Nov 7 23:49:01.678079 kernel: Console: colour dummy device 80x25 Nov 7 23:49:01.678085 kernel: ACPI: Core revision 20200925 Nov 7 23:49:01.678091 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 7 23:49:01.678097 kernel: pid_max: default: 32768 minimum: 301 Nov 7 23:49:01.678102 kernel: LSM: Security Framework initializing Nov 7 23:49:01.678108 kernel: SELinux: Initializing. Nov 7 23:49:01.678114 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 7 23:49:01.678120 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 7 23:49:01.678126 kernel: rcu: Hierarchical SRCU implementation. Nov 7 23:49:01.678133 kernel: Platform MSI: ITS@0x8080000 domain created Nov 7 23:49:01.678139 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 7 23:49:01.678145 kernel: Remapping and enabling EFI services. Nov 7 23:49:01.678151 kernel: smp: Bringing up secondary CPUs ... Nov 7 23:49:01.678157 kernel: Detected PIPT I-cache on CPU1 Nov 7 23:49:01.678163 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 7 23:49:01.678169 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Nov 7 23:49:01.678175 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 7 23:49:01.678180 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 7 23:49:01.678186 kernel: Detected PIPT I-cache on CPU2 Nov 7 23:49:01.678193 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 7 23:49:01.678199 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Nov 7 23:49:01.678206 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 7 23:49:01.678211 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 7 23:49:01.678218 kernel: Detected PIPT I-cache on CPU3 Nov 7 23:49:01.678229 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 7 23:49:01.678236 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Nov 7 23:49:01.678243 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 7 23:49:01.678248 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 7 23:49:01.678255 kernel: smp: Brought up 1 node, 4 CPUs Nov 7 23:49:01.678261 kernel: SMP: Total of 4 processors activated. Nov 7 23:49:01.678267 kernel: CPU features: detected: Privileged Access Never Nov 7 23:49:01.678273 kernel: CPU features: detected: LSE atomic instructions Nov 7 23:49:01.678279 kernel: CPU features: detected: User Access Override Nov 7 23:49:01.678285 kernel: CPU features: detected: 32-bit EL0 Support Nov 7 23:49:01.678291 kernel: CPU features: detected: Common not Private translations Nov 7 23:49:01.678297 kernel: CPU features: detected: RAS Extension Support Nov 7 23:49:01.678304 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 7 23:49:01.678310 kernel: CPU features: detected: CRC32 instructions Nov 7 23:49:01.678317 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 7 23:49:01.678323 kernel: CPU: All CPU(s) started at EL1 Nov 7 23:49:01.678328 kernel: alternatives: patching kernel code Nov 7 23:49:01.678335 kernel: devtmpfs: initialized Nov 7 23:49:01.678341 kernel: KASLR enabled Nov 7 23:49:01.678347 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 7 23:49:01.678353 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 7 23:49:01.678359 kernel: pinctrl core: initialized pinctrl subsystem Nov 7 23:49:01.678365 kernel: SMBIOS 3.0.0 present. Nov 7 23:49:01.678371 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Nov 7 23:49:01.678377 kernel: NET: Registered protocol family 16 Nov 7 23:49:01.678383 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 7 23:49:01.678389 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 7 23:49:01.678397 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 7 23:49:01.678403 kernel: audit: initializing netlink subsys (disabled) Nov 7 23:49:01.678409 kernel: audit: type=2000 audit(0.034:1): state=initialized audit_enabled=0 res=1 Nov 7 23:49:01.678416 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 7 23:49:01.678422 kernel: cpuidle: using governor menu Nov 7 23:49:01.678428 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 7 23:49:01.678434 kernel: ASID allocator initialised with 32768 entries Nov 7 23:49:01.678441 kernel: ACPI: bus type PCI registered Nov 7 23:49:01.678446 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 7 23:49:01.678453 kernel: Serial: AMBA PL011 UART driver Nov 7 23:49:01.678459 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 7 23:49:01.678466 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 7 23:49:01.678471 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 7 23:49:01.678478 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 7 23:49:01.678484 kernel: cryptd: max_cpu_qlen set to 1000 Nov 7 23:49:01.678490 kernel: ACPI: Added _OSI(Module Device) Nov 7 23:49:01.678496 kernel: ACPI: Added _OSI(Processor Device) Nov 7 23:49:01.678502 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 7 23:49:01.678509 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 7 23:49:01.678515 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 7 23:49:01.678521 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 7 23:49:01.678527 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 7 23:49:01.678533 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 7 23:49:01.678539 kernel: ACPI: Interpreter enabled Nov 7 23:49:01.678544 kernel: ACPI: Using GIC for interrupt routing Nov 7 23:49:01.678550 kernel: ACPI: MCFG table detected, 1 entries Nov 7 23:49:01.678556 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 7 23:49:01.678563 kernel: printk: console [ttyAMA0] enabled Nov 7 23:49:01.678570 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 7 23:49:01.678694 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 7 23:49:01.678756 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 7 23:49:01.678810 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 7 23:49:01.678864 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 7 23:49:01.678918 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 7 23:49:01.678926 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 7 23:49:01.678935 kernel: PCI host bridge to bus 0000:00 Nov 7 23:49:01.678996 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 7 23:49:01.679050 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 7 23:49:01.679102 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 7 23:49:01.679152 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 7 23:49:01.679220 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 7 23:49:01.679284 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 7 23:49:01.679344 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 7 23:49:01.679401 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 7 23:49:01.679458 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 7 23:49:01.679514 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 7 23:49:01.679571 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 7 23:49:01.679634 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 7 23:49:01.679693 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 7 23:49:01.679762 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 7 23:49:01.679812 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 7 23:49:01.679820 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Nov 7 23:49:01.679826 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Nov 7 23:49:01.679832 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Nov 7 23:49:01.679839 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Nov 7 23:49:01.679845 kernel: vgaarb: loaded Nov 7 23:49:01.679851 kernel: Registered efivars operations Nov 7 23:49:01.679857 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 7 23:49:01.679865 kernel: VFS: Disk quotas dquot_6.6.0 Nov 7 23:49:01.679871 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 7 23:49:01.679877 kernel: pnp: PnP ACPI init Nov 7 23:49:01.679945 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 7 23:49:01.679997 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Nov 7 23:49:01.680005 kernel: pnp: PnP ACPI: found 1 devices Nov 7 23:49:01.680011 kernel: NET: Registered protocol family 2 Nov 7 23:49:01.680017 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 7 23:49:01.680025 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 7 23:49:01.680031 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 7 23:49:01.680037 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 7 23:49:01.680044 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 7 23:49:01.680050 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 7 23:49:01.680056 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 7 23:49:01.680062 kernel: NET: Registered protocol family 1 Nov 7 23:49:01.680068 kernel: PCI: CLS 0 bytes, default 64 Nov 7 23:49:01.680074 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 7 23:49:01.680081 kernel: kvm [1]: HYP mode not available Nov 7 23:49:01.680087 kernel: Initialise system trusted keyrings Nov 7 23:49:01.680093 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 7 23:49:01.680100 kernel: Key type asymmetric registered Nov 7 23:49:01.680105 kernel: Asymmetric key parser 'x509' registered Nov 7 23:49:01.680112 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 7 23:49:01.680118 kernel: io scheduler mq-deadline registered Nov 7 23:49:01.680124 kernel: io scheduler kyber registered Nov 7 23:49:01.680130 kernel: io scheduler bfq registered Nov 7 23:49:01.680137 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 7 23:49:01.680143 kernel: ACPI: Power Button [PWRB] Nov 7 23:49:01.680149 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Nov 7 23:49:01.680206 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 7 23:49:01.680215 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 7 23:49:01.680221 kernel: msm_serial: driver initialized Nov 7 23:49:01.680227 kernel: random: fast init done Nov 7 23:49:01.680233 kernel: random: crng init done Nov 7 23:49:01.680239 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Nov 7 23:49:01.680245 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Nov 7 23:49:01.680253 kernel: thunder_xcv, ver 1.0 Nov 7 23:49:01.680259 kernel: thunder_bgx, ver 1.0 Nov 7 23:49:01.680265 kernel: nicpf, ver 1.0 Nov 7 23:49:01.680270 kernel: nicvf, ver 1.0 Nov 7 23:49:01.680335 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 7 23:49:01.680393 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-07T23:49:01 UTC (1762559341) Nov 7 23:49:01.680401 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 7 23:49:01.680407 kernel: NET: Registered protocol family 10 Nov 7 23:49:01.680415 kernel: Segment Routing with IPv6 Nov 7 23:49:01.680421 kernel: NET: Registered protocol family 17 Nov 7 23:49:01.680428 kernel: Key type dns_resolver registered Nov 7 23:49:01.680434 kernel: registered taskstats version 1 Nov 7 23:49:01.680440 kernel: Loading compiled-in X.509 certificates Nov 7 23:49:01.680447 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Nov 7 23:49:01.680453 kernel: Key type ._fscrypt registered Nov 7 23:49:01.680459 kernel: Key type .fscrypt registered Nov 7 23:49:01.680465 kernel: Key type fscrypt-provisioning registered Nov 7 23:49:01.680472 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 7 23:49:01.680479 kernel: ima: Allocated hash algorithm: sha1 Nov 7 23:49:01.680485 kernel: ima: No architecture policies found Nov 7 23:49:01.680491 kernel: Freeing unused kernel memory: 34240K Nov 7 23:49:01.680497 kernel: Run /init as init process Nov 7 23:49:01.680503 kernel: with arguments: Nov 7 23:49:01.680509 kernel: /init Nov 7 23:49:01.680515 kernel: with environment: Nov 7 23:49:01.680521 kernel: HOME=/ Nov 7 23:49:01.680527 kernel: TERM=linux Nov 7 23:49:01.680533 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 7 23:49:01.680541 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 7 23:49:01.680550 systemd[1]: Detected virtualization kvm. Nov 7 23:49:01.680557 systemd[1]: Detected architecture arm64. Nov 7 23:49:01.680563 systemd[1]: Running in initial RAM disk. Nov 7 23:49:01.680570 systemd[1]: No hostname configured, using default hostname. Nov 7 23:49:01.680576 systemd[1]: Hostname set to . Nov 7 23:49:01.680583 systemd[1]: Initializing machine ID from VM UUID. Nov 7 23:49:01.680595 systemd[1]: Queued start job for default target Initrd Default Target. Nov 7 23:49:01.680603 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 7 23:49:01.680610 systemd[1]: Reached target Local Encrypted Volumes. Nov 7 23:49:01.680616 systemd[1]: Reached target Path Units. Nov 7 23:49:01.680622 systemd[1]: Reached target Slice Units. Nov 7 23:49:01.680629 systemd[1]: Reached target Swaps. Nov 7 23:49:01.680635 systemd[1]: Reached target Timer Units. Nov 7 23:49:01.680643 systemd[1]: Listening on Open-iSCSI iscsid Socket. Nov 7 23:49:01.680650 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Nov 7 23:49:01.680656 systemd[1]: Listening on Journal Audit Socket. Nov 7 23:49:01.680663 systemd[1]: Listening on Journal Socket (/dev/log). Nov 7 23:49:01.680670 systemd[1]: Listening on Journal Socket. Nov 7 23:49:01.680696 systemd[1]: Listening on Network Service Netlink Socket. Nov 7 23:49:01.680703 systemd[1]: Listening on udev Control Socket. Nov 7 23:49:01.680709 systemd[1]: Listening on udev Kernel Socket. Nov 7 23:49:01.680716 systemd[1]: Reached target Socket Units. Nov 7 23:49:01.680723 systemd[1]: Starting Create List of Static Device Nodes... Nov 7 23:49:01.680730 systemd[1]: Finished Network Cleanup. Nov 7 23:49:01.680736 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Nov 7 23:49:01.680743 systemd[1]: Starting Journal Service... Nov 7 23:49:01.680750 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 7 23:49:01.680756 systemd[1]: Starting Apply Kernel Variables... Nov 7 23:49:01.680763 systemd[1]: Starting Setup Virtual Console... Nov 7 23:49:01.680769 systemd[1]: Finished Create List of Static Device Nodes. Nov 7 23:49:01.680776 systemd[1]: Finished Apply Kernel Variables. Nov 7 23:49:01.680783 systemd[1]: Finished Setup Virtual Console. Nov 7 23:49:01.680790 systemd[1]: Starting dracut ask for additional cmdline parameters... Nov 7 23:49:01.680796 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 7 23:49:01.680805 systemd-journald[279]: Journal started Nov 7 23:49:01.680841 systemd-journald[279]: Runtime Journal (/run/log/journal/47597f7ca35148efaf74a0939ece6cab) is 6.0M, max 48.5M, 42.4M free. Nov 7 23:49:01.683258 systemd[1]: Started Journal Service. Nov 7 23:49:01.684087 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 7 23:49:01.696652 systemd[1]: Finished dracut ask for additional cmdline parameters. Nov 7 23:49:01.698216 systemd[1]: Starting dracut cmdline hook... Nov 7 23:49:01.707020 dracut-cmdline[297]: dracut-dracut-053 Nov 7 23:49:01.709201 dracut-cmdline[297]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Nov 7 23:49:01.766704 kernel: SCSI subsystem initialized Nov 7 23:49:01.771695 kernel: Loading iSCSI transport class v2.0-870. Nov 7 23:49:01.777710 kernel: iscsi: registered transport (tcp) Nov 7 23:49:01.789708 kernel: iscsi: registered transport (qla4xxx) Nov 7 23:49:01.789723 kernel: QLogic iSCSI HBA Driver Nov 7 23:49:01.799719 systemd[1]: Finished dracut cmdline hook. Nov 7 23:49:01.801179 systemd[1]: Starting dracut pre-udev hook... Nov 7 23:49:01.814943 kernel: device-mapper: uevent: version 1.0.3 Nov 7 23:49:01.814988 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Nov 7 23:49:01.852637 kernel: raid6: neonx8 gen() 9304 MB/s Nov 7 23:49:01.868700 kernel: raid6: neonx8 xor() 9337 MB/s Nov 7 23:49:01.885690 kernel: raid6: neonx4 gen() 13557 MB/s Nov 7 23:49:01.902688 kernel: raid6: neonx4 xor() 11531 MB/s Nov 7 23:49:01.919688 kernel: raid6: neonx2 gen() 13010 MB/s Nov 7 23:49:01.936688 kernel: raid6: neonx2 xor() 9896 MB/s Nov 7 23:49:01.953699 kernel: raid6: neonx1 gen() 10968 MB/s Nov 7 23:49:01.970697 kernel: raid6: neonx1 xor() 8835 MB/s Nov 7 23:49:01.987699 kernel: raid6: int64x8 gen() 6761 MB/s Nov 7 23:49:02.004694 kernel: raid6: int64x8 xor() 3793 MB/s Nov 7 23:49:02.021697 kernel: raid6: int64x4 gen() 6909 MB/s Nov 7 23:49:02.038696 kernel: raid6: int64x4 xor() 3835 MB/s Nov 7 23:49:02.055696 kernel: raid6: int64x2 gen() 6187 MB/s Nov 7 23:49:02.072696 kernel: raid6: int64x2 xor() 3300 MB/s Nov 7 23:49:02.089696 kernel: raid6: int64x1 gen() 5014 MB/s Nov 7 23:49:02.106823 kernel: raid6: int64x1 xor() 2586 MB/s Nov 7 23:49:02.106834 kernel: raid6: using algorithm neonx4 gen() 13557 MB/s Nov 7 23:49:02.106842 kernel: raid6: .... xor() 11531 MB/s, rmw enabled Nov 7 23:49:02.107943 kernel: raid6: using neon recovery algorithm Nov 7 23:49:02.117694 kernel: xor: measuring software checksum speed Nov 7 23:49:02.118693 kernel: 8regs : 17109 MB/sec Nov 7 23:49:02.120131 kernel: 32regs : 20755 MB/sec Nov 7 23:49:02.120142 kernel: arm64_neon : 28967 MB/sec Nov 7 23:49:02.120149 kernel: xor: using function: arm64_neon (28967 MB/sec) Nov 7 23:49:02.165705 kernel: Btrfs loaded, crc32c=crc32c-generic Nov 7 23:49:02.175203 systemd[1]: Finished dracut pre-udev hook. Nov 7 23:49:02.175000 audit: BPF prog-id=6 op=LOAD Nov 7 23:49:02.176000 audit: BPF prog-id=7 op=LOAD Nov 7 23:49:02.178296 kernel: audit: type=1334 audit(1762559342.175:2): prog-id=6 op=LOAD Nov 7 23:49:02.178319 kernel: audit: type=1334 audit(1762559342.176:3): prog-id=7 op=LOAD Nov 7 23:49:02.178327 kernel: audit: type=1334 audit(1762559342.177:4): prog-id=8 op=LOAD Nov 7 23:49:02.177000 audit: BPF prog-id=8 op=LOAD Nov 7 23:49:02.178657 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 7 23:49:02.189774 systemd-udevd[416]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 7 23:49:02.191580 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 7 23:49:02.193283 systemd[1]: Starting dracut pre-trigger hook... Nov 7 23:49:02.198809 systemd[1]: Starting Network Configuration... Nov 7 23:49:02.201576 kernel: audit: type=1334 audit(1762559342.197:5): prog-id=9 op=LOAD Nov 7 23:49:02.197000 audit: BPF prog-id=9 op=LOAD Nov 7 23:49:02.205204 dracut-pre-trigger[422]: rd.md=0: removing MD RAID activation Nov 7 23:49:02.215917 systemd-networkd[433]: lo: Link UP Nov 7 23:49:02.215924 systemd-networkd[433]: lo: Gained carrier Nov 7 23:49:02.216200 systemd-networkd[433]: Enumeration completed Nov 7 23:49:02.216434 systemd[1]: Started Network Configuration. Nov 7 23:49:02.217000 audit: BPF prog-id=10 op=LOAD Nov 7 23:49:02.218440 systemd[1]: Starting Network Name Resolution... Nov 7 23:49:02.221849 kernel: audit: type=1334 audit(1762559342.217:6): prog-id=10 op=LOAD Nov 7 23:49:02.231596 systemd[1]: Finished dracut pre-trigger hook. Nov 7 23:49:02.233213 systemd[1]: Starting Coldplug All udev Devices... Nov 7 23:49:02.243534 systemd-udevd[416]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 7 23:49:02.248279 systemd-resolved[449]: Positive Trust Anchors: Nov 7 23:49:02.248294 systemd-resolved[449]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 7 23:49:02.248322 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 7 23:49:02.248601 systemd-resolved[449]: Defaulting to hostname 'linux'. Nov 7 23:49:02.249296 systemd[1]: Started Network Name Resolution. Nov 7 23:49:02.253797 systemd[1]: Reached target Network. Nov 7 23:49:02.255556 systemd[1]: Reached target Host and Network Name Lookups. Nov 7 23:49:02.261981 systemd[1]: Starting iSCSI UserSpace I/O driver... Nov 7 23:49:02.263191 systemd[1]: Finished Coldplug All udev Devices. Nov 7 23:49:02.279019 iscsid[483]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 7 23:49:02.279019 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 Nov 7 23:49:02.279019 iscsid[483]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Nov 7 23:49:02.279019 iscsid[483]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 7 23:49:02.279019 iscsid[483]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 7 23:49:02.279019 iscsid[483]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 7 23:49:02.279019 iscsid[483]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 7 23:49:02.294207 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 7 23:49:02.294342 kernel: vda: detected capacity change from 0 to 4756340736 Nov 7 23:49:02.267883 systemd[1]: Started iSCSI UserSpace I/O driver. Nov 7 23:49:02.269672 systemd[1]: Starting Open-iSCSI... Nov 7 23:49:02.276524 systemd[1]: Started Open-iSCSI. Nov 7 23:49:02.278725 systemd[1]: Starting dracut initqueue hook... Nov 7 23:49:02.304687 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 7 23:49:02.313042 systemd-udevd[462]: Using default interface naming scheme 'v249'. Nov 7 23:49:02.319041 systemd-networkd[433]: eth0: Link UP Nov 7 23:49:02.327689 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (462) Nov 7 23:49:02.332866 systemd[1]: Found device /dev/disk/by-label/ROOT. Nov 7 23:49:02.335066 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Nov 7 23:49:02.336098 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Nov 7 23:49:02.339646 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Nov 7 23:49:02.340740 systemd[1]: Finished dracut initqueue hook. Nov 7 23:49:02.343838 systemd[1]: Found device /dev/disk/by-label/OEM. Nov 7 23:49:02.344671 systemd[1]: Reached target Initrd Root Device. Nov 7 23:49:02.346088 systemd[1]: Reached target Preparation for Remote File Systems. Nov 7 23:49:02.347533 systemd[1]: Reached target Remote Encrypted Volumes. Nov 7 23:49:02.349089 systemd[1]: Reached target Remote File Systems. Nov 7 23:49:02.351071 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Nov 7 23:49:02.352685 systemd[1]: Starting dracut pre-mount hook... Nov 7 23:49:02.360360 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 7 23:49:02.360448 systemd[1]: Finished dracut pre-mount hook. Nov 7 23:49:03.306693 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Nov 7 23:49:03.306635 systemd-networkd[433]: eth0: Gained carrier Nov 7 23:49:03.313752 systemd-networkd[433]: eth0: DHCPv4 address 10.0.0.4/16 via 10.0.0.1 Nov 7 23:49:03.368719 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 7 23:49:03.369232 disk-uuid[504]: The operation has completed successfully. Nov 7 23:49:03.390562 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 7 23:49:03.390716 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Nov 7 23:49:03.392645 systemd[1]: Starting Ignition (setup)... Nov 7 23:49:03.400953 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 7 23:49:03.400988 kernel: BTRFS info (device vda6): has skinny extents Nov 7 23:49:03.408049 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 7 23:49:03.414249 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 7 23:49:03.414368 systemd[1]: Finished Ignition (setup). Nov 7 23:49:03.416803 systemd[1]: Starting Ignition (disks)... Nov 7 23:49:03.430633 ignition[540]: Ignition v0.36.1-15-gde4e6cc9 Nov 7 23:49:03.430649 ignition[540]: Stage: disks Nov 7 23:49:03.430659 ignition[540]: reading system config file "/usr/lib/ignition/base.ign" Nov 7 23:49:03.430670 ignition[540]: no config at "/usr/lib/ignition/base.ign" Nov 7 23:49:03.430727 ignition[540]: parsed url from cmdline: "" Nov 7 23:49:03.430730 ignition[540]: no config URL provided Nov 7 23:49:03.430735 ignition[540]: reading system config file "/usr/lib/ignition/user.ign" Nov 7 23:49:03.430742 ignition[540]: no config at "/usr/lib/ignition/user.ign" Nov 7 23:49:03.430764 ignition[540]: op(1): [started] loading QEMU firmware config module Nov 7 23:49:03.430768 ignition[540]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 7 23:49:03.432392 ignition[540]: op(1): [finished] loading QEMU firmware config module Nov 7 23:49:03.445912 ignition[540]: parsing config with SHA512: 328594625805bdbcec4582461518ed283ba17343501d2bce11290bb9ca131f6e06415f6ef19ae6954de310086a7f18ed54d9307e974fdb41c21858b6ff7992bc Nov 7 23:49:03.447918 ignition[540]: disks: disks passed Nov 7 23:49:03.447926 ignition[540]: Ignition finished successfully Nov 7 23:49:03.448544 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 7 23:49:03.448692 systemd[1]: Finished Ignition (disks). Nov 7 23:49:03.450053 systemd[1]: Reached target Preparation for Local File Systems. Nov 7 23:49:03.452389 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Nov 7 23:49:03.454878 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Nov 7 23:49:03.481697 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 7 23:49:03.484670 systemd-fsck[558]: ROOT: clean, 528/553792 files, 37752/553472 blocks Nov 7 23:49:03.488388 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Nov 7 23:49:03.490235 systemd[1]: Mounting /sysroot... Nov 7 23:49:03.507182 systemd[1]: Found device /dev/mapper/usr. Nov 7 23:49:03.509362 systemd[1]: Starting File System Check on /dev/mapper/usr... Nov 7 23:49:03.510455 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Nov 7 23:49:03.519301 systemd-fsck[568]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Nov 7 23:49:03.519301 systemd-fsck[568]: You must have r/w access to the filesystem or be root Nov 7 23:49:03.522218 systemd-fsck[566]: fsck failed with exit status 8. Nov 7 23:49:03.522224 systemd-fsck[566]: Ignoring error. Nov 7 23:49:03.522924 systemd[1]: Finished File System Check on /dev/mapper/usr. Nov 7 23:49:03.525345 systemd[1]: Mounting /sysusr/usr... Nov 7 23:49:03.534115 systemd[1]: Mounted /sysusr/usr. Nov 7 23:49:03.537044 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Nov 7 23:49:03.537064 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Nov 7 23:49:03.537079 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Nov 7 23:49:03.537123 systemd[1]: Mounted /sysroot. Nov 7 23:49:03.537981 systemd[1]: Reached target Initrd Root File System. Nov 7 23:49:03.539207 systemd[1]: Reached target Local File Systems. Nov 7 23:49:03.540645 systemd[1]: Reached target System Initialization. Nov 7 23:49:03.542354 systemd[1]: Reached target Basic System. Nov 7 23:49:03.545288 systemd[1]: Mounting /sysroot/usr... Nov 7 23:49:03.547519 systemd[1]: Mounted /sysroot/usr. Nov 7 23:49:03.548983 systemd[1]: Starting Root filesystem setup... Nov 7 23:49:03.575325 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 7 23:49:03.575451 systemd[1]: Finished Root filesystem setup. Nov 7 23:49:03.577845 systemd[1]: Starting Ignition (files)... Nov 7 23:49:03.579120 systemd[1]: Starting /sysroot/boot... Nov 7 23:49:03.581019 ignition[585]: Ignition v0.36.1-15-gde4e6cc9 Nov 7 23:49:03.581032 ignition[585]: Stage: files Nov 7 23:49:03.581042 ignition[585]: reading system config file "/usr/lib/ignition/base.ign" Nov 7 23:49:03.581052 ignition[585]: no config at "/usr/lib/ignition/base.ign" Nov 7 23:49:03.581558 ignition[585]: files: compiled without relabeling support, skipping Nov 7 23:49:03.598918 systemd[1]: Finished /sysroot/boot. Nov 7 23:49:03.600916 ignition[585]: files: createUsers: op(1): [started] creating or modifying user "core" Nov 7 23:49:03.600926 ignition[585]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Nov 7 23:49:03.602536 ignition[585]: files: createUsers: op(1): [finished] creating or modifying user "core" Nov 7 23:49:03.602546 ignition[585]: files: createUsers: op(2): [started] adding ssh keys to user "core" Nov 7 23:49:03.604305 ignition[585]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Nov 7 23:49:03.604336 ignition[585]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Nov 7 23:49:03.605189 ignition[585]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Nov 7 23:49:03.605197 ignition[585]: files: op(4): [started] processing unit "coreos-metadata.service" Nov 7 23:49:03.609244 systemd[1]: ignition-files.service: Deactivated successfully. Nov 7 23:49:03.605301 ignition[585]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Nov 7 23:49:03.609369 systemd[1]: Finished Ignition (files). Nov 7 23:49:03.608368 ignition[585]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Nov 7 23:49:03.610592 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Nov 7 23:49:03.608375 ignition[585]: files: op(4): [finished] processing unit "coreos-metadata.service" Nov 7 23:49:03.611332 systemd[1]: Starting Ignition (record completion)... Nov 7 23:49:03.608380 ignition[585]: files: files passed Nov 7 23:49:03.613049 systemd[1]: Starting Reload Configuration from the Real Root... Nov 7 23:49:03.608384 ignition[585]: Ignition finished successfully Nov 7 23:49:03.627388 kernel: audit: type=1334 audit(1762559343.624:7): prog-id=6 op=UNLOAD Nov 7 23:49:03.627410 kernel: audit: type=1334 audit(1762559343.625:8): prog-id=10 op=UNLOAD Nov 7 23:49:03.627425 kernel: audit: type=1334 audit(1762559343.626:9): prog-id=3 op=UNLOAD Nov 7 23:49:03.624000 audit: BPF prog-id=6 op=UNLOAD Nov 7 23:49:03.625000 audit: BPF prog-id=10 op=UNLOAD Nov 7 23:49:03.626000 audit: BPF prog-id=3 op=UNLOAD Nov 7 23:49:03.614756 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 7 23:49:03.633338 kernel: audit: type=1334 audit(1762559343.626:10): prog-id=9 op=UNLOAD Nov 7 23:49:03.626000 audit: BPF prog-id=9 op=UNLOAD Nov 7 23:49:03.614878 systemd[1]: Finished Ignition (record completion). Nov 7 23:49:03.618493 systemd[1]: Reloading. Nov 7 23:49:03.710000 audit: BPF prog-id=11 op=LOAD Nov 7 23:49:03.710000 audit: BPF prog-id=12 op=LOAD Nov 7 23:49:03.710000 audit: BPF prog-id=13 op=LOAD Nov 7 23:49:03.710000 audit: BPF prog-id=7 op=UNLOAD Nov 7 23:49:03.710000 audit: BPF prog-id=8 op=UNLOAD Nov 7 23:49:03.710000 audit: BPF prog-id=14 op=LOAD Nov 7 23:49:03.711000 audit: BPF prog-id=15 op=LOAD Nov 7 23:49:03.711000 audit: BPF prog-id=16 op=LOAD Nov 7 23:49:03.711000 audit: BPF prog-id=17 op=LOAD Nov 7 23:49:03.711000 audit: BPF prog-id=4 op=UNLOAD Nov 7 23:49:03.711000 audit: BPF prog-id=5 op=UNLOAD Nov 7 23:49:03.711000 audit: BPF prog-id=18 op=LOAD Nov 7 23:49:03.727169 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 7 23:49:03.727296 systemd[1]: Finished Reload Configuration from the Real Root. Nov 7 23:49:03.729065 systemd[1]: Reached target Initrd File Systems. Nov 7 23:49:03.730441 systemd[1]: Reached target Initrd Default Target. Nov 7 23:49:03.731902 systemd[1]: Condition check resulted in dracut mount hook being skipped. Nov 7 23:49:03.732592 systemd[1]: Starting dracut pre-pivot and cleanup hook... Nov 7 23:49:03.742468 systemd[1]: Finished dracut pre-pivot and cleanup hook. Nov 7 23:49:03.744127 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Nov 7 23:49:03.750469 systemd[1]: Stopped target Host and Network Name Lookups. Nov 7 23:49:03.751479 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 7 23:49:03.753044 systemd[1]: Stopped target Timer Units. Nov 7 23:49:03.754415 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 7 23:49:03.754532 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Nov 7 23:49:03.755828 systemd[1]: Stopped target Initrd Default Target. Nov 7 23:49:03.757324 systemd[1]: Stopped target Basic System. Nov 7 23:49:03.758805 systemd[1]: Stopped target Initrd Root Device. Nov 7 23:49:03.760194 systemd[1]: Stopped target Path Units. Nov 7 23:49:03.761399 systemd[1]: Stopped target Remote File Systems. Nov 7 23:49:03.762800 systemd[1]: Stopped target Preparation for Remote File Systems. Nov 7 23:49:03.764218 systemd[1]: Stopped target Slice Units. Nov 7 23:49:03.765465 systemd[1]: Stopped target Socket Units. Nov 7 23:49:03.767034 systemd[1]: Stopped target System Initialization. Nov 7 23:49:03.768397 systemd[1]: Stopped target Local File Systems. Nov 7 23:49:03.769668 systemd[1]: Stopped target Preparation for Local File Systems. Nov 7 23:49:03.771326 systemd[1]: Stopped target Swaps. Nov 7 23:49:03.772538 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 7 23:49:03.772683 systemd[1]: Stopped dracut pre-mount hook. Nov 7 23:49:03.774242 systemd[1]: Stopped target Local Encrypted Volumes. Nov 7 23:49:03.775610 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 7 23:49:03.779724 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 7 23:49:03.781794 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 7 23:49:03.781911 systemd[1]: Stopped dracut initqueue hook. Nov 7 23:49:03.783728 systemd[1]: Stopping Open-iSCSI... Nov 7 23:49:03.785265 iscsid[483]: iscsid shutting down. Nov 7 23:49:03.785420 systemd[1]: Stopping /sysroot/boot... Nov 7 23:49:03.786619 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 7 23:49:03.786768 systemd[1]: Stopped Coldplug All udev Devices. Nov 7 23:49:03.788065 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 7 23:49:03.788155 systemd[1]: Stopped dracut pre-trigger hook. Nov 7 23:49:03.790561 systemd[1]: iscsid.service: Deactivated successfully. Nov 7 23:49:03.790706 systemd[1]: Stopped Open-iSCSI. Nov 7 23:49:03.792490 systemd[1]: iscsid.socket: Deactivated successfully. Nov 7 23:49:03.792558 systemd[1]: Closed Open-iSCSI iscsid Socket. Nov 7 23:49:03.793864 systemd[1]: Stopping iSCSI UserSpace I/O driver... Nov 7 23:49:03.796911 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 7 23:49:03.797029 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Nov 7 23:49:03.798389 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 7 23:49:03.798492 systemd[1]: Stopped iSCSI UserSpace I/O driver. Nov 7 23:49:03.799815 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 7 23:49:03.799933 systemd[1]: Stopped /sysroot/boot. Nov 7 23:49:03.801601 systemd[1]: Stopped target Network. Nov 7 23:49:03.803173 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 7 23:49:03.803237 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Nov 7 23:49:03.804841 systemd[1]: Stopping Network Name Resolution... Nov 7 23:49:03.811261 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 7 23:49:03.811397 systemd[1]: Stopped Network Name Resolution. Nov 7 23:49:03.813073 systemd[1]: Stopping Network Configuration... Nov 7 23:49:03.818814 systemd-networkd[433]: eth0: DHCP lease lost Nov 7 23:49:03.821000 audit: BPF prog-id=14 op=UNLOAD Nov 7 23:49:03.829742 systemd-networkd[433]: eth0: DHCPv6 lease lost Nov 7 23:49:03.830797 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 7 23:49:03.830924 systemd[1]: Stopped Network Configuration. Nov 7 23:49:03.832542 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 7 23:49:03.832573 systemd[1]: Closed Network Service Netlink Socket. Nov 7 23:49:03.834328 systemd[1]: Stopping Network Cleanup... Nov 7 23:49:03.835121 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 7 23:49:03.835190 systemd[1]: Stopped Apply Kernel Variables. Nov 7 23:49:03.836540 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Nov 7 23:49:03.842823 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 7 23:49:03.843000 audit: BPF prog-id=18 op=UNLOAD Nov 7 23:49:03.842954 systemd[1]: Stopped Network Cleanup. Nov 7 23:49:03.845328 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 7 23:49:03.845450 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Nov 7 23:49:03.847374 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 7 23:49:03.847416 systemd[1]: Closed udev Control Socket. Nov 7 23:49:03.848853 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 7 23:49:03.848886 systemd[1]: Closed udev Kernel Socket. Nov 7 23:49:03.852000 audit: BPF prog-id=11 op=UNLOAD Nov 7 23:49:03.850263 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 7 23:49:03.850310 systemd[1]: Stopped dracut pre-udev hook. Nov 7 23:49:03.851436 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 7 23:49:03.851473 systemd[1]: Stopped dracut cmdline hook. Nov 7 23:49:03.852986 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 7 23:49:03.853031 systemd[1]: Stopped dracut ask for additional cmdline parameters. Nov 7 23:49:03.855292 systemd[1]: Starting Cleanup udev Database... Nov 7 23:49:03.856520 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Nov 7 23:49:03.857758 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 7 23:49:03.857814 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 7 23:49:03.859459 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 7 23:49:03.859504 systemd[1]: Stopped Create List of Static Device Nodes. Nov 7 23:49:03.860885 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 7 23:49:03.860928 systemd[1]: Stopped Setup Virtual Console. Nov 7 23:49:03.862768 systemd[1]: rngd.service: Deactivated successfully. Nov 7 23:49:03.862894 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Nov 7 23:49:03.864414 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 7 23:49:03.873000 audit: BPF prog-id=15 op=UNLOAD Nov 7 23:49:03.864524 systemd[1]: Finished Cleanup udev Database. Nov 7 23:49:03.865557 systemd[1]: Reached target Switch Root. Nov 7 23:49:03.867525 systemd[1]: Starting Switch Root... Nov 7 23:49:03.872843 systemd[1]: Switching root. Nov 7 23:49:03.882972 systemd-journald[279]: Journal stopped Nov 7 23:49:06.062055 systemd-journald[279]: Received SIGTERM from PID 1 (systemd). Nov 7 23:49:06.062113 kernel: SELinux: policy capability network_peer_controls=1 Nov 7 23:49:06.062125 kernel: SELinux: policy capability open_perms=1 Nov 7 23:49:06.062137 kernel: SELinux: policy capability extended_socket_class=1 Nov 7 23:49:06.062147 kernel: SELinux: policy capability always_check_network=0 Nov 7 23:49:06.062156 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 7 23:49:06.062166 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 7 23:49:06.062178 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 7 23:49:06.062188 systemd[1]: Successfully loaded SELinux policy in 31.886ms. Nov 7 23:49:06.062204 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.824ms. Nov 7 23:49:06.062215 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 7 23:49:06.062225 systemd[1]: Detected virtualization kvm. Nov 7 23:49:06.062234 systemd[1]: Detected architecture arm64. Nov 7 23:49:06.062244 systemd[1]: Detected first boot. Nov 7 23:49:06.062254 systemd[1]: Initializing machine ID from VM UUID. Nov 7 23:49:06.062264 systemd[1]: Populated /etc with preset unit settings. Nov 7 23:49:06.062276 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 7 23:49:06.062287 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 7 23:49:06.062297 kernel: kauditd_printk_skb: 24 callbacks suppressed Nov 7 23:49:06.062306 kernel: audit: type=1334 audit(1762559345.932:35): prog-id=21 op=LOAD Nov 7 23:49:06.062315 kernel: audit: type=1334 audit(1762559345.933:36): prog-id=22 op=LOAD Nov 7 23:49:06.062324 kernel: audit: type=1334 audit(1762559345.933:37): prog-id=23 op=LOAD Nov 7 23:49:06.062333 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 7 23:49:06.062343 kernel: audit: type=1334 audit(1762559345.933:38): prog-id=16 op=UNLOAD Nov 7 23:49:06.062354 systemd[1]: Stopped Switch Root. Nov 7 23:49:06.062364 kernel: audit: type=1334 audit(1762559345.933:39): prog-id=17 op=UNLOAD Nov 7 23:49:06.062374 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 7 23:49:06.062384 systemd[1]: Created slice Slice /system/addon-config. Nov 7 23:49:06.062394 systemd[1]: Created slice Slice /system/addon-run. Nov 7 23:49:06.062404 kernel: audit: type=1334 audit(1762559345.944:40): prog-id=21 op=UNLOAD Nov 7 23:49:06.062413 systemd[1]: Created slice Slice /system/getty. Nov 7 23:49:06.062423 systemd[1]: Created slice Slice /system/modprobe. Nov 7 23:49:06.062433 systemd[1]: Created slice Slice /system/serial-getty. Nov 7 23:49:06.062445 systemd[1]: Created slice Slice /system/system-cloudinit. Nov 7 23:49:06.062456 systemd[1]: Created slice Slice /system/systemd-fsck. Nov 7 23:49:06.062465 systemd[1]: Created slice User and Session Slice. Nov 7 23:49:06.062475 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 7 23:49:06.062943 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Nov 7 23:49:06.062976 systemd[1]: Set up automount Boot partition Automount Point. Nov 7 23:49:06.062987 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 7 23:49:06.062998 systemd[1]: Stopped target Switch Root. Nov 7 23:49:06.063009 systemd[1]: Stopped target Initrd File Systems. Nov 7 23:49:06.063022 systemd[1]: Stopped target Initrd Root File System. Nov 7 23:49:06.063033 systemd[1]: Reached target Remote Encrypted Volumes. Nov 7 23:49:06.063045 systemd[1]: Reached target Remote File Systems. Nov 7 23:49:06.063055 systemd[1]: Reached target Slice Units. Nov 7 23:49:06.063064 systemd[1]: Reached target Swaps. Nov 7 23:49:06.063074 systemd[1]: Reached target Verify torcx succeeded. Nov 7 23:49:06.063084 systemd[1]: Reached target Local Verity Protected Volumes. Nov 7 23:49:06.063094 systemd[1]: Listening on Process Core Dump Socket. Nov 7 23:49:06.063104 systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 7 23:49:06.063113 systemd[1]: Listening on Network Service Netlink Socket. Nov 7 23:49:06.063124 systemd[1]: Listening on udev Control Socket. Nov 7 23:49:06.063134 systemd[1]: Listening on udev Kernel Socket. Nov 7 23:49:06.063144 systemd[1]: Mounting Huge Pages File System... Nov 7 23:49:06.063154 systemd[1]: Mounting POSIX Message Queue File System... Nov 7 23:49:06.063164 systemd[1]: Mounting External Media Directory... Nov 7 23:49:06.063174 systemd[1]: Mounting Kernel Debug File System... Nov 7 23:49:06.063184 systemd[1]: Mounting Kernel Trace File System... Nov 7 23:49:06.063194 systemd[1]: Mounting Temporary Directory /tmp... Nov 7 23:49:06.063204 systemd[1]: Starting Create missing system files... Nov 7 23:49:06.063213 systemd[1]: Starting Create List of Static Device Nodes... Nov 7 23:49:06.063224 systemd[1]: Starting Load Kernel Module configfs... Nov 7 23:49:06.063234 systemd[1]: Starting Load Kernel Module drm... Nov 7 23:49:06.063244 systemd[1]: Starting Load Kernel Module fuse... Nov 7 23:49:06.063254 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Nov 7 23:49:06.063263 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 7 23:49:06.063273 systemd[1]: Stopped File System Check on Root Device. Nov 7 23:49:06.063284 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 7 23:49:06.063294 systemd[1]: Stopped systemd-fsck-usr.service. Nov 7 23:49:06.063304 kernel: fuse: init (API version 7.32) Nov 7 23:49:06.063315 systemd[1]: Stopped Journal Service. Nov 7 23:49:06.063325 kernel: audit: type=1334 audit(1762559346.033:41): prog-id=24 op=LOAD Nov 7 23:49:06.063334 kernel: audit: type=1334 audit(1762559346.034:42): prog-id=25 op=LOAD Nov 7 23:49:06.063344 kernel: audit: type=1334 audit(1762559346.035:43): prog-id=26 op=LOAD Nov 7 23:49:06.063353 systemd[1]: Starting Journal Service... Nov 7 23:49:06.063363 kernel: audit: type=1334 audit(1762559346.035:44): prog-id=22 op=UNLOAD Nov 7 23:49:06.063373 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 7 23:49:06.063383 systemd[1]: Starting Remount Root and Kernel File Systems... Nov 7 23:49:06.063395 systemd[1]: Starting Apply Kernel Variables... Nov 7 23:49:06.063404 systemd[1]: Starting Coldplug All udev Devices... Nov 7 23:49:06.063414 systemd[1]: verity-setup.service: Deactivated successfully. Nov 7 23:49:06.063423 systemd[1]: Stopped verity-setup.service. Nov 7 23:49:06.063433 systemd[1]: Mounted Huge Pages File System. Nov 7 23:49:06.063443 systemd[1]: Mounted POSIX Message Queue File System. Nov 7 23:49:06.063452 systemd[1]: Mounted External Media Directory. Nov 7 23:49:06.063462 systemd[1]: Mounted Kernel Debug File System. Nov 7 23:49:06.063471 systemd[1]: Mounted Kernel Trace File System. Nov 7 23:49:06.063483 systemd-journald[800]: Journal started Nov 7 23:49:06.063527 systemd-journald[800]: Runtime Journal (/run/log/journal/47597f7ca35148efaf74a0939ece6cab) is 6.0M, max 48.5M, 42.4M free. Nov 7 23:49:03.951000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 7 23:49:03.985000 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 7 23:49:03.985000 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 7 23:49:03.985000 audit: BPF prog-id=19 op=LOAD Nov 7 23:49:03.985000 audit: BPF prog-id=19 op=UNLOAD Nov 7 23:49:03.986000 audit: BPF prog-id=20 op=LOAD Nov 7 23:49:03.986000 audit: BPF prog-id=20 op=UNLOAD Nov 7 23:49:04.021000 audit[749]: AVC avc: denied { associate } for pid=749 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Nov 7 23:49:05.932000 audit: BPF prog-id=21 op=LOAD Nov 7 23:49:05.933000 audit: BPF prog-id=22 op=LOAD Nov 7 23:49:05.933000 audit: BPF prog-id=23 op=LOAD Nov 7 23:49:05.933000 audit: BPF prog-id=16 op=UNLOAD Nov 7 23:49:05.933000 audit: BPF prog-id=17 op=UNLOAD Nov 7 23:49:05.944000 audit: BPF prog-id=21 op=UNLOAD Nov 7 23:49:06.033000 audit: BPF prog-id=24 op=LOAD Nov 7 23:49:06.034000 audit: BPF prog-id=25 op=LOAD Nov 7 23:49:06.035000 audit: BPF prog-id=26 op=LOAD Nov 7 23:49:06.035000 audit: BPF prog-id=22 op=UNLOAD Nov 7 23:49:06.035000 audit: BPF prog-id=23 op=UNLOAD Nov 7 23:49:06.060000 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 7 23:49:05.923084 systemd[1]: Queued start job for default target Multi-User System. Nov 7 23:49:06.065378 systemd[1]: Started Journal Service. Nov 7 23:49:04.020001 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" 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 7 23:49:05.935071 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 7 23:49:04.020445 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 7 23:49:04.020465 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 7 23:49:04.020598 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 7 23:49:04.020612 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 7 23:49:04.020647 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 7 23:49:04.020660 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 7 23:49:04.020881 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 7 23:49:04.020916 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 7 23:49:04.020931 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 7 23:49:06.066161 systemd[1]: Mounted Temporary Directory /tmp. Nov 7 23:49:04.021479 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" 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 7 23:49:04.021512 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" 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 7 23:49:04.021533 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" 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 7 23:49:04.021549 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Nov 7 23:49:04.021568 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" 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 7 23:49:04.021590 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:04Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 7 23:49:05.744830 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:05Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 7 23:49:05.745105 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:05Z" 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 7 23:49:05.745205 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:05Z" 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 7 23:49:05.745330 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:05Z" 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 7 23:49:05.745385 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:05Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 7 23:49:05.745441 /usr/lib/systemd/system-generators/torcx-generator[749]: time="2025-11-07T23:49:05Z" 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 7 23:49:06.067493 systemd[1]: Finished Create missing system files. Nov 7 23:49:06.068771 systemd[1]: Finished Create List of Static Device Nodes. Nov 7 23:49:06.069875 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 7 23:49:06.070068 systemd[1]: Finished Load Kernel Module configfs. Nov 7 23:49:06.071145 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 7 23:49:06.071334 systemd[1]: Finished Load Kernel Module drm. Nov 7 23:49:06.072357 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 7 23:49:06.074874 systemd[1]: Finished Load Kernel Module fuse. Nov 7 23:49:06.090141 systemd[1]: Finished Remount Root and Kernel File Systems. Nov 7 23:49:06.091444 systemd[1]: Finished Apply Kernel Variables. Nov 7 23:49:06.094429 systemd[1]: Mounting FUSE Control File System... Nov 7 23:49:06.096305 systemd[1]: Mounting Kernel Configuration File System... Nov 7 23:49:06.097341 systemd[1]: Condition check resulted in Remount Root File System being skipped. Nov 7 23:49:06.100522 systemd[1]: Starting Rebuild Hardware Database... Nov 7 23:49:06.104710 systemd[1]: Starting Flush Journal to Persistent Storage... Nov 7 23:49:06.109832 systemd-journald[800]: Time spent on flushing to /var/log/journal/47597f7ca35148efaf74a0939ece6cab is 8.273ms for 770 entries. Nov 7 23:49:06.109832 systemd-journald[800]: System Journal (/var/log/journal/47597f7ca35148efaf74a0939ece6cab) is 8.0M, max 203.0M, 195.0M free. Nov 7 23:49:06.105618 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Nov 7 23:49:06.106773 systemd[1]: Starting Load/Save Random Seed... Nov 7 23:49:06.108604 systemd[1]: Starting Create System Users... Nov 7 23:49:06.115311 systemd[1]: Mounted FUSE Control File System. Nov 7 23:49:06.116461 systemd[1]: Mounted Kernel Configuration File System. Nov 7 23:49:06.118773 systemd[1]: Finished Coldplug All udev Devices. Nov 7 23:49:06.125984 systemd[1]: Starting Wait for udev To Complete Device Initialization... Nov 7 23:49:06.128955 systemd-sysusers[812]: Creating group sgx with gid 999. Nov 7 23:49:06.129894 systemd-sysusers[812]: Creating group systemd-oom with gid 998. Nov 7 23:49:06.130470 systemd-sysusers[812]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Nov 7 23:49:06.131309 systemd-sysusers[812]: Creating group systemd-timesync with gid 997. Nov 7 23:49:06.131856 systemd-sysusers[812]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Nov 7 23:49:06.132419 systemd-sysusers[812]: Creating group systemd-coredump with gid 996. Nov 7 23:49:06.132904 systemd-sysusers[812]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Nov 7 23:49:06.136246 systemd[1]: Finished Load/Save Random Seed. Nov 7 23:49:06.138429 systemd[1]: Reached target First Boot Complete. Nov 7 23:49:06.153253 systemd[1]: Finished Flush Journal to Persistent Storage. Nov 7 23:49:06.154855 systemd[1]: Finished Create System Users. Nov 7 23:49:06.158012 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 7 23:49:06.172316 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 7 23:49:06.385530 systemd[1]: Finished Rebuild Hardware Database. Nov 7 23:49:06.396000 audit: BPF prog-id=27 op=LOAD Nov 7 23:49:06.396000 audit: BPF prog-id=28 op=LOAD Nov 7 23:49:06.396000 audit: BPF prog-id=29 op=LOAD Nov 7 23:49:06.396000 audit: BPF prog-id=12 op=UNLOAD Nov 7 23:49:06.396000 audit: BPF prog-id=13 op=UNLOAD Nov 7 23:49:06.398355 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 7 23:49:06.422003 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 7 23:49:06.430000 audit: BPF prog-id=30 op=LOAD Nov 7 23:49:06.432945 systemd[1]: Starting Network Configuration... Nov 7 23:49:06.465517 systemd-udevd[832]: Using default interface naming scheme 'v249'. Nov 7 23:49:06.466328 systemd-networkd[837]: lo: Link UP Nov 7 23:49:06.466337 systemd-networkd[837]: lo: Gained carrier Nov 7 23:49:06.466661 systemd-networkd[837]: Enumeration completed Nov 7 23:49:06.466831 systemd[1]: Started Network Configuration. Nov 7 23:49:06.493697 udevadm[814]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Nov 7 23:49:06.497602 systemd-networkd[837]: eth0: Link UP Nov 7 23:49:06.508728 systemd-networkd[837]: eth0: Gained carrier Nov 7 23:49:06.513886 systemd[1]: Finished Wait for udev To Complete Device Initialization. Nov 7 23:49:06.518832 systemd-networkd[837]: eth0: DHCPv4 address 10.0.0.4/16 via 10.0.0.1 Nov 7 23:49:06.523841 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 7 23:49:06.532740 lvm[845]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 7 23:49:06.564812 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 7 23:49:06.565883 systemd[1]: Reached target Local Encrypted Volumes. Nov 7 23:49:06.578779 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 7 23:49:06.582383 lvm[846]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 7 23:49:06.612845 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 7 23:49:06.613936 systemd[1]: Reached target Preparation for Local File Systems. Nov 7 23:49:06.615082 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Nov 7 23:49:06.615108 systemd[1]: Reached target Containers. Nov 7 23:49:06.631977 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Nov 7 23:49:06.645400 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Nov 7 23:49:06.664730 systemd[1]: Mounting /usr/share/oem... Nov 7 23:49:06.671152 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 7 23:49:06.671301 kernel: BTRFS info (device vda6): has skinny extents Nov 7 23:49:06.673528 systemd[1]: Mounted /usr/share/oem. Nov 7 23:49:06.674368 systemd[1]: Reached target Local File Systems. Nov 7 23:49:06.676406 systemd[1]: Starting Rebuild Dynamic Linker Cache... Nov 7 23:49:06.677693 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 7 23:49:06.677744 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Nov 7 23:49:06.678896 systemd[1]: Starting Commit a transient machine-id on disk... Nov 7 23:49:06.681189 systemd[1]: Starting Create Volatile Files and Directories... Nov 7 23:49:06.687887 systemd-tmpfiles[871]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 7 23:49:06.688921 systemd-tmpfiles[871]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Nov 7 23:49:06.696288 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 7 23:49:06.696934 systemd[1]: Finished Commit a transient machine-id on disk. Nov 7 23:49:06.718877 systemd-tmpfiles[871]: Detected autofs mount point /boot during canonicalization of /boot. Nov 7 23:49:06.718887 systemd-tmpfiles[871]: Skipping /boot Nov 7 23:49:06.723928 systemd-tmpfiles[871]: Detected autofs mount point /boot during canonicalization of /boot. Nov 7 23:49:06.723941 systemd-tmpfiles[871]: Skipping /boot Nov 7 23:49:06.758259 systemd[1]: Finished Rebuild Dynamic Linker Cache. Nov 7 23:49:06.759537 systemd[1]: Finished Create Volatile Files and Directories. Nov 7 23:49:06.772536 systemd[1]: Starting Load Security Auditing Rules... Nov 7 23:49:06.775724 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Nov 7 23:49:06.778517 systemd[1]: Starting Rebuild Journal Catalog... Nov 7 23:49:06.780000 audit: BPF prog-id=31 op=LOAD Nov 7 23:49:06.783858 systemd[1]: Starting Network Name Resolution... Nov 7 23:49:06.784000 audit: BPF prog-id=32 op=LOAD Nov 7 23:49:06.787364 systemd[1]: Starting Network Time Synchronization... Nov 7 23:49:06.790019 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Nov 7 23:49:06.791783 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Nov 7 23:49:06.793305 systemd[1]: Finished Rebuild Journal Catalog. Nov 7 23:49:06.798479 systemd[1]: Starting Update is Completed... Nov 7 23:49:06.800033 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Nov 7 23:49:06.800662 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Nov 7 23:49:06.804666 systemd[1]: Finished Update is Completed. Nov 7 23:49:06.808000 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 7 23:49:06.809637 augenrules[893]: No rules Nov 7 23:49:06.811106 systemd[1]: Finished Load Security Auditing Rules. Nov 7 23:49:06.839526 systemd-resolved[881]: Positive Trust Anchors: Nov 7 23:49:06.839538 systemd-resolved[881]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 7 23:49:06.839574 systemd-resolved[881]: 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 7 23:49:06.839722 systemd[1]: Started Network Time Synchronization. Nov 7 23:49:06.840992 systemd-timesyncd[882]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Nov 7 23:49:06.841036 systemd[1]: Reached target System Initialization. Nov 7 23:49:06.842039 systemd[1]: Started Watch for update engine configuration changes. Nov 7 23:49:06.842120 systemd-resolved[881]: Defaulting to hostname 'linux'. Nov 7 23:49:06.843096 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 7 23:49:06.844290 systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 7 23:49:06.845281 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Nov 7 23:49:06.845315 systemd[1]: Reached target Path Units. Nov 7 23:49:06.846027 systemd[1]: Reached target System Time Set. Nov 7 23:49:06.846952 systemd[1]: Started Daily Log Rotation. Nov 7 23:49:06.847852 systemd[1]: Started Weekly check for MD array's redundancy information.. Nov 7 23:49:06.848924 systemd[1]: Reached target Timer Units. Nov 7 23:49:06.850037 systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 7 23:49:06.857442 systemd[1]: Starting Docker Socket for the API... Nov 7 23:49:06.860827 systemd[1]: Listening on OpenSSH Server Socket. Nov 7 23:49:06.862285 systemd[1]: Started Network Name Resolution. Nov 7 23:49:06.863243 systemd[1]: Listening on Docker Socket for the API. Nov 7 23:49:06.864237 systemd[1]: Reached target Network. Nov 7 23:49:06.864968 systemd[1]: Reached target Host and Network Name Lookups. Nov 7 23:49:06.865881 systemd[1]: Reached target Socket Units. Nov 7 23:49:06.866603 systemd[1]: Reached target Basic System. Nov 7 23:49:06.867399 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Nov 7 23:49:06.867430 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Nov 7 23:49:06.868650 systemd[1]: Started D-Bus System Message Bus. Nov 7 23:49:06.872790 systemd[1]: Starting Extend Filesystems... Nov 7 23:49:06.873655 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Nov 7 23:49:06.875029 systemd[1]: Starting Generate /run/flatcar/motd... Nov 7 23:49:06.877255 systemd[1]: Starting Install an ssh key from /proc/cmdline... Nov 7 23:49:06.880217 systemd[1]: Starting Generate sshd host keys... Nov 7 23:49:06.881291 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Nov 7 23:49:06.881345 systemd[1]: Reached target Load system-provided cloud configs. Nov 7 23:49:06.883756 extend-filesystems[902]: Found vda Nov 7 23:49:06.883756 extend-filesystems[902]: Found vda1 Nov 7 23:49:06.883756 extend-filesystems[902]: Found vda2 Nov 7 23:49:06.883756 extend-filesystems[902]: Found vda3 Nov 7 23:49:06.883756 extend-filesystems[902]: Found usr Nov 7 23:49:06.883756 extend-filesystems[902]: Found vda4 Nov 7 23:49:06.883756 extend-filesystems[902]: Found vda6 Nov 7 23:49:06.883756 extend-filesystems[902]: Found vda7 Nov 7 23:49:06.883756 extend-filesystems[902]: Found vda9 Nov 7 23:49:06.883756 extend-filesystems[902]: Checking size of /dev/vda9 Nov 7 23:49:06.884793 systemd[1]: Starting User Login Management... Nov 7 23:49:06.915385 extend-filesystems[902]: Old size kept for /dev/vda9 Nov 7 23:49:06.887729 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 7 23:49:06.888589 systemd[1]: Starting Update Engine... Nov 7 23:49:06.890934 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Nov 7 23:49:06.890984 systemd[1]: Reached target Load user-provided cloud configs. Nov 7 23:49:06.893274 systemd[1]: motdgen.service: Deactivated successfully. Nov 7 23:49:06.893618 systemd[1]: Finished Generate /run/flatcar/motd. Nov 7 23:49:06.908058 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 7 23:49:06.908314 systemd[1]: Finished Install an ssh key from /proc/cmdline. Nov 7 23:49:06.912346 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 7 23:49:06.912594 systemd[1]: Finished Extend Filesystems. Nov 7 23:49:06.929034 update_engine[919]: I1107 23:49:06.928733 919 main.cc:89] Flatcar Update Engine starting Nov 7 23:49:06.931095 systemd[1]: Started Update Engine. Nov 7 23:49:06.931971 update_engine[919]: I1107 23:49:06.931929 919 update_check_scheduler.cc:74] Next update check in 3m7s Nov 7 23:49:06.937134 systemd[1]: Started Cluster reboot manager. Nov 7 23:49:06.938575 systemd-logind[913]: Watching system buttons on /dev/input/event0 (Power Button) Nov 7 23:49:06.938804 systemd-logind[913]: New seat seat0. Nov 7 23:49:06.941221 systemd[1]: Started User Login Management. Nov 7 23:49:06.980943 locksmithd[925]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 7 23:49:07.089904 systemd[1]: Created slice Slice /system/sshd. Nov 7 23:49:07.304770 sshd_keygen[920]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Nov 7 23:49:07.323850 systemd[1]: Finished Generate sshd host keys. Nov 7 23:49:07.335865 systemd[1]: Starting Generate /run/issue... Nov 7 23:49:07.337643 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38730). Nov 7 23:49:07.341905 systemd[1]: issuegen.service: Deactivated successfully. Nov 7 23:49:07.342146 systemd[1]: Finished Generate /run/issue. Nov 7 23:49:07.344439 systemd[1]: Starting Permit User Sessions... Nov 7 23:49:07.349087 systemd[1]: Finished Permit User Sessions. Nov 7 23:49:07.351657 systemd[1]: Started Getty on tty1. Nov 7 23:49:07.353767 systemd[1]: Started Serial Getty on ttyAMA0. Nov 7 23:49:07.354772 systemd[1]: Reached target Login Prompts. Nov 7 23:49:07.356424 systemd[1]: Reached target Multi-User System. Nov 7 23:49:07.358596 systemd[1]: Starting Record Runlevel Change in UTMP... Nov 7 23:49:07.363896 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 7 23:49:07.364134 systemd[1]: Finished Record Runlevel Change in UTMP. Nov 7 23:49:07.365203 systemd[1]: Startup finished in 710ms (kernel) + 2.364s (initrd) + 3.447s (userspace) = 6.522s. Nov 7 23:49:07.385553 sshd[941]: Accepted publickey for core from 10.0.0.1 port 38730 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:07.387362 sshd[941]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:07.408224 systemd[1]: Created slice User Slice of UID 500. Nov 7 23:49:07.409329 systemd[1]: Starting User Runtime Directory /run/user/500... Nov 7 23:49:07.410993 systemd-logind[913]: New session 1 of user core. Nov 7 23:49:07.415745 systemd[1]: Finished User Runtime Directory /run/user/500. Nov 7 23:49:07.417063 systemd[1]: Starting User Manager for UID 500... Nov 7 23:49:07.419528 systemd[952]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:07.467731 systemd[952]: Queued start job for default target Main User Target. Nov 7 23:49:07.467909 systemd[952]: Reached target Paths. Nov 7 23:49:07.467923 systemd[952]: Reached target Sockets. Nov 7 23:49:07.467935 systemd[952]: Reached target Timers. Nov 7 23:49:07.467945 systemd[952]: Reached target Basic System. Nov 7 23:49:07.467989 systemd[952]: Reached target Main User Target. Nov 7 23:49:07.468003 systemd[952]: Startup finished in 44ms. Nov 7 23:49:07.468211 systemd[1]: Started User Manager for UID 500. Nov 7 23:49:07.474845 systemd[1]: Started Session 1 of User core. Nov 7 23:49:07.535647 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38734). Nov 7 23:49:07.580926 sshd[961]: Accepted publickey for core from 10.0.0.1 port 38734 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:07.582073 sshd[961]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:07.584696 systemd-logind[913]: New session 2 of user core. Nov 7 23:49:07.593842 systemd[1]: Started Session 2 of User core. Nov 7 23:49:07.645619 sshd[961]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:07.658473 systemd[1]: sshd@1-10.0.0.4:22-10.0.0.1:38734.service: Deactivated successfully. Nov 7 23:49:07.659100 systemd[1]: session-2.scope: Deactivated successfully. Nov 7 23:49:07.659661 systemd-logind[913]: Session 2 logged out. Waiting for processes to exit. Nov 7 23:49:07.660766 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38746). Nov 7 23:49:07.661419 systemd-logind[913]: Removed session 2. Nov 7 23:49:07.703090 sshd[967]: Accepted publickey for core from 10.0.0.1 port 38746 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:07.704290 sshd[967]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:07.706947 systemd-logind[913]: New session 3 of user core. Nov 7 23:49:07.717869 systemd[1]: Started Session 3 of User core. Nov 7 23:49:07.765595 sshd[967]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:07.774613 systemd[1]: sshd@2-10.0.0.4:22-10.0.0.1:38746.service: Deactivated successfully. Nov 7 23:49:07.775145 systemd[1]: session-3.scope: Deactivated successfully. Nov 7 23:49:07.775659 systemd-logind[913]: Session 3 logged out. Waiting for processes to exit. Nov 7 23:49:07.776639 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38754). Nov 7 23:49:07.777208 systemd-logind[913]: Removed session 3. Nov 7 23:49:07.818893 sshd[973]: Accepted publickey for core from 10.0.0.1 port 38754 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:07.820158 sshd[973]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:07.822722 systemd-logind[913]: New session 4 of user core. Nov 7 23:49:07.830855 systemd[1]: Started Session 4 of User core. Nov 7 23:49:07.882299 sshd[973]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:07.897240 systemd[1]: sshd@3-10.0.0.4:22-10.0.0.1:38754.service: Deactivated successfully. Nov 7 23:49:07.897791 systemd[1]: session-4.scope: Deactivated successfully. Nov 7 23:49:07.898314 systemd-logind[913]: Session 4 logged out. Waiting for processes to exit. Nov 7 23:49:07.899298 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38770). Nov 7 23:49:07.899810 systemd-logind[913]: Removed session 4. Nov 7 23:49:07.941571 sshd[979]: Accepted publickey for core from 10.0.0.1 port 38770 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:07.942520 sshd[979]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:07.945282 systemd-logind[913]: New session 5 of user core. Nov 7 23:49:07.955852 systemd[1]: Started Session 5 of User core. Nov 7 23:49:08.010268 sudo[982]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Nov 7 23:49:08.010487 sudo[982]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 7 23:49:08.019202 sudo[982]: pam_unix(sudo:session): session closed for user root Nov 7 23:49:08.021295 sshd[979]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:08.032589 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38784). Nov 7 23:49:08.034964 dbus-daemon[901]: [system] Reloaded configuration Nov 7 23:49:08.037288 systemd[1]: sshd@4-10.0.0.4:22-10.0.0.1:38770.service: Deactivated successfully. Nov 7 23:49:08.038037 systemd[1]: session-5.scope: Deactivated successfully. Nov 7 23:49:08.038604 systemd-logind[913]: Session 5 logged out. Waiting for processes to exit. Nov 7 23:49:08.039252 systemd-logind[913]: Removed session 5. Nov 7 23:49:08.075988 sshd[985]: Accepted publickey for core from 10.0.0.1 port 38784 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:08.077055 sshd[985]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:08.079739 systemd-logind[913]: New session 6 of user core. Nov 7 23:49:08.092854 systemd[1]: Started Session 6 of User core. Nov 7 23:49:08.143255 sudo[990]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Nov 7 23:49:08.143506 sudo[990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 7 23:49:08.146603 sudo[990]: pam_unix(sudo:session): session closed for user root Nov 7 23:49:08.150387 sudo[989]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Nov 7 23:49:08.150619 sudo[989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 7 23:49:08.167793 systemd[1]: Stopping Load Security Auditing Rules... Nov 7 23:49:08.168000 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 7 23:49:08.169012 auditctl[993]: No rules Nov 7 23:49:08.169301 systemd[1]: audit-rules.service: Deactivated successfully. Nov 7 23:49:08.169549 systemd[1]: Stopped Load Security Auditing Rules. Nov 7 23:49:08.171016 systemd[1]: Starting Load Security Auditing Rules... Nov 7 23:49:08.186581 augenrules[1010]: No rules Nov 7 23:49:08.187337 systemd[1]: Finished Load Security Auditing Rules. Nov 7 23:49:08.188206 sudo[989]: pam_unix(sudo:session): session closed for user root Nov 7 23:49:08.189438 sshd[985]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:08.201923 systemd[1]: sshd@5-10.0.0.4:22-10.0.0.1:38784.service: Deactivated successfully. Nov 7 23:49:08.202571 systemd[1]: session-6.scope: Deactivated successfully. Nov 7 23:49:08.203211 systemd-logind[913]: Session 6 logged out. Waiting for processes to exit. Nov 7 23:49:08.204322 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38790). Nov 7 23:49:08.205001 systemd-logind[913]: Removed session 6. Nov 7 23:49:08.246901 sshd[1017]: Accepted publickey for core from 10.0.0.1 port 38790 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:08.247989 sshd[1017]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:08.250821 systemd-logind[913]: New session 7 of user core. Nov 7 23:49:08.256882 systemd[1]: Started Session 7 of User core. Nov 7 23:49:08.307183 sudo[1020]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/bash -c cat >/etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem </etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem < Nov 7 23:49:11.345229 update_engine[1267]: Nov 7 23:49:11.345229 update_engine[1267]: Nov 7 23:49:11.345229 update_engine[1267]: Nov 7 23:49:11.345229 update_engine[1267]: Nov 7 23:49:11.345229 update_engine[1267]: Nov 7 23:49:11.345229 update_engine[1267]: Nov 7 23:49:11.345229 update_engine[1267]: Nov 7 23:49:11.345229 update_engine[1267]: Nov 7 23:49:11.345229 update_engine[1267]: I1107 23:49:11.345224 1267 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Nov 7 23:49:11.348026 update_engine[1267]: I1107 23:49:11.347993 1267 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Nov 7 23:49:11.348279 update_engine[1267]: I1107 23:49:11.348251 1267 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Nov 7 23:49:11.349531 update_engine[1267]: I1107 23:49:11.349464 1267 libcurl_http_fetcher.cc:248] HTTP response code: 200 Nov 7 23:49:11.349620 update_engine[1267]: I1107 23:49:11.349579 1267 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Nov 7 23:49:11.349620 update_engine[1267]: I1107 23:49:11.349588 1267 omaha_request_action.cc:619] Omaha request response: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.349620 update_engine[1267]: Nov 7 23:49:11.352204 update_engine[1267]: I1107 23:49:11.352169 1267 omaha_request_action.cc:447] Omaha Response manifest version = Nov 7 23:49:11.352204 update_engine[1267]: I1107 23:49:11.352205 1267 omaha_request_action.cc:470] Found 1 url(s) Nov 7 23:49:11.352295 update_engine[1267]: I1107 23:49:11.352218 1267 omaha_request_action.cc:506] Processing first of 1 package(s) Nov 7 23:49:11.352295 update_engine[1267]: I1107 23:49:11.352222 1267 omaha_request_action.cc:513] Omaha Response package name = update.gz Nov 7 23:49:11.352295 update_engine[1267]: I1107 23:49:11.352226 1267 omaha_request_action.cc:529] Url0: http://10.0.0.3:34567/packages/update.gz Nov 7 23:49:11.352295 update_engine[1267]: I1107 23:49:11.352234 1267 omaha_request_action.cc:541] Payload size = 440031851 bytes Nov 7 23:49:11.352295 update_engine[1267]: I1107 23:49:11.352245 1267 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Nov 7 23:49:11.352295 update_engine[1267]: I1107 23:49:11.352262 1267 payload_state.cc:51] Resetting all persisted state as this is a new response Nov 7 23:49:11.352295 update_engine[1267]: I1107 23:49:11.352265 1267 payload_state.cc:360] Current Response Signature = Nov 7 23:49:11.352295 update_engine[1267]: NumURLs = 1 Nov 7 23:49:11.352295 update_engine[1267]: Url0 = http://10.0.0.3:34567/packages/update.gz Nov 7 23:49:11.352295 update_engine[1267]: Payload Size = 440031851 Nov 7 23:49:11.352295 update_engine[1267]: Payload Sha256 Hash = uQUy6dTYGJTZMb3bS3ifsAZBNhhWh7sCUvkHGF92C1k= Nov 7 23:49:11.352295 update_engine[1267]: Is Delta Payload = 0 Nov 7 23:49:11.352295 update_engine[1267]: Max Failure Count Per Url = 10 Nov 7 23:49:11.352295 update_engine[1267]: Disable Payload Backoff = 1 Nov 7 23:49:11.352542 update_engine[1267]: I1107 23:49:11.352360 1267 payload_state.cc:381] Payload Attempt Number = 0 Nov 7 23:49:11.352542 update_engine[1267]: I1107 23:49:11.352396 1267 payload_state.cc:404] Current URL Index = 0 Nov 7 23:49:11.352542 update_engine[1267]: I1107 23:49:11.352425 1267 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Nov 7 23:49:11.352542 update_engine[1267]: I1107 23:49:11.352455 1267 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Nov 7 23:49:11.352542 update_engine[1267]: I1107 23:49:11.352473 1267 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Nov 7 23:49:11.352542 update_engine[1267]: I1107 23:49:11.352522 1267 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Nov 7 23:49:11.352542 update_engine[1267]: I1107 23:49:11.352541 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Nov 7 23:49:11.352542 update_engine[1267]: I1107 23:49:11.352546 1267 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Nov 7 23:49:11.352692 update_engine[1267]: I1107 23:49:11.352562 1267 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Nov 7 23:49:11.352692 update_engine[1267]: E1107 23:49:11.352567 1267 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Nov 7 23:49:11.353093 update_engine[1267]: I1107 23:49:11.353067 1267 omaha_response_handler_action.cc:85] Using this install plan: Nov 7 23:49:11.353093 update_engine[1267]: I1107 23:49:11.353084 1267 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.3:34567/packages/update.gz, payload size: 440031851, payload hash: uQUy6dTYGJTZMb3bS3ifsAZBNhhWh7sCUvkHGF92C1k=, 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 7 23:49:11.353200 update_engine[1267]: I1107 23:49:11.353183 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Nov 7 23:49:11.354973 update_engine[1267]: I1107 23:49:11.354908 1267 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Nov 7 23:49:11.403577 sshd[1288]: Accepted publickey for core from 10.0.0.1 port 51506 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:11.405964 sshd[1288]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:11.408696 kernel: audit: type=1006 audit(1762559351.404:352): pid=1288 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=25 res=1 Nov 7 23:49:11.408826 systemd-logind[913]: New session 25 of user core. Nov 7 23:49:11.414842 systemd[1]: Started Session 25 of User core. Nov 7 23:49:11.470140 sshd[1288]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:11.473018 systemd[1]: sshd@24-10.0.0.4:22-10.0.0.1:51506.service: Deactivated successfully. Nov 7 23:49:11.473645 systemd[1]: session-25.scope: Deactivated successfully. Nov 7 23:49:11.474226 systemd-logind[913]: Session 25 logged out. Waiting for processes to exit. Nov 7 23:49:11.474972 systemd-logind[913]: Removed session 25. Nov 7 23:49:13.296844 update_engine[1267]: I1107 23:49:13.296804 1267 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Nov 7 23:49:13.296844 update_engine[1267]: I1107 23:49:13.296847 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Nov 7 23:49:13.362703 update_engine[1267]: E1107 23:49:13.362632 1267 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Nov 7 23:49:13.362703 update_engine[1267]: I1107 23:49:13.362684 1267 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Nov 7 23:49:13.362703 update_engine[1267]: I1107 23:49:13.362689 1267 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Nov 7 23:49:13.362703 update_engine[1267]: I1107 23:49:13.362692 1267 update_attempter.cc:302] Processing Done. Nov 7 23:49:13.362957 update_engine[1267]: E1107 23:49:13.362736 1267 update_attempter.cc:615] Update failed. Nov 7 23:49:13.362957 update_engine[1267]: I1107 23:49:13.362741 1267 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Nov 7 23:49:13.362957 update_engine[1267]: I1107 23:49:13.362744 1267 payload_state.cc:276] Incrementing the URL failure count Nov 7 23:49:13.362957 update_engine[1267]: I1107 23:49:13.362747 1267 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Nov 7 23:49:13.362957 update_engine[1267]: I1107 23:49:13.362934 1267 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Nov 7 23:49:13.362957 update_engine[1267]: I1107 23:49:13.362957 1267 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.3:34567/v1/update Nov 7 23:49:13.363694 update_engine[1267]: I1107 23:49:13.362960 1267 omaha_request_action.cc:269] Request: Nov 7 23:49:13.363694 update_engine[1267]: Nov 7 23:49:13.363694 update_engine[1267]: Nov 7 23:49:13.363694 update_engine[1267]: Nov 7 23:49:13.363694 update_engine[1267]: Nov 7 23:49:13.363694 update_engine[1267]: Nov 7 23:49:13.363694 update_engine[1267]: Nov 7 23:49:13.363694 update_engine[1267]: I1107 23:49:13.362965 1267 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Nov 7 23:49:13.363694 update_engine[1267]: I1107 23:49:13.363037 1267 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Nov 7 23:49:13.363694 update_engine[1267]: I1107 23:49:13.363168 1267 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Nov 7 23:49:13.537054 update_engine[1267]: I1107 23:49:13.536971 1267 libcurl_http_fetcher.cc:248] HTTP response code: 200 Nov 7 23:49:13.537192 update_engine[1267]: I1107 23:49:13.537076 1267 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Nov 7 23:49:13.537192 update_engine[1267]: I1107 23:49:13.537083 1267 omaha_request_action.cc:619] Omaha request response: Nov 7 23:49:13.537192 update_engine[1267]: Nov 7 23:49:13.537192 update_engine[1267]: Nov 7 23:49:13.537192 update_engine[1267]: Nov 7 23:49:13.537192 update_engine[1267]: Nov 7 23:49:13.537192 update_engine[1267]: Nov 7 23:49:13.537192 update_engine[1267]: Nov 7 23:49:13.537192 update_engine[1267]: E1107 23:49:13.537098 1267 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Nov 7 23:49:13.537192 update_engine[1267]: I1107 23:49:13.537103 1267 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 7 23:49:13.537192 update_engine[1267]: I1107 23:49:13.537106 1267 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 7 23:49:13.537192 update_engine[1267]: I1107 23:49:13.537109 1267 update_attempter.cc:302] Processing Done. Nov 7 23:49:13.537192 update_engine[1267]: I1107 23:49:13.537113 1267 update_attempter.cc:306] Error event sent. Nov 7 23:49:21.446668 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34354). Nov 7 23:49:21.492719 sshd[1303]: Accepted publickey for core from 10.0.0.1 port 34354 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:21.495274 sshd[1303]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:21.496703 kernel: audit: type=1006 audit(1762559361.492:353): pid=1303 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=26 res=1 Nov 7 23:49:21.498373 systemd-logind[913]: New session 26 of user core. Nov 7 23:49:21.510924 systemd[1]: Started Session 26 of User core. Nov 7 23:49:21.570726 sshd[1303]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:21.582467 systemd[1]: sshd@25-10.0.0.4:22-10.0.0.1:34354.service: Deactivated successfully. Nov 7 23:49:21.583041 systemd[1]: session-26.scope: Deactivated successfully. Nov 7 23:49:21.583667 systemd-logind[913]: Session 26 logged out. Waiting for processes to exit. Nov 7 23:49:21.584732 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34370). Nov 7 23:49:21.585382 systemd-logind[913]: Removed session 26. Nov 7 23:49:21.630175 sshd[1310]: Accepted publickey for core from 10.0.0.1 port 34370 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:21.632018 sshd[1310]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:21.633700 kernel: audit: type=1006 audit(1762559361.630:354): pid=1310 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=27 res=1 Nov 7 23:49:21.635644 systemd-logind[913]: New session 27 of user core. Nov 7 23:49:21.641903 systemd[1]: Started Session 27 of User core. Nov 7 23:49:21.698115 sshd[1310]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:21.711518 systemd[1]: sshd@26-10.0.0.4:22-10.0.0.1:34370.service: Deactivated successfully. Nov 7 23:49:21.712562 systemd[1]: session-27.scope: Deactivated successfully. Nov 7 23:49:21.713373 systemd-logind[913]: Session 27 logged out. Waiting for processes to exit. Nov 7 23:49:21.717380 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34382). Nov 7 23:49:21.718375 systemd-logind[913]: Removed session 27. Nov 7 23:49:21.762191 sshd[1318]: Accepted publickey for core from 10.0.0.1 port 34382 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:21.764038 sshd[1318]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:21.765708 kernel: audit: type=1006 audit(1762559361.762:355): pid=1318 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=28 res=1 Nov 7 23:49:21.766886 systemd-logind[913]: New session 28 of user core. Nov 7 23:49:21.776955 systemd[1]: Started Session 28 of User core. Nov 7 23:49:21.830545 sshd[1318]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:21.841077 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34386). Nov 7 23:49:21.843565 systemd[1]: sshd@27-10.0.0.4:22-10.0.0.1:34382.service: Deactivated successfully. Nov 7 23:49:21.844239 systemd[1]: session-28.scope: Deactivated successfully. Nov 7 23:49:21.845065 systemd-logind[913]: Session 28 logged out. Waiting for processes to exit. Nov 7 23:49:21.845866 systemd-logind[913]: Removed session 28. Nov 7 23:49:21.883306 sshd[1323]: Accepted publickey for core from 10.0.0.1 port 34386 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:21.884391 sshd[1323]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:21.886700 kernel: audit: type=1006 audit(1762559361.883:356): pid=1323 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=29 res=1 Nov 7 23:49:21.888886 systemd-logind[913]: New session 29 of user core. Nov 7 23:49:21.897912 systemd[1]: Started Session 29 of User core. Nov 7 23:49:21.948984 sshd[1323]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:21.963652 systemd[1]: sshd@28-10.0.0.4:22-10.0.0.1:34386.service: Deactivated successfully. Nov 7 23:49:21.965308 systemd[1]: session-29.scope: Deactivated successfully. Nov 7 23:49:21.966000 systemd-logind[913]: Session 29 logged out. Waiting for processes to exit. Nov 7 23:49:21.967129 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34398). Nov 7 23:49:21.967861 systemd-logind[913]: Removed session 29. Nov 7 23:49:22.009792 sshd[1330]: Accepted publickey for core from 10.0.0.1 port 34398 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:22.010896 sshd[1330]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:22.012790 kernel: audit: type=1006 audit(1762559362.008:357): pid=1330 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 7 23:49:22.015502 systemd-logind[913]: New session 30 of user core. Nov 7 23:49:22.022937 systemd[1]: Started Session 30 of User core. Nov 7 23:49:22.075230 sudo[1334]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Nov 7 23:49:22.075466 sudo[1334]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 7 23:49:22.083006 systemd[1]: sshd.socket: Deactivated successfully. Nov 7 23:49:22.083391 systemd[1]: Closed OpenSSH Server Socket. Nov 7 23:49:22.084642 sudo[1334]: pam_unix(sudo:session): session closed for user root Nov 7 23:49:22.088851 sudo[1333]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Nov 7 23:49:22.089068 sudo[1333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 7 23:49:22.122897 systemd[1]: Stopping Session 1 of User core... Nov 7 23:49:22.124144 sshd[941]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:22.128307 sudo[1333]: pam_unix(sudo:session): session closed for user root Nov 7 23:49:22.128466 systemd[1]: Stopping Session 30 of User core... Nov 7 23:49:22.128451 sshd[1330]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:22.129555 systemd[1]: Removed slice Slice /system/addon-config. Nov 7 23:49:22.132392 systemd[1]: Removed slice Slice /system/addon-run. Nov 7 23:49:22.133644 systemd[1]: Removed slice Slice /system/modprobe. Nov 7 23:49:22.134844 systemd[1]: Removed slice Slice /system/system-cloudinit. Nov 7 23:49:22.139952 systemd[1]: Stopped target Multi-User System. Nov 7 23:49:22.141279 systemd[1]: Stopped target Login Prompts. Nov 7 23:49:22.142952 systemd[1]: Stopped target Containers. Nov 7 23:49:22.143739 systemd[1]: Stopped target Host and Network Name Lookups. Nov 7 23:49:22.144652 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 7 23:49:22.145805 systemd[1]: Stopped target Timer Units. Nov 7 23:49:22.146522 systemd[1]: logrotate.timer: Deactivated successfully. Nov 7 23:49:22.146571 systemd[1]: Stopped Daily Log Rotation. Nov 7 23:49:22.147429 systemd[1]: mdadm.timer: Deactivated successfully. Nov 7 23:49:22.147468 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Nov 7 23:49:22.148757 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Nov 7 23:49:22.148800 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Nov 7 23:49:22.149755 systemd[1]: Stopped target System Time Set. Nov 7 23:49:22.150525 systemd[1]: Stopped target Load user-provided cloud configs. Nov 7 23:49:22.151576 systemd[1]: Stopped target Load system-provided cloud configs. Nov 7 23:49:22.152748 systemd[1]: systemd-coredump.socket: Deactivated successfully. Nov 7 23:49:22.152852 systemd[1]: Closed Process Core Dump Socket. Nov 7 23:49:22.154829 systemd[1]: Unmounting Boot partition... Nov 7 23:49:22.156235 systemd[1]: Stopping Getty on tty1... Nov 7 23:49:22.157461 systemd[1]: Stopping Serial Getty on ttyAMA0... Nov 7 23:49:22.158493 systemd[1]: Stopping OpenSSH per-connection server daemon... Nov 7 23:49:22.159572 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:34398)... Nov 7 23:49:22.160546 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Nov 7 23:49:22.160716 systemd[1]: Stopped Commit a transient machine-id on disk. Nov 7 23:49:22.161759 sshd[1330]: pam_systemd(sshd:session): Failed to release session: Interrupted system call Nov 7 23:49:22.161815 systemd[1]: Stopped target First Boot Complete. Nov 7 23:49:22.170815 systemd[1]: Stopping Load/Save Random Seed... Nov 7 23:49:22.171818 systemd[1]: Stopping Update Engine... Nov 7 23:49:22.175315 systemd[1]: sshd@0-10.0.0.4:22-10.0.0.1:38730.service: Deactivated successfully. Nov 7 23:49:22.175540 systemd[1]: Stopped OpenSSH per-connection server daemon. Nov 7 23:49:22.177249 systemd[1]: getty@tty1.service: Deactivated successfully. Nov 7 23:49:22.177459 systemd[1]: Stopped Getty on tty1. Nov 7 23:49:22.178764 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Nov 7 23:49:22.178972 systemd[1]: Stopped Serial Getty on ttyAMA0. Nov 7 23:49:22.180594 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Nov 7 23:49:22.180690 systemd[1]: update-engine.service: Failed with result 'exit-code'. Nov 7 23:49:22.180983 systemd[1]: Stopped Update Engine. Nov 7 23:49:22.182020 systemd[1]: update-engine.service: Consumed 2.487s CPU time. Nov 7 23:49:22.182308 systemd[1]: sshd@29-10.0.0.4:22-10.0.0.1:34398.service: Deactivated successfully. Nov 7 23:49:22.182520 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:34398). Nov 7 23:49:22.196327 systemd[1]: boot.mount: Deactivated successfully. Nov 7 23:49:22.196615 systemd[1]: Unmounted Boot partition. Nov 7 23:49:22.197894 systemd[1]: systemd-random-seed.service: Deactivated successfully. Nov 7 23:49:22.198132 systemd[1]: Stopped Load/Save Random Seed. Nov 7 23:49:22.199126 systemd[1]: session-30.scope: Deactivated successfully. Nov 7 23:49:22.199420 systemd[1]: Stopped Session 30 of User core. Nov 7 23:49:22.200446 systemd[1]: session-1.scope: Deactivated successfully. Nov 7 23:49:22.200709 systemd[1]: Stopped Session 1 of User core. Nov 7 23:49:22.201843 systemd-logind[913]: Session 1 logged out. Waiting for processes to exit. Nov 7 23:49:22.202799 systemd-logind[913]: Session 30 logged out. Waiting for processes to exit. Nov 7 23:49:22.203044 systemd[1]: Removed slice Slice /system/getty. Nov 7 23:49:22.204143 systemd[1]: Removed slice Slice /system/serial-getty. Nov 7 23:49:22.205344 systemd[1]: Removed slice Slice /system/sshd. Nov 7 23:49:22.206584 systemd[1]: sshd-keygen.service: Deactivated successfully. Nov 7 23:49:22.206701 systemd[1]: Stopped Generate sshd host keys. Nov 7 23:49:22.207509 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Nov 7 23:49:22.207625 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Nov 7 23:49:22.208991 systemd[1]: Stopping User Login Management... Nov 7 23:49:22.210017 systemd[1]: Stopping User Manager for UID 500... Nov 7 23:49:22.210983 systemd[952]: Stopped target Main User Target. Nov 7 23:49:22.211001 systemd[952]: Stopped target Basic System. Nov 7 23:49:22.211011 systemd[952]: Stopped target Paths. Nov 7 23:49:22.211019 systemd[952]: Stopped target Sockets. Nov 7 23:49:22.211036 systemd[952]: Reached target Shutdown. Nov 7 23:49:22.211043 systemd[952]: Stopped target Timers. Nov 7 23:49:22.211156 systemd[952]: Finished Exit the Session. Nov 7 23:49:22.211190 systemd[952]: Reached target Exit the Session. Nov 7 23:49:22.212557 systemd-logind[913]: Removed session 30. Nov 7 23:49:22.213920 systemd[1]: user@500.service: Deactivated successfully. Nov 7 23:49:22.214255 systemd[1]: Stopped User Manager for UID 500. Nov 7 23:49:22.216231 systemd[1]: Stopping User Runtime Directory /run/user/500... Nov 7 23:49:22.220568 systemd[1]: systemd-logind.service: Deactivated successfully. Nov 7 23:49:22.220871 systemd[1]: Stopped User Login Management. Nov 7 23:49:22.222949 systemd[1]: run-user-500.mount: Deactivated successfully. Nov 7 23:49:22.223016 systemd[1]: Unmounted /run/user/500. Nov 7 23:49:22.224157 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Nov 7 23:49:22.224387 systemd[1]: Stopped User Runtime Directory /run/user/500. Nov 7 23:49:22.226002 systemd[1]: Removed slice User Slice of UID 500. Nov 7 23:49:22.226000 audit: BPF prog-id=59 op=UNLOAD Nov 7 23:49:22.227691 kernel: audit: type=1334 audit(1762559362.226:358): prog-id=59 op=UNLOAD Nov 7 23:49:22.228609 systemd[1]: Stopping D-Bus System Message Bus... Nov 7 23:49:22.237749 systemd[1]: Stopping Permit User Sessions... Nov 7 23:49:22.238969 systemd[1]: dbus.service: Deactivated successfully. Nov 7 23:49:22.239232 systemd[1]: Stopped D-Bus System Message Bus. Nov 7 23:49:22.242312 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Nov 7 23:49:22.242531 systemd[1]: Stopped Permit User Sessions. Nov 7 23:49:22.243413 systemd[1]: Stopped target Basic System. Nov 7 23:49:22.244300 systemd[1]: Stopped target Network. Nov 7 23:49:22.244985 systemd[1]: Stopped target Path Units. Nov 7 23:49:22.245658 systemd[1]: motdgen.path: Deactivated successfully. Nov 7 23:49:22.249732 systemd[1]: Stopped Watch for update engine configuration changes. Nov 7 23:49:22.250730 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Nov 7 23:49:22.254766 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 7 23:49:22.255861 systemd[1]: Stopped target Remote File Systems. Nov 7 23:49:22.256608 systemd[1]: Stopped target Slice Units. Nov 7 23:49:22.257671 systemd[1]: Removed slice User and Session Slice. Nov 7 23:49:22.258466 systemd[1]: Stopped target Socket Units. Nov 7 23:49:22.259304 systemd[1]: dbus.socket: Deactivated successfully. Nov 7 23:49:22.259365 systemd[1]: Closed D-Bus System Message Bus Socket. Nov 7 23:49:22.260386 systemd[1]: docker.socket: Deactivated successfully. Nov 7 23:49:22.260637 systemd[1]: Closed Docker Socket for the API. Nov 7 23:49:22.261517 systemd[1]: Stopped target System Initialization. Nov 7 23:49:22.262380 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Nov 7 23:49:22.262520 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Nov 7 23:49:22.263597 systemd[1]: Stopped target Local Verity Protected Volumes. Nov 7 23:49:22.265551 systemd[1]: Stopping Load Security Auditing Rules... Nov 7 23:49:22.266484 systemd[1]: Stopping Network Name Resolution... Nov 7 23:49:22.267555 auditctl[1349]: No rules Nov 7 23:49:22.267787 systemd[1]: Stopping Network Time Synchronization... Nov 7 23:49:22.268486 systemd[1]: systemd-update-done.service: Deactivated successfully. Nov 7 23:49:22.268562 systemd[1]: Stopped Update is Completed. Nov 7 23:49:22.269347 systemd[1]: ldconfig.service: Deactivated successfully. Nov 7 23:49:22.269401 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Nov 7 23:49:22.270243 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Nov 7 23:49:22.270305 systemd[1]: Stopped Rebuild Hardware Database. Nov 7 23:49:22.271229 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Nov 7 23:49:22.271291 systemd[1]: Stopped Rebuild Journal Catalog. Nov 7 23:49:22.273800 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Nov 7 23:49:22.276381 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 7 23:49:22.276642 systemd[1]: Stopped Network Name Resolution. Nov 7 23:49:22.277854 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Nov 7 23:49:22.278104 systemd[1]: Stopped Network Time Synchronization. Nov 7 23:49:22.279243 systemd[1]: audit-rules.service: Deactivated successfully. Nov 7 23:49:22.279476 systemd[1]: Stopped Load Security Auditing Rules. Nov 7 23:49:22.281985 systemd[1]: Stopping Network Configuration... Nov 7 23:49:22.282948 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Nov 7 23:49:22.283194 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Nov 7 23:49:22.284859 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 7 23:49:22.284957 systemd[1]: Stopped Create Volatile Files and Directories. Nov 7 23:49:22.285859 systemd[1]: Stopped target Local File Systems. Nov 7 23:49:22.287722 systemd-networkd[837]: eth0: DHCPv6 lease lost Nov 7 23:49:22.294897 kernel: audit: type=1334 audit(1762559362.293:359): prog-id=51 op=UNLOAD Nov 7 23:49:22.294923 kernel: audit: type=1334 audit(1762559362.294:360): prog-id=55 op=UNLOAD Nov 7 23:49:22.293000 audit: BPF prog-id=51 op=UNLOAD Nov 7 23:49:22.294000 audit: BPF prog-id=55 op=UNLOAD Nov 7 23:49:22.296402 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Nov 7 23:49:22.297927 systemd[1]: Unmounting External Media Directory... Nov 7 23:49:22.299528 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Nov 7 23:49:22.301408 systemd[1]: Unmounting /run/torcx/unpack... Nov 7 23:49:22.302715 systemd[1]: Unmounting Temporary Directory /tmp... Nov 7 23:49:22.304048 systemd[1]: Unmounting /usr/share/oem... Nov 7 23:49:22.306149 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Nov 7 23:49:22.308663 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 7 23:49:22.309021 systemd[1]: Stopped Network Configuration. Nov 7 23:49:22.310415 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Nov 7 23:49:22.310670 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Nov 7 23:49:22.311998 systemd[1]: media.mount: Deactivated successfully. Nov 7 23:49:22.312277 systemd[1]: Unmounted External Media Directory. Nov 7 23:49:22.313216 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Nov 7 23:49:22.313712 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Nov 7 23:49:22.327923 systemd[1]: tmp.mount: Deactivated successfully. Nov 7 23:49:22.328229 systemd[1]: Unmounted Temporary Directory /tmp. Nov 7 23:49:22.329292 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Nov 7 23:49:22.329528 systemd[1]: Unmounted /run/torcx/unpack. Nov 7 23:49:22.330562 systemd[1]: usr-share-oem.mount: Deactivated successfully. Nov 7 23:49:22.330832 systemd[1]: Unmounted /usr/share/oem. Nov 7 23:49:22.331635 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Nov 7 23:49:22.331916 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Nov 7 23:49:22.332000 audit: BPF prog-id=50 op=UNLOAD Nov 7 23:49:22.334304 systemd[1]: Stopped target Swaps. Nov 7 23:49:22.334892 kernel: audit: type=1334 audit(1762559362.332:361): prog-id=50 op=UNLOAD Nov 7 23:49:22.335142 systemd[1]: Reached target Unmount All Filesystems. Nov 7 23:49:22.335982 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 7 23:49:22.336047 systemd[1]: Closed Network Service Netlink Socket. Nov 7 23:49:22.336840 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Nov 7 23:49:22.336907 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Nov 7 23:49:22.338118 systemd[1]: Removed slice Slice /system/systemd-fsck. Nov 7 23:49:22.338951 systemd[1]: Stopped target Preparation for Local File Systems. Nov 7 23:49:22.340152 systemd[1]: lvm2-activation.service: Deactivated successfully. Nov 7 23:49:22.340222 systemd[1]: Stopped Activation of LVM2 logical volumes. Nov 7 23:49:22.341148 systemd[1]: Stopped target Local Encrypted Volumes. Nov 7 23:49:22.341956 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 7 23:49:22.342067 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 7 23:49:22.343070 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Nov 7 23:49:22.346733 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Nov 7 23:49:22.347950 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Nov 7 23:49:22.348043 systemd[1]: Stopped Activation of LVM2 logical volumes. Nov 7 23:49:22.349127 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 7 23:49:22.349263 systemd[1]: Stopped Apply Kernel Variables. Nov 7 23:49:22.350135 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 7 23:49:22.350194 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 7 23:49:22.351274 systemd[1]: systemd-sysusers.service: Deactivated successfully. Nov 7 23:49:22.351326 systemd[1]: Stopped Create System Users. Nov 7 23:49:22.352132 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Nov 7 23:49:22.352186 systemd[1]: Stopped Remount Root and Kernel File Systems. Nov 7 23:49:22.353160 systemd[1]: Reached target System Shutdown. Nov 7 23:49:22.353971 systemd[1]: Reached target Late Shutdown Services. Nov 7 23:49:22.354899 systemd[1]: systemd-reboot.service: Deactivated successfully. Nov 7 23:49:22.354935 systemd[1]: Finished System Reboot. Nov 7 23:49:22.355580 systemd[1]: Reached target System Reboot. Nov 7 23:49:22.356319 systemd[1]: Shutting down. Nov 7 23:49:22.359000 audit: BPF prog-id=54 op=UNLOAD Nov 7 23:49:22.360000 audit: BPF prog-id=53 op=UNLOAD Nov 7 23:49:22.360000 audit: BPF prog-id=52 op=UNLOAD Nov 7 23:49:22.361689 kernel: audit: type=1334 audit(1762559362.359:362): prog-id=54 op=UNLOAD Nov 7 23:49:22.361000 audit: BPF prog-id=58 op=UNLOAD Nov 7 23:49:22.361000 audit: BPF prog-id=57 op=UNLOAD Nov 7 23:49:22.361000 audit: BPF prog-id=56 op=UNLOAD Nov 7 23:49:22.361000 audit: BPF prog-id=61 op=UNLOAD Nov 7 23:49:22.361000 audit: BPF prog-id=60 op=UNLOAD Nov 7 23:49:22.398706 systemd-shutdown[1]: Syncing filesystems and block devices. Nov 7 23:49:22.405916 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Nov 7 23:49:22.405981 systemd-journald[800]: Journal stopped -- Reboot -- Nov 7 23:49:29.702493 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 7 23:49:29.702511 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 7 23:49:29.702520 kernel: efi: EFI v2.70 by EDK II Nov 7 23:49:29.702526 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Nov 7 23:49:29.702531 kernel: efi: seeding entropy pool Nov 7 23:49:29.702536 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Nov 7 23:49:29.702543 kernel: ACPI: Early table checksum verification disabled Nov 7 23:49:29.702548 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Nov 7 23:49:29.702553 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 7 23:49:29.702558 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:29.702566 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:29.702571 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:29.702577 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:29.702583 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:29.702589 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:29.702595 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:29.702601 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:29.702607 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 7 23:49:29.702613 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 7 23:49:29.702619 kernel: ACPI: NUMA: Failed to initialise from firmware Nov 7 23:49:29.702625 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 7 23:49:29.702630 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Nov 7 23:49:29.702635 kernel: Zone ranges: Nov 7 23:49:29.702641 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 7 23:49:29.702646 kernel: DMA32 empty Nov 7 23:49:29.702652 kernel: Normal empty Nov 7 23:49:29.702657 kernel: Movable zone start for each node Nov 7 23:49:29.702663 kernel: Early memory node ranges Nov 7 23:49:29.702669 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Nov 7 23:49:29.702674 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Nov 7 23:49:29.702680 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Nov 7 23:49:29.702685 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Nov 7 23:49:29.702691 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Nov 7 23:49:29.702696 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Nov 7 23:49:29.702702 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Nov 7 23:49:29.702707 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 7 23:49:29.702713 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 7 23:49:29.702718 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 7 23:49:29.702723 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 7 23:49:29.702729 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 7 23:49:29.702738 kernel: On node 0 totalpages: 643072 Nov 7 23:49:29.702744 kernel: DMA zone: 10048 pages used for memmap Nov 7 23:49:29.702750 kernel: DMA zone: 0 pages reserved Nov 7 23:49:29.702756 kernel: DMA zone: 643072 pages, LIFO batch:63 Nov 7 23:49:29.702762 kernel: psci: probing for conduit method from ACPI. Nov 7 23:49:29.702767 kernel: psci: PSCIv1.1 detected in firmware. Nov 7 23:49:29.702773 kernel: psci: Using standard PSCI v0.2 function IDs Nov 7 23:49:29.702779 kernel: psci: Trusted OS migration not required Nov 7 23:49:29.702785 kernel: psci: SMC Calling Convention v1.1 Nov 7 23:49:29.702791 kernel: ACPI: SRAT not present Nov 7 23:49:29.702797 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Nov 7 23:49:29.702803 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Nov 7 23:49:29.702808 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 7 23:49:29.702814 kernel: Detected PIPT I-cache on CPU0 Nov 7 23:49:29.702820 kernel: CPU features: detected: GIC system register CPU interface Nov 7 23:49:29.702826 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 7 23:49:29.702831 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 7 23:49:29.702837 kernel: CPU features: detected: Hardware dirty bit management Nov 7 23:49:29.702843 kernel: CPU features: detected: Spectre-v4 Nov 7 23:49:29.702850 kernel: CPU features: detected: ARM erratum 1418040 Nov 7 23:49:29.702856 kernel: CPU features: detected: Spectre-BHB Nov 7 23:49:29.702862 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 7 23:49:29.702867 kernel: Policy zone: DMA Nov 7 23:49:29.702874 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 7 23:49:29.702881 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 7 23:49:29.702887 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 7 23:49:29.702892 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 7 23:49:29.702898 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Nov 7 23:49:29.702904 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Nov 7 23:49:29.702909 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 7 23:49:29.702916 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 7 23:49:29.702923 kernel: rcu: RCU event tracing is enabled. Nov 7 23:49:29.702929 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 7 23:49:29.702935 kernel: Trampoline variant of Tasks RCU enabled. Nov 7 23:49:29.702941 kernel: Tracing variant of Tasks RCU enabled. Nov 7 23:49:29.702947 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 7 23:49:29.702952 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 7 23:49:29.702958 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 7 23:49:29.702964 kernel: GICv3: 256 SPIs implemented Nov 7 23:49:29.702970 kernel: GICv3: 0 Extended SPIs implemented Nov 7 23:49:29.702976 kernel: GICv3: Distributor has no Range Selector support Nov 7 23:49:29.702981 kernel: GICv3: 16 PPIs implemented Nov 7 23:49:29.702988 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 7 23:49:29.702994 kernel: ACPI: SRAT not present Nov 7 23:49:29.703000 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 7 23:49:29.703006 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Nov 7 23:49:29.703012 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Nov 7 23:49:29.703018 kernel: GICv3: using LPI property table @0x00000000400d0000 Nov 7 23:49:29.703024 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Nov 7 23:49:29.703030 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 7 23:49:29.703036 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 7 23:49:29.703042 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 7 23:49:29.703048 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 7 23:49:29.703054 kernel: arm-pv: using stolen time PV Nov 7 23:49:29.703062 kernel: Console: colour dummy device 80x25 Nov 7 23:49:29.703068 kernel: ACPI: Core revision 20200925 Nov 7 23:49:29.703074 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 7 23:49:29.703081 kernel: pid_max: default: 32768 minimum: 301 Nov 7 23:49:29.703087 kernel: LSM: Security Framework initializing Nov 7 23:49:29.703093 kernel: SELinux: Initializing. Nov 7 23:49:29.703100 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 7 23:49:29.703106 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 7 23:49:29.703112 kernel: rcu: Hierarchical SRCU implementation. Nov 7 23:49:29.703119 kernel: Platform MSI: ITS@0x8080000 domain created Nov 7 23:49:29.703125 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 7 23:49:29.703131 kernel: Remapping and enabling EFI services. Nov 7 23:49:29.703137 kernel: smp: Bringing up secondary CPUs ... Nov 7 23:49:29.703143 kernel: Detected PIPT I-cache on CPU1 Nov 7 23:49:29.703149 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 7 23:49:29.703155 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Nov 7 23:49:29.703161 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 7 23:49:29.703167 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 7 23:49:29.703173 kernel: Detected PIPT I-cache on CPU2 Nov 7 23:49:29.703181 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 7 23:49:29.703187 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Nov 7 23:49:29.703193 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 7 23:49:29.703206 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 7 23:49:29.703213 kernel: Detected PIPT I-cache on CPU3 Nov 7 23:49:29.703224 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 7 23:49:29.703230 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Nov 7 23:49:29.703237 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 7 23:49:29.703244 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 7 23:49:29.703250 kernel: smp: Brought up 1 node, 4 CPUs Nov 7 23:49:29.703256 kernel: SMP: Total of 4 processors activated. Nov 7 23:49:29.703262 kernel: CPU features: detected: Privileged Access Never Nov 7 23:49:29.703269 kernel: CPU features: detected: LSE atomic instructions Nov 7 23:49:29.703275 kernel: CPU features: detected: User Access Override Nov 7 23:49:29.703281 kernel: CPU features: detected: 32-bit EL0 Support Nov 7 23:49:29.703287 kernel: CPU features: detected: Common not Private translations Nov 7 23:49:29.703294 kernel: CPU features: detected: RAS Extension Support Nov 7 23:49:29.703302 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 7 23:49:29.703309 kernel: CPU features: detected: CRC32 instructions Nov 7 23:49:29.703316 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 7 23:49:29.703322 kernel: CPU: All CPU(s) started at EL1 Nov 7 23:49:29.703328 kernel: alternatives: patching kernel code Nov 7 23:49:29.703335 kernel: devtmpfs: initialized Nov 7 23:49:29.703342 kernel: KASLR enabled Nov 7 23:49:29.703348 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 7 23:49:29.703355 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 7 23:49:29.703370 kernel: pinctrl core: initialized pinctrl subsystem Nov 7 23:49:29.703377 kernel: SMBIOS 3.0.0 present. Nov 7 23:49:29.703383 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Nov 7 23:49:29.703389 kernel: NET: Registered protocol family 16 Nov 7 23:49:29.703395 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 7 23:49:29.703401 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 7 23:49:29.703409 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 7 23:49:29.703416 kernel: audit: initializing netlink subsys (disabled) Nov 7 23:49:29.703423 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 7 23:49:29.703430 kernel: audit: type=2000 audit(0.035:1): state=initialized audit_enabled=0 res=1 Nov 7 23:49:29.703458 kernel: cpuidle: using governor menu Nov 7 23:49:29.703465 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 7 23:49:29.703471 kernel: ASID allocator initialised with 32768 entries Nov 7 23:49:29.703477 kernel: ACPI: bus type PCI registered Nov 7 23:49:29.703484 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 7 23:49:29.703492 kernel: Serial: AMBA PL011 UART driver Nov 7 23:49:29.703499 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 7 23:49:29.703505 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 7 23:49:29.703511 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 7 23:49:29.703517 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 7 23:49:29.703524 kernel: cryptd: max_cpu_qlen set to 1000 Nov 7 23:49:29.703530 kernel: ACPI: Added _OSI(Module Device) Nov 7 23:49:29.703536 kernel: ACPI: Added _OSI(Processor Device) Nov 7 23:49:29.703543 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 7 23:49:29.703550 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 7 23:49:29.703558 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 7 23:49:29.703564 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 7 23:49:29.703571 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 7 23:49:29.703577 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 7 23:49:29.703584 kernel: ACPI: Interpreter enabled Nov 7 23:49:29.703590 kernel: ACPI: Using GIC for interrupt routing Nov 7 23:49:29.703596 kernel: ACPI: MCFG table detected, 1 entries Nov 7 23:49:29.703603 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 7 23:49:29.703609 kernel: printk: console [ttyAMA0] enabled Nov 7 23:49:29.703617 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 7 23:49:29.703738 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 7 23:49:29.703798 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 7 23:49:29.703853 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 7 23:49:29.703906 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 7 23:49:29.703968 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 7 23:49:29.703976 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 7 23:49:29.703984 kernel: PCI host bridge to bus 0000:00 Nov 7 23:49:29.704048 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 7 23:49:29.704098 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 7 23:49:29.704147 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 7 23:49:29.704194 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 7 23:49:29.704277 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 7 23:49:29.704341 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 7 23:49:29.704402 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 7 23:49:29.704471 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 7 23:49:29.704529 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 7 23:49:29.704586 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 7 23:49:29.704645 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 7 23:49:29.704703 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 7 23:49:29.704756 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 7 23:49:29.704824 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 7 23:49:29.704875 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 7 23:49:29.704883 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Nov 7 23:49:29.704890 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Nov 7 23:49:29.704897 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Nov 7 23:49:29.704903 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Nov 7 23:49:29.704909 kernel: vgaarb: loaded Nov 7 23:49:29.704915 kernel: Registered efivars operations Nov 7 23:49:29.704921 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 7 23:49:29.704929 kernel: VFS: Disk quotas dquot_6.6.0 Nov 7 23:49:29.704935 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 7 23:49:29.704942 kernel: pnp: PnP ACPI init Nov 7 23:49:29.705000 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 7 23:49:29.705051 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Nov 7 23:49:29.705059 kernel: pnp: PnP ACPI: found 1 devices Nov 7 23:49:29.705065 kernel: NET: Registered protocol family 2 Nov 7 23:49:29.705071 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 7 23:49:29.705079 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 7 23:49:29.705086 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 7 23:49:29.705092 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 7 23:49:29.705098 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 7 23:49:29.705104 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 7 23:49:29.705110 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 7 23:49:29.705116 kernel: NET: Registered protocol family 1 Nov 7 23:49:29.705122 kernel: PCI: CLS 0 bytes, default 64 Nov 7 23:49:29.705128 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 7 23:49:29.705135 kernel: kvm [1]: HYP mode not available Nov 7 23:49:29.705142 kernel: Initialise system trusted keyrings Nov 7 23:49:29.705148 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 7 23:49:29.705154 kernel: Key type asymmetric registered Nov 7 23:49:29.705160 kernel: Asymmetric key parser 'x509' registered Nov 7 23:49:29.705166 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 7 23:49:29.705172 kernel: io scheduler mq-deadline registered Nov 7 23:49:29.705178 kernel: io scheduler kyber registered Nov 7 23:49:29.705184 kernel: io scheduler bfq registered Nov 7 23:49:29.705191 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 7 23:49:29.705203 kernel: ACPI: Power Button [PWRB] Nov 7 23:49:29.705209 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Nov 7 23:49:29.705268 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 7 23:49:29.705276 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 7 23:49:29.705282 kernel: msm_serial: driver initialized Nov 7 23:49:29.705288 kernel: random: fast init done Nov 7 23:49:29.705294 kernel: random: crng init done Nov 7 23:49:29.705300 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Nov 7 23:49:29.705306 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Nov 7 23:49:29.705314 kernel: thunder_xcv, ver 1.0 Nov 7 23:49:29.705320 kernel: thunder_bgx, ver 1.0 Nov 7 23:49:29.705326 kernel: nicpf, ver 1.0 Nov 7 23:49:29.705332 kernel: nicvf, ver 1.0 Nov 7 23:49:29.705397 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 7 23:49:29.705471 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-07T23:49:29 UTC (1762559369) Nov 7 23:49:29.705481 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 7 23:49:29.705487 kernel: NET: Registered protocol family 10 Nov 7 23:49:29.705495 kernel: Segment Routing with IPv6 Nov 7 23:49:29.705501 kernel: NET: Registered protocol family 17 Nov 7 23:49:29.705507 kernel: Key type dns_resolver registered Nov 7 23:49:29.705513 kernel: registered taskstats version 1 Nov 7 23:49:29.705519 kernel: Loading compiled-in X.509 certificates Nov 7 23:49:29.705526 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Nov 7 23:49:29.705532 kernel: Key type ._fscrypt registered Nov 7 23:49:29.705538 kernel: Key type .fscrypt registered Nov 7 23:49:29.705544 kernel: Key type fscrypt-provisioning registered Nov 7 23:49:29.705551 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 7 23:49:29.705557 kernel: ima: Allocated hash algorithm: sha1 Nov 7 23:49:29.705564 kernel: ima: No architecture policies found Nov 7 23:49:29.705570 kernel: Freeing unused kernel memory: 34240K Nov 7 23:49:29.705576 kernel: Run /init as init process Nov 7 23:49:29.705582 kernel: with arguments: Nov 7 23:49:29.705588 kernel: /init Nov 7 23:49:29.705594 kernel: with environment: Nov 7 23:49:29.705600 kernel: HOME=/ Nov 7 23:49:29.705606 kernel: TERM=linux Nov 7 23:49:29.705613 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 7 23:49:29.705621 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 7 23:49:29.705630 systemd[1]: Detected virtualization kvm. Nov 7 23:49:29.705637 systemd[1]: Detected architecture arm64. Nov 7 23:49:29.705643 systemd[1]: Running in initial RAM disk. Nov 7 23:49:29.705650 systemd[1]: No hostname configured, using default hostname. Nov 7 23:49:29.705657 systemd[1]: Hostname set to . Nov 7 23:49:29.705665 systemd[1]: Initializing machine ID from VM UUID. Nov 7 23:49:29.705672 systemd[1]: Queued start job for default target Initrd Default Target. Nov 7 23:49:29.705679 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 7 23:49:29.705686 systemd[1]: Reached target Local Encrypted Volumes. Nov 7 23:49:29.705692 systemd[1]: Reached target Path Units. Nov 7 23:49:29.705699 systemd[1]: Reached target Slice Units. Nov 7 23:49:29.705705 systemd[1]: Reached target Swaps. Nov 7 23:49:29.705712 systemd[1]: Reached target Timer Units. Nov 7 23:49:29.705720 systemd[1]: Listening on Open-iSCSI iscsid Socket. Nov 7 23:49:29.705727 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Nov 7 23:49:29.705734 systemd[1]: Listening on Journal Audit Socket. Nov 7 23:49:29.705741 systemd[1]: Listening on Journal Socket (/dev/log). Nov 7 23:49:29.705748 systemd[1]: Listening on Journal Socket. Nov 7 23:49:29.705755 systemd[1]: Listening on udev Control Socket. Nov 7 23:49:29.705761 systemd[1]: Listening on udev Kernel Socket. Nov 7 23:49:29.705773 systemd[1]: Reached target Socket Units. Nov 7 23:49:29.705779 systemd[1]: Starting iSCSI UserSpace I/O driver... Nov 7 23:49:29.705788 systemd[1]: Starting Create List of Static Device Nodes... Nov 7 23:49:29.705794 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Nov 7 23:49:29.705801 systemd[1]: Starting Journal Service... Nov 7 23:49:29.705808 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 7 23:49:29.705815 systemd[1]: Starting Apply Kernel Variables... Nov 7 23:49:29.705822 systemd[1]: Starting Setup Virtual Console... Nov 7 23:49:29.705829 systemd[1]: Started iSCSI UserSpace I/O driver. Nov 7 23:49:29.705835 systemd[1]: Finished Create List of Static Device Nodes. Nov 7 23:49:29.705842 systemd[1]: Finished Apply Kernel Variables. Nov 7 23:49:29.705850 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 7 23:49:29.705858 systemd[1]: Finished Setup Virtual Console. Nov 7 23:49:29.705875 kernel: SCSI subsystem initialized Nov 7 23:49:29.705881 kernel: Loading iSCSI transport class v2.0-870. Nov 7 23:49:29.705887 systemd[1]: Starting dracut ask for additional cmdline parameters... Nov 7 23:49:29.705894 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 7 23:49:29.705904 systemd-journald[269]: Journal started Nov 7 23:49:29.705947 systemd-journald[269]: Runtime Journal (/run/log/journal/47597f7ca35148efaf74a0939ece6cab) is 6.0M, max 48.5M, 42.4M free. Nov 7 23:49:29.707449 systemd[1]: Started Journal Service. Nov 7 23:49:29.720491 systemd[1]: Finished dracut ask for additional cmdline parameters. Nov 7 23:49:29.722253 systemd[1]: Starting dracut cmdline hook... Nov 7 23:49:29.732385 dracut-cmdline[290]: dracut-dracut-053 Nov 7 23:49:29.735619 dracut-cmdline[290]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Nov 7 23:49:29.800459 kernel: iscsi: registered transport (tcp) Nov 7 23:49:29.813460 kernel: iscsi: registered transport (qla4xxx) Nov 7 23:49:29.813498 kernel: QLogic iSCSI HBA Driver Nov 7 23:49:29.824777 systemd[1]: Finished dracut cmdline hook. Nov 7 23:49:29.826413 systemd[1]: Starting dracut pre-udev hook... Nov 7 23:49:29.827706 systemd[1]: Starting Open-iSCSI... Nov 7 23:49:29.830124 iscsid[375]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 7 23:49:29.830124 iscsid[375]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Nov 7 23:49:29.830124 iscsid[375]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 7 23:49:29.830124 iscsid[375]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 7 23:49:29.830124 iscsid[375]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 7 23:49:29.841152 iscsid[375]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 7 23:49:29.843552 kernel: device-mapper: uevent: version 1.0.3 Nov 7 23:49:29.843574 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Nov 7 23:49:29.834559 systemd[1]: Started Open-iSCSI. Nov 7 23:49:29.878465 kernel: raid6: neonx8 gen() 13806 MB/s Nov 7 23:49:29.895449 kernel: raid6: neonx8 xor() 10742 MB/s Nov 7 23:49:29.912453 kernel: raid6: neonx4 gen() 13590 MB/s Nov 7 23:49:29.929453 kernel: raid6: neonx4 xor() 11505 MB/s Nov 7 23:49:29.946454 kernel: raid6: neonx2 gen() 12999 MB/s Nov 7 23:49:29.963456 kernel: raid6: neonx2 xor() 9564 MB/s Nov 7 23:49:29.980469 kernel: raid6: neonx1 gen() 10979 MB/s Nov 7 23:49:29.997465 kernel: raid6: neonx1 xor() 8797 MB/s Nov 7 23:49:30.014461 kernel: raid6: int64x8 gen() 6814 MB/s Nov 7 23:49:30.031456 kernel: raid6: int64x8 xor() 3795 MB/s Nov 7 23:49:30.048457 kernel: raid6: int64x4 gen() 6897 MB/s Nov 7 23:49:30.065449 kernel: raid6: int64x4 xor() 3835 MB/s Nov 7 23:49:30.082455 kernel: raid6: int64x2 gen() 6169 MB/s Nov 7 23:49:30.099456 kernel: raid6: int64x2 xor() 3312 MB/s Nov 7 23:49:30.116456 kernel: raid6: int64x1 gen() 4993 MB/s Nov 7 23:49:30.133529 kernel: raid6: int64x1 xor() 2594 MB/s Nov 7 23:49:30.133560 kernel: raid6: using algorithm neonx8 gen() 13806 MB/s Nov 7 23:49:30.133569 kernel: raid6: .... xor() 10742 MB/s, rmw enabled Nov 7 23:49:30.134580 kernel: raid6: using neon recovery algorithm Nov 7 23:49:30.144471 kernel: xor: measuring software checksum speed Nov 7 23:49:30.145453 kernel: 8regs : 17159 MB/sec Nov 7 23:49:30.148000 kernel: 32regs : 20776 MB/sec Nov 7 23:49:30.148015 kernel: arm64_neon : 28977 MB/sec Nov 7 23:49:30.148023 kernel: xor: using function: arm64_neon (28977 MB/sec) Nov 7 23:49:30.192460 kernel: Btrfs loaded, crc32c=crc32c-generic Nov 7 23:49:30.203970 systemd[1]: Finished dracut pre-udev hook. Nov 7 23:49:30.204000 audit: BPF prog-id=6 op=LOAD Nov 7 23:49:30.205949 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 7 23:49:30.209602 kernel: audit: type=1334 audit(1762559370.204:2): prog-id=6 op=LOAD Nov 7 23:49:30.209629 kernel: audit: type=1334 audit(1762559370.204:3): prog-id=7 op=LOAD Nov 7 23:49:30.209637 kernel: audit: type=1334 audit(1762559370.205:4): prog-id=8 op=LOAD Nov 7 23:49:30.204000 audit: BPF prog-id=7 op=LOAD Nov 7 23:49:30.205000 audit: BPF prog-id=8 op=LOAD Nov 7 23:49:30.219482 systemd-udevd[409]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 7 23:49:30.221191 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 7 23:49:30.222960 systemd[1]: Starting dracut pre-trigger hook... Nov 7 23:49:30.235155 dracut-pre-trigger[416]: rd.md=0: removing MD RAID activation Nov 7 23:49:30.258314 systemd[1]: Finished dracut pre-trigger hook. Nov 7 23:49:30.259832 systemd[1]: Starting Coldplug All udev Devices... Nov 7 23:49:30.269403 systemd-udevd[409]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 7 23:49:30.290675 systemd[1]: Finished Coldplug All udev Devices. Nov 7 23:49:30.292345 systemd[1]: Starting dracut initqueue hook... Nov 7 23:49:30.310283 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 7 23:49:30.310473 kernel: vda: detected capacity change from 0 to 4756340736 Nov 7 23:49:30.322943 systemd-udevd[456]: Using default interface naming scheme 'v249'. Nov 7 23:49:30.324105 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 7 23:49:30.344456 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (472) Nov 7 23:49:30.348200 systemd[1]: Found device /dev/disk/by-label/ROOT. Nov 7 23:49:30.354085 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Nov 7 23:49:30.355256 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Nov 7 23:49:30.359145 systemd[1]: Finished dracut initqueue hook. Nov 7 23:49:30.360029 systemd[1]: Reached target Initrd Root Device. Nov 7 23:49:30.361231 systemd[1]: Reached target Preparation for Remote File Systems. Nov 7 23:49:30.362789 systemd[1]: Reached target Remote Encrypted Volumes. Nov 7 23:49:30.364267 systemd[1]: Reached target Remote File Systems. Nov 7 23:49:30.366449 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Nov 7 23:49:30.368115 systemd[1]: Starting dracut pre-mount hook... Nov 7 23:49:30.369416 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 7 23:49:30.369548 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Nov 7 23:49:30.370578 systemd[1]: Reached target Preparation for Local File Systems. Nov 7 23:49:30.372867 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Nov 7 23:49:30.376800 systemd[1]: Finished dracut pre-mount hook. Nov 7 23:49:30.378381 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Nov 7 23:49:30.389697 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 7 23:49:30.392090 systemd-fsck[506]: ROOT: clean, 640/553792 files, 39961/553472 blocks Nov 7 23:49:30.394188 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Nov 7 23:49:30.396668 systemd[1]: Mounting /sysroot... Nov 7 23:49:30.413731 systemd[1]: Found device /dev/mapper/usr. Nov 7 23:49:30.415766 systemd[1]: Starting File System Check on /dev/mapper/usr... Nov 7 23:49:30.417776 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Nov 7 23:49:30.426764 systemd-fsck[517]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Nov 7 23:49:30.426764 systemd-fsck[517]: You must have r/w access to the filesystem or be root Nov 7 23:49:30.429959 systemd-fsck[514]: fsck failed with exit status 8. Nov 7 23:49:30.429967 systemd-fsck[514]: Ignoring error. Nov 7 23:49:30.432526 systemd[1]: Finished File System Check on /dev/mapper/usr. Nov 7 23:49:30.434144 systemd[1]: Mounting /sysusr/usr... Nov 7 23:49:30.444183 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Nov 7 23:49:30.444242 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Nov 7 23:49:30.444260 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Nov 7 23:49:30.443672 systemd[1]: Mounted /sysusr/usr. Nov 7 23:49:30.444993 systemd[1]: Reached target Local File Systems. Nov 7 23:49:30.446220 systemd[1]: Reached target System Initialization. Nov 7 23:49:30.447631 systemd[1]: Reached target Basic System. Nov 7 23:49:30.449534 systemd[1]: Mounted /sysroot. Nov 7 23:49:30.450215 systemd[1]: Reached target Initrd Root File System. Nov 7 23:49:30.452357 systemd[1]: Mounting /sysroot/usr... Nov 7 23:49:30.453526 systemd[1]: Starting Reload Configuration from the Real Root... Nov 7 23:49:30.454943 systemd[1]: Mounted /sysroot/usr. Nov 7 23:49:30.457657 systemd[1]: Reloading. Nov 7 23:49:30.459000 audit: BPF prog-id=3 op=UNLOAD Nov 7 23:49:30.461450 kernel: audit: type=1334 audit(1762559370.459:5): prog-id=3 op=UNLOAD Nov 7 23:49:30.467000 audit: BPF prog-id=6 op=UNLOAD Nov 7 23:49:30.469473 kernel: audit: type=1334 audit(1762559370.467:6): prog-id=6 op=UNLOAD Nov 7 23:49:30.547000 audit: BPF prog-id=9 op=LOAD Nov 7 23:49:30.548451 kernel: audit: type=1334 audit(1762559370.547:7): prog-id=9 op=LOAD Nov 7 23:49:30.548485 kernel: audit: type=1334 audit(1762559370.547:8): prog-id=10 op=LOAD Nov 7 23:49:30.547000 audit: BPF prog-id=10 op=LOAD Nov 7 23:49:30.548000 audit: BPF prog-id=11 op=LOAD Nov 7 23:49:30.550049 kernel: audit: type=1334 audit(1762559370.548:9): prog-id=11 op=LOAD Nov 7 23:49:30.550071 kernel: audit: type=1334 audit(1762559370.548:10): prog-id=4 op=UNLOAD Nov 7 23:49:30.548000 audit: BPF prog-id=4 op=UNLOAD Nov 7 23:49:30.548000 audit: BPF prog-id=5 op=UNLOAD Nov 7 23:49:30.549000 audit: BPF prog-id=12 op=LOAD Nov 7 23:49:30.550000 audit: BPF prog-id=13 op=LOAD Nov 7 23:49:30.550000 audit: BPF prog-id=14 op=LOAD Nov 7 23:49:30.550000 audit: BPF prog-id=7 op=UNLOAD Nov 7 23:49:30.550000 audit: BPF prog-id=8 op=UNLOAD Nov 7 23:49:30.565305 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 7 23:49:30.566412 systemd[1]: Finished Reload Configuration from the Real Root. Nov 7 23:49:30.567475 systemd[1]: Reached target Initrd File Systems. Nov 7 23:49:30.568956 systemd[1]: Reached target Initrd Default Target. Nov 7 23:49:30.570346 systemd[1]: Condition check resulted in dracut mount hook being skipped. Nov 7 23:49:30.571082 systemd[1]: Starting dracut pre-pivot and cleanup hook... Nov 7 23:49:30.581717 systemd[1]: Finished dracut pre-pivot and cleanup hook. Nov 7 23:49:30.583350 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Nov 7 23:49:30.589330 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 7 23:49:30.590310 systemd[1]: Stopped target Timer Units. Nov 7 23:49:30.591659 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 7 23:49:30.591775 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Nov 7 23:49:30.593077 systemd[1]: Stopped target Initrd Default Target. Nov 7 23:49:30.594491 systemd[1]: Stopped target Basic System. Nov 7 23:49:30.595958 systemd[1]: Stopped target Initrd Root Device. Nov 7 23:49:30.597302 systemd[1]: Stopped target Path Units. Nov 7 23:49:30.598446 systemd[1]: Stopped target Remote File Systems. Nov 7 23:49:30.599853 systemd[1]: Stopped target Preparation for Remote File Systems. Nov 7 23:49:30.601281 systemd[1]: Stopped target Slice Units. Nov 7 23:49:30.602518 systemd[1]: Stopped target Socket Units. Nov 7 23:49:30.604031 systemd[1]: Stopped target System Initialization. Nov 7 23:49:30.605290 systemd[1]: Stopped target Local File Systems. Nov 7 23:49:30.606513 systemd[1]: Stopped target Preparation for Local File Systems. Nov 7 23:49:30.608080 systemd[1]: Stopped target Swaps. Nov 7 23:49:30.609208 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 7 23:49:30.609326 systemd[1]: Stopped dracut pre-mount hook. Nov 7 23:49:30.610693 systemd[1]: Stopped target Local Encrypted Volumes. Nov 7 23:49:30.611841 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 7 23:49:30.613471 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 7 23:49:30.615231 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 7 23:49:30.618847 iscsid[375]: iscsid shutting down. Nov 7 23:49:30.615339 systemd[1]: Stopped dracut initqueue hook. Nov 7 23:49:30.616900 systemd[1]: Stopping Open-iSCSI... Nov 7 23:49:30.618058 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 7 23:49:30.618166 systemd[1]: Stopped Apply Kernel Variables. Nov 7 23:49:30.619570 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 7 23:49:30.619657 systemd[1]: Stopped Coldplug All udev Devices. Nov 7 23:49:30.620735 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 7 23:49:30.620819 systemd[1]: Stopped dracut pre-trigger hook. Nov 7 23:49:30.622082 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Nov 7 23:49:30.626549 systemd[1]: iscsid.service: Deactivated successfully. Nov 7 23:49:30.626673 systemd[1]: Stopped Open-iSCSI. Nov 7 23:49:30.628123 systemd[1]: iscsid.socket: Deactivated successfully. Nov 7 23:49:30.628200 systemd[1]: Closed Open-iSCSI iscsid Socket. Nov 7 23:49:30.629594 systemd[1]: Stopping iSCSI UserSpace I/O driver... Nov 7 23:49:30.642000 audit: BPF prog-id=12 op=UNLOAD Nov 7 23:49:30.632369 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 7 23:49:30.632512 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Nov 7 23:49:30.634355 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 7 23:49:30.634475 systemd[1]: Stopped iSCSI UserSpace I/O driver. Nov 7 23:49:30.635649 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 7 23:49:30.635753 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Nov 7 23:49:30.637993 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 7 23:49:30.638044 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Nov 7 23:49:30.638947 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 7 23:49:30.638989 systemd[1]: Closed udev Control Socket. Nov 7 23:49:30.640062 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 7 23:49:30.640094 systemd[1]: Closed udev Kernel Socket. Nov 7 23:49:30.641334 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 7 23:49:30.641379 systemd[1]: Stopped dracut pre-udev hook. Nov 7 23:49:30.642686 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 7 23:49:30.642726 systemd[1]: Stopped dracut cmdline hook. Nov 7 23:49:30.644112 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 7 23:49:30.644152 systemd[1]: Stopped dracut ask for additional cmdline parameters. Nov 7 23:49:30.646498 systemd[1]: Starting Cleanup udev Database... Nov 7 23:49:30.666000 audit: BPF prog-id=9 op=UNLOAD Nov 7 23:49:30.647360 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Nov 7 23:49:30.648972 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 7 23:49:30.649034 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 7 23:49:30.650498 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 7 23:49:30.650542 systemd[1]: Stopped Create List of Static Device Nodes. Nov 7 23:49:30.652331 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 7 23:49:30.652378 systemd[1]: Stopped Setup Virtual Console. Nov 7 23:49:30.654222 systemd[1]: rngd.service: Deactivated successfully. Nov 7 23:49:30.654354 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Nov 7 23:49:30.655684 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 7 23:49:30.655799 systemd[1]: Finished Cleanup udev Database. Nov 7 23:49:30.657010 systemd[1]: Reached target Switch Root. Nov 7 23:49:30.659179 systemd[1]: Starting Switch Root... Nov 7 23:49:30.665342 systemd[1]: Switching root. Nov 7 23:49:30.680714 systemd-journald[269]: Journal stopped Nov 7 23:49:32.786232 systemd-journald[269]: Received SIGTERM from PID 1 (systemd). Nov 7 23:49:32.786294 kernel: SELinux: policy capability network_peer_controls=1 Nov 7 23:49:32.786312 kernel: SELinux: policy capability open_perms=1 Nov 7 23:49:32.786322 kernel: SELinux: policy capability extended_socket_class=1 Nov 7 23:49:32.786337 kernel: SELinux: policy capability always_check_network=0 Nov 7 23:49:32.786347 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 7 23:49:32.786359 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 7 23:49:32.786369 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 7 23:49:32.786379 systemd[1]: Successfully loaded SELinux policy in 30.914ms. Nov 7 23:49:32.786392 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.245ms. Nov 7 23:49:32.786404 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 7 23:49:32.786415 systemd[1]: Detected virtualization kvm. Nov 7 23:49:32.786425 systemd[1]: Detected architecture arm64. Nov 7 23:49:32.786460 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 7 23:49:32.786476 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 7 23:49:32.786487 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 7 23:49:32.786496 systemd[1]: Stopped Switch Root. Nov 7 23:49:32.786506 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 7 23:49:32.786516 systemd[1]: Created slice Slice /system/addon-config. Nov 7 23:49:32.786526 systemd[1]: Created slice Slice /system/addon-run. Nov 7 23:49:32.786536 systemd[1]: Created slice Slice /system/getty. Nov 7 23:49:32.786545 systemd[1]: Created slice Slice /system/modprobe. Nov 7 23:49:32.786558 systemd[1]: Created slice Slice /system/serial-getty. Nov 7 23:49:32.786569 systemd[1]: Created slice Slice /system/system-cloudinit. Nov 7 23:49:32.786580 systemd[1]: Created slice Slice /system/systemd-fsck. Nov 7 23:49:32.786589 systemd[1]: Created slice User and Session Slice. Nov 7 23:49:32.786599 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 7 23:49:32.786609 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Nov 7 23:49:32.786694 systemd[1]: Set up automount Boot partition Automount Point. Nov 7 23:49:32.786745 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 7 23:49:32.786889 systemd[1]: Stopped target Switch Root. Nov 7 23:49:32.786908 systemd[1]: Stopped target Initrd File Systems. Nov 7 23:49:32.786934 systemd[1]: Stopped target Initrd Root File System. Nov 7 23:49:32.786945 systemd[1]: Reached target Remote Encrypted Volumes. Nov 7 23:49:32.786955 systemd[1]: Reached target Remote File Systems. Nov 7 23:49:32.786965 systemd[1]: Reached target Slice Units. Nov 7 23:49:32.786989 systemd[1]: Reached target Swaps. Nov 7 23:49:32.786999 systemd[1]: Reached target Verify torcx succeeded. Nov 7 23:49:32.787009 systemd[1]: Reached target Local Verity Protected Volumes. Nov 7 23:49:32.787019 systemd[1]: Listening on Process Core Dump Socket. Nov 7 23:49:32.787030 systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 7 23:49:32.787041 systemd[1]: Listening on Network Service Netlink Socket. Nov 7 23:49:32.787053 systemd[1]: Listening on udev Control Socket. Nov 7 23:49:32.787064 systemd[1]: Listening on udev Kernel Socket. Nov 7 23:49:32.787138 systemd[1]: Mounting Huge Pages File System... Nov 7 23:49:32.787155 systemd[1]: Mounting POSIX Message Queue File System... Nov 7 23:49:32.787169 systemd[1]: Mounting External Media Directory... Nov 7 23:49:32.787180 systemd[1]: Mounting Kernel Debug File System... Nov 7 23:49:32.787198 systemd[1]: Mounting Kernel Trace File System... Nov 7 23:49:32.787208 systemd[1]: Mounting Temporary Directory /tmp... Nov 7 23:49:32.787219 systemd[1]: Starting Create missing system files... Nov 7 23:49:32.787232 systemd[1]: Starting Create List of Static Device Nodes... Nov 7 23:49:32.787242 systemd[1]: Starting Load Kernel Module configfs... Nov 7 23:49:32.787252 systemd[1]: Starting Load Kernel Module drm... Nov 7 23:49:32.787262 systemd[1]: Starting Load Kernel Module fuse... Nov 7 23:49:32.787272 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Nov 7 23:49:32.787282 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 7 23:49:32.787296 systemd[1]: Stopped File System Check on Root Device. Nov 7 23:49:32.787307 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 7 23:49:32.787317 systemd[1]: Stopped systemd-fsck-usr.service. Nov 7 23:49:32.787327 systemd[1]: Stopped Journal Service. Nov 7 23:49:32.787338 kernel: fuse: init (API version 7.32) Nov 7 23:49:32.787350 systemd[1]: Starting Journal Service... Nov 7 23:49:32.787369 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 7 23:49:32.787380 systemd[1]: Starting Remount Root and Kernel File Systems... Nov 7 23:49:32.787390 systemd[1]: Starting Apply Kernel Variables... Nov 7 23:49:32.787399 systemd[1]: Starting Coldplug All udev Devices... Nov 7 23:49:32.787410 systemd[1]: verity-setup.service: Deactivated successfully. Nov 7 23:49:32.787420 systemd[1]: Stopped verity-setup.service. Nov 7 23:49:32.787447 systemd-journald[693]: Journal started Nov 7 23:49:32.787499 systemd-journald[693]: Runtime Journal (/run/log/journal/47597f7ca35148efaf74a0939ece6cab) is 6.0M, max 48.5M, 42.4M free. Nov 7 23:49:30.752000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 7 23:49:30.779000 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 7 23:49:30.779000 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 7 23:49:30.779000 audit: BPF prog-id=15 op=LOAD Nov 7 23:49:30.779000 audit: BPF prog-id=15 op=UNLOAD Nov 7 23:49:30.779000 audit: BPF prog-id=16 op=LOAD Nov 7 23:49:30.779000 audit: BPF prog-id=16 op=UNLOAD Nov 7 23:49:30.822000 audit[645]: AVC avc: denied { associate } for pid=645 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 7 23:49:32.655000 audit: BPF prog-id=17 op=LOAD Nov 7 23:49:32.656000 audit: BPF prog-id=18 op=LOAD Nov 7 23:49:32.656000 audit: BPF prog-id=19 op=LOAD Nov 7 23:49:32.656000 audit: BPF prog-id=10 op=UNLOAD Nov 7 23:49:32.656000 audit: BPF prog-id=11 op=UNLOAD Nov 7 23:49:32.665000 audit: BPF prog-id=17 op=UNLOAD Nov 7 23:49:32.769000 audit: BPF prog-id=20 op=LOAD Nov 7 23:49:32.769000 audit: BPF prog-id=21 op=LOAD Nov 7 23:49:32.769000 audit: BPF prog-id=22 op=LOAD Nov 7 23:49:32.769000 audit: BPF prog-id=18 op=UNLOAD Nov 7 23:49:32.769000 audit: BPF prog-id=19 op=UNLOAD Nov 7 23:49:32.784000 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 7 23:49:32.643028 systemd[1]: Queued start job for default target Multi-User System. Nov 7 23:49:30.820792 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" 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 7 23:49:32.657205 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 7 23:49:30.821072 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 7 23:49:30.821091 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 7 23:49:30.821410 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 7 23:49:30.821423 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 7 23:49:30.821469 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 7 23:49:30.821482 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 7 23:49:30.821820 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 7 23:49:30.821861 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 7 23:49:30.821877 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 7 23:49:30.822299 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" 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 7 23:49:30.822333 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" 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 7 23:49:30.822354 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" 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 7 23:49:30.822370 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Nov 7 23:49:30.822486 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" 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 7 23:49:30.822503 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:30Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 7 23:49:32.523667 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:32Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 7 23:49:32.523951 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:32Z" 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 7 23:49:32.524059 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:32Z" 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 7 23:49:32.524194 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:32Z" 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 7 23:49:32.524296 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:32Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 7 23:49:32.524355 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-07T23:49:32Z" 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 7 23:49:32.790626 systemd[1]: Started Journal Service. Nov 7 23:49:32.791228 systemd[1]: Mounted Huge Pages File System. Nov 7 23:49:32.792393 systemd[1]: Mounted POSIX Message Queue File System. Nov 7 23:49:32.793696 systemd[1]: Mounted External Media Directory. Nov 7 23:49:32.794798 systemd[1]: Mounted Kernel Debug File System. Nov 7 23:49:32.795838 systemd[1]: Mounted Kernel Trace File System. Nov 7 23:49:32.796855 systemd[1]: Mounted Temporary Directory /tmp. Nov 7 23:49:32.798122 systemd[1]: Finished Create missing system files. Nov 7 23:49:32.799566 systemd[1]: Finished Create List of Static Device Nodes. Nov 7 23:49:32.800888 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 7 23:49:32.801133 systemd[1]: Finished Load Kernel Module configfs. Nov 7 23:49:32.802386 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 7 23:49:32.802611 systemd[1]: Finished Load Kernel Module drm. Nov 7 23:49:32.803819 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 7 23:49:32.804000 systemd[1]: Finished Load Kernel Module fuse. Nov 7 23:49:32.805300 systemd[1]: Finished Remount Root and Kernel File Systems. Nov 7 23:49:32.806704 systemd[1]: Finished Apply Kernel Variables. Nov 7 23:49:32.819703 systemd[1]: Mounting FUSE Control File System... Nov 7 23:49:32.821736 systemd[1]: Mounting Kernel Configuration File System... Nov 7 23:49:32.822774 systemd[1]: Condition check resulted in Remount Root File System being skipped. Nov 7 23:49:32.824002 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Nov 7 23:49:32.825354 systemd[1]: Starting Flush Journal to Persistent Storage... Nov 7 23:49:32.826797 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Nov 7 23:49:32.828024 systemd[1]: Starting Load/Save Random Seed... Nov 7 23:49:32.828958 systemd[1]: Condition check resulted in Create System Users being skipped. Nov 7 23:49:32.831570 systemd-journald[693]: Time spent on flushing to /var/log/journal/47597f7ca35148efaf74a0939ece6cab is 15.018ms for 655 entries. Nov 7 23:49:32.831570 systemd-journald[693]: System Journal (/var/log/journal/47597f7ca35148efaf74a0939ece6cab) is 8.0M, max 203.0M, 195.0M free. Nov 7 23:49:32.856000 audit: BPF prog-id=23 op=LOAD Nov 7 23:49:32.857000 audit: BPF prog-id=24 op=LOAD Nov 7 23:49:32.857000 audit: BPF prog-id=25 op=LOAD Nov 7 23:49:32.857000 audit: BPF prog-id=13 op=UNLOAD Nov 7 23:49:32.857000 audit: BPF prog-id=14 op=UNLOAD Nov 7 23:49:32.830129 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 7 23:49:32.832172 systemd[1]: Mounted FUSE Control File System. Nov 7 23:49:32.834651 systemd[1]: Mounted Kernel Configuration File System. Nov 7 23:49:32.839105 systemd[1]: Finished Coldplug All udev Devices. Nov 7 23:49:32.840880 systemd[1]: Finished Load/Save Random Seed. Nov 7 23:49:32.841938 systemd[1]: Condition check resulted in First Boot Complete being skipped. Nov 7 23:49:32.846758 systemd[1]: Starting Wait for udev To Complete Device Initialization... Nov 7 23:49:32.854345 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 7 23:49:32.858427 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 7 23:49:32.863327 systemd[1]: Finished Flush Journal to Persistent Storage. Nov 7 23:49:32.889822 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 7 23:49:32.891000 audit: BPF prog-id=26 op=LOAD Nov 7 23:49:32.892887 systemd[1]: Starting Network Configuration... Nov 7 23:49:32.928776 systemd-networkd[714]: lo: Link UP Nov 7 23:49:32.928786 systemd-networkd[714]: lo: Gained carrier Nov 7 23:49:32.929117 systemd-networkd[714]: Enumeration completed Nov 7 23:49:32.929242 systemd[1]: Started Network Configuration. Nov 7 23:49:32.931020 systemd-udevd[715]: Using default interface naming scheme 'v249'. Nov 7 23:49:32.950615 udevadm[705]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Nov 7 23:49:32.968291 systemd-networkd[714]: eth0: Link UP Nov 7 23:49:32.973745 systemd[1]: Finished Wait for udev To Complete Device Initialization. Nov 7 23:49:32.976472 systemd-networkd[714]: eth0: Gained carrier Nov 7 23:49:32.981534 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 7 23:49:32.985574 systemd-networkd[714]: eth0: DHCPv4 address 10.0.0.4/16 via 10.0.0.1 Nov 7 23:49:32.990733 lvm[734]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 7 23:49:33.018594 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 7 23:49:33.019594 systemd[1]: Reached target Local Encrypted Volumes. Nov 7 23:49:33.032405 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 7 23:49:33.035886 lvm[736]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 7 23:49:33.060569 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 7 23:49:33.061596 systemd[1]: Reached target Preparation for Local File Systems. Nov 7 23:49:33.062568 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Nov 7 23:49:33.062595 systemd[1]: Reached target Containers. Nov 7 23:49:33.074718 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Nov 7 23:49:33.088383 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Nov 7 23:49:33.103538 systemd[1]: Mounting /usr/share/oem... Nov 7 23:49:33.110015 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 7 23:49:33.110096 kernel: BTRFS info (device vda6): has skinny extents Nov 7 23:49:33.112340 systemd[1]: Mounted /usr/share/oem. Nov 7 23:49:33.113214 systemd[1]: Reached target Local File Systems. Nov 7 23:49:33.114125 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Nov 7 23:49:33.114519 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 7 23:49:33.114559 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Nov 7 23:49:33.114592 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Nov 7 23:49:33.115709 systemd[1]: Starting Create Volatile Files and Directories... Nov 7 23:49:33.121823 systemd-tmpfiles[759]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 7 23:49:33.122871 systemd-tmpfiles[759]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Nov 7 23:49:33.151806 systemd-tmpfiles[759]: Detected autofs mount point /boot during canonicalization of /boot. Nov 7 23:49:33.151818 systemd-tmpfiles[759]: Skipping /boot Nov 7 23:49:33.157843 systemd-tmpfiles[759]: Detected autofs mount point /boot during canonicalization of /boot. Nov 7 23:49:33.157863 systemd-tmpfiles[759]: Skipping /boot Nov 7 23:49:33.187699 systemd[1]: Finished Create Volatile Files and Directories. Nov 7 23:49:33.199639 systemd[1]: Starting Load Security Auditing Rules... Nov 7 23:49:33.201675 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Nov 7 23:49:33.202754 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Nov 7 23:49:33.203000 audit: BPF prog-id=27 op=LOAD Nov 7 23:49:33.204925 systemd[1]: Starting Network Name Resolution... Nov 7 23:49:33.206000 audit: BPF prog-id=28 op=LOAD Nov 7 23:49:33.209014 systemd[1]: Starting Network Time Synchronization... Nov 7 23:49:33.209940 systemd[1]: Condition check resulted in Update is Completed being skipped. Nov 7 23:49:33.211282 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Nov 7 23:49:33.212935 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Nov 7 23:49:33.214259 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Nov 7 23:49:33.231486 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Nov 7 23:49:33.238000 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 7 23:49:33.239117 augenrules[780]: No rules Nov 7 23:49:33.244931 systemd[1]: Finished Load Security Auditing Rules. Nov 7 23:49:33.248113 systemd[1]: Started Network Time Synchronization. Nov 7 23:49:33.248228 systemd-resolved[763]: Positive Trust Anchors: Nov 7 23:49:33.248235 systemd-resolved[763]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 7 23:49:33.248263 systemd-resolved[763]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Nov 7 23:49:33.249343 systemd-timesyncd[769]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Nov 7 23:49:33.249466 systemd[1]: Reached target System Initialization. Nov 7 23:49:33.249659 systemd-resolved[763]: Defaulting to hostname 'linux'. Nov 7 23:49:33.250359 systemd[1]: Started Watch for update engine configuration changes. Nov 7 23:49:33.251524 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 7 23:49:33.252554 systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 7 23:49:33.253459 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Nov 7 23:49:33.253492 systemd[1]: Reached target Path Units. Nov 7 23:49:33.254158 systemd[1]: Reached target System Time Set. Nov 7 23:49:33.255164 systemd[1]: Started Daily Log Rotation. Nov 7 23:49:33.255986 systemd[1]: Started Weekly check for MD array's redundancy information.. Nov 7 23:49:33.257055 systemd[1]: Reached target Timer Units. Nov 7 23:49:33.258280 systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 7 23:49:33.267234 systemd[1]: Starting Docker Socket for the API... Nov 7 23:49:33.270641 systemd[1]: Listening on OpenSSH Server Socket. Nov 7 23:49:33.271970 systemd[1]: Started Network Name Resolution. Nov 7 23:49:33.272893 systemd[1]: Listening on Docker Socket for the API. Nov 7 23:49:33.273776 systemd[1]: Reached target Network. Nov 7 23:49:33.274430 systemd[1]: Reached target Host and Network Name Lookups. Nov 7 23:49:33.275291 systemd[1]: Reached target Socket Units. Nov 7 23:49:33.276385 systemd[1]: Reached target Basic System. Nov 7 23:49:33.277301 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Nov 7 23:49:33.277332 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Nov 7 23:49:33.278520 systemd[1]: Started D-Bus System Message Bus. Nov 7 23:49:33.282272 systemd[1]: Starting Extend Filesystems... Nov 7 23:49:33.283267 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Nov 7 23:49:33.284487 systemd[1]: Starting Generate /run/flatcar/motd... Nov 7 23:49:33.286511 systemd[1]: Starting Install an ssh key from /proc/cmdline... Nov 7 23:49:33.288760 systemd[1]: Starting Generate sshd host keys... Nov 7 23:49:33.290543 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Nov 7 23:49:33.290587 systemd[1]: Reached target Load system-provided cloud configs. Nov 7 23:49:33.294601 systemd[1]: Starting User Login Management... Nov 7 23:49:33.295755 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 7 23:49:33.296489 systemd[1]: Starting Update Engine... Nov 7 23:49:33.297133 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Nov 7 23:49:33.297177 systemd[1]: Reached target Load user-provided cloud configs. Nov 7 23:49:33.299253 extend-filesystems[790]: Found vda Nov 7 23:49:33.299253 extend-filesystems[790]: Found vda1 Nov 7 23:49:33.299253 extend-filesystems[790]: Found vda2 Nov 7 23:49:33.299253 extend-filesystems[790]: Found vda3 Nov 7 23:49:33.299253 extend-filesystems[790]: Found usr Nov 7 23:49:33.299253 extend-filesystems[790]: Found vda4 Nov 7 23:49:33.299253 extend-filesystems[790]: Found vda6 Nov 7 23:49:33.299253 extend-filesystems[790]: Found vda7 Nov 7 23:49:33.309266 extend-filesystems[790]: Found vda9 Nov 7 23:49:33.309266 extend-filesystems[790]: Checking size of /dev/vda9 Nov 7 23:49:33.299299 systemd[1]: motdgen.service: Deactivated successfully. Nov 7 23:49:33.299610 systemd[1]: Finished Generate /run/flatcar/motd. Nov 7 23:49:33.301798 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 7 23:49:33.302018 systemd[1]: Finished Install an ssh key from /proc/cmdline. Nov 7 23:49:33.313813 extend-filesystems[790]: Old size kept for /dev/vda9 Nov 7 23:49:33.317761 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 7 23:49:33.318004 systemd[1]: Finished Extend Filesystems. Nov 7 23:49:33.340602 systemd-logind[803]: Watching system buttons on /dev/input/event0 (Power Button) Nov 7 23:49:33.340818 systemd-logind[803]: New seat seat0. Nov 7 23:49:33.344127 systemd[1]: Started User Login Management. Nov 7 23:49:33.352117 update_engine[805]: I1107 23:49:33.351819 805 main.cc:89] Flatcar Update Engine starting Nov 7 23:49:33.352775 update_engine[805]: I1107 23:49:33.352748 805 payload_state.cc:360] Current Response Signature = Nov 7 23:49:33.352775 update_engine[805]: NumURLs = 1 Nov 7 23:49:33.352775 update_engine[805]: Url0 = http://10.0.0.3:34567/packages/update.gz Nov 7 23:49:33.352775 update_engine[805]: Payload Size = 440031851 Nov 7 23:49:33.352775 update_engine[805]: Payload Sha256 Hash = uQUy6dTYGJTZMb3bS3ifsAZBNhhWh7sCUvkHGF92C1k= Nov 7 23:49:33.352775 update_engine[805]: Is Delta Payload = 0 Nov 7 23:49:33.352775 update_engine[805]: Max Failure Count Per Url = 10 Nov 7 23:49:33.352775 update_engine[805]: Disable Payload Backoff = 1 Nov 7 23:49:33.353003 update_engine[805]: I1107 23:49:33.352984 805 payload_state.cc:381] Payload Attempt Number = 0 Nov 7 23:49:33.353236 update_engine[805]: I1107 23:49:33.353220 805 payload_state.cc:404] Current URL Index = 0 Nov 7 23:49:33.353410 update_engine[805]: I1107 23:49:33.353396 805 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Nov 7 23:49:33.353628 update_engine[805]: I1107 23:49:33.353596 805 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Nov 7 23:49:33.355584 systemd[1]: Started Update Engine. Nov 7 23:49:33.355737 update_engine[805]: I1107 23:49:33.355702 805 update_check_scheduler.cc:74] Next update check in 11m14s Nov 7 23:49:33.358997 systemd[1]: Finished Generate sshd host keys. Nov 7 23:49:33.374677 systemd[1]: Starting Generate /run/issue... Nov 7 23:49:33.379331 systemd[1]: issuegen.service: Deactivated successfully. Nov 7 23:49:33.379597 systemd[1]: Finished Generate /run/issue. Nov 7 23:49:33.381836 systemd[1]: Starting Permit User Sessions... Nov 7 23:49:33.386930 systemd[1]: Finished Permit User Sessions. Nov 7 23:49:33.389358 systemd[1]: Started Getty on tty1. Nov 7 23:49:33.391640 systemd[1]: Started Serial Getty on ttyAMA0. Nov 7 23:49:33.392623 systemd[1]: Reached target Login Prompts. Nov 7 23:49:33.393499 systemd[1]: Reached target Multi-User System. Nov 7 23:49:33.395711 systemd[1]: Starting Record Runlevel Change in UTMP... Nov 7 23:49:33.401116 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 7 23:49:33.401374 systemd[1]: Finished Record Runlevel Change in UTMP. Nov 7 23:49:33.402476 systemd[1]: Startup finished in 712ms (kernel) + 1.161s (initrd) + 2.682s (userspace) = 4.556s. Nov 7 23:49:33.923567 systemd[1]: Created slice Slice /system/sshd. Nov 7 23:49:33.924698 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34252). Nov 7 23:49:33.972195 sshd[831]: Accepted publickey for core from 10.0.0.1 port 34252 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:33.974269 sshd[831]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:33.999003 systemd[1]: Created slice User Slice of UID 500. Nov 7 23:49:34.000117 systemd[1]: Starting User Runtime Directory /run/user/500... Nov 7 23:49:34.001925 systemd-logind[803]: New session 1 of user core. Nov 7 23:49:34.006684 systemd[1]: Finished User Runtime Directory /run/user/500. Nov 7 23:49:34.008199 systemd[1]: Starting User Manager for UID 500... Nov 7 23:49:34.010719 systemd[834]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:34.064675 systemd[834]: Queued start job for default target Main User Target. Nov 7 23:49:34.064880 systemd[834]: Reached target Paths. Nov 7 23:49:34.064896 systemd[834]: Reached target Sockets. Nov 7 23:49:34.064907 systemd[834]: Reached target Timers. Nov 7 23:49:34.064918 systemd[834]: Reached target Basic System. Nov 7 23:49:34.064967 systemd[834]: Reached target Main User Target. Nov 7 23:49:34.064979 systemd[834]: Startup finished in 49ms. Nov 7 23:49:34.065212 systemd[1]: Started User Manager for UID 500. Nov 7 23:49:34.073701 systemd[1]: Started Session 1 of User core. Nov 7 23:49:34.136398 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34254). Nov 7 23:49:34.180267 sshd[843]: Accepted publickey for core from 10.0.0.1 port 34254 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:34.181364 sshd[843]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:34.184372 systemd-logind[803]: New session 2 of user core. Nov 7 23:49:34.195691 systemd[1]: Started Session 2 of User core. Nov 7 23:49:34.251852 sshd[843]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:34.264272 systemd[1]: sshd@1-10.0.0.4:22-10.0.0.1:34254.service: Deactivated successfully. Nov 7 23:49:34.264907 systemd[1]: session-2.scope: Deactivated successfully. Nov 7 23:49:34.265592 systemd-logind[803]: Session 2 logged out. Waiting for processes to exit. Nov 7 23:49:34.266714 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34262). Nov 7 23:49:34.267442 systemd-logind[803]: Removed session 2. Nov 7 23:49:34.310539 sshd[849]: Accepted publickey for core from 10.0.0.1 port 34262 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:34.311931 sshd[849]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:34.314772 systemd-logind[803]: New session 3 of user core. Nov 7 23:49:34.317734 systemd-networkd[714]: eth0: Gained IPv6LL Nov 7 23:49:34.323706 systemd[1]: Started Session 3 of User core. Nov 7 23:49:34.375080 sshd[849]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:34.384379 systemd[1]: sshd@2-10.0.0.4:22-10.0.0.1:34262.service: Deactivated successfully. Nov 7 23:49:34.385037 systemd[1]: session-3.scope: Deactivated successfully. Nov 7 23:49:34.385742 systemd-logind[803]: Session 3 logged out. Waiting for processes to exit. Nov 7 23:49:34.386923 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34270). Nov 7 23:49:34.387746 systemd-logind[803]: Removed session 3. Nov 7 23:49:34.432761 sshd[856]: Accepted publickey for core from 10.0.0.1 port 34270 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:34.433122 sshd[856]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:34.435901 systemd-logind[803]: New session 4 of user core. Nov 7 23:49:34.441736 systemd[1]: Started Session 4 of User core. Nov 7 23:49:34.496648 sshd[856]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:34.504324 systemd[1]: sshd@3-10.0.0.4:22-10.0.0.1:34270.service: Deactivated successfully. Nov 7 23:49:34.505160 systemd[1]: session-4.scope: Deactivated successfully. Nov 7 23:49:34.505866 systemd-logind[803]: Session 4 logged out. Waiting for processes to exit. Nov 7 23:49:34.506984 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34272). Nov 7 23:49:34.507617 systemd-logind[803]: Removed session 4. Nov 7 23:49:34.550545 sshd[862]: Accepted publickey for core from 10.0.0.1 port 34272 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:34.551992 sshd[862]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:34.554924 systemd-logind[803]: New session 5 of user core. Nov 7 23:49:34.565715 systemd[1]: Started Session 5 of User core. Nov 7 23:49:34.626175 sudo[865]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Nov 7 23:49:34.626403 sudo[865]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 7 23:49:34.641120 sudo[865]: pam_unix(sudo:session): session closed for user root Nov 7 23:49:34.644049 sshd[862]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:34.658650 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34278). Nov 7 23:49:34.661150 dbus-daemon[789]: [system] Reloaded configuration Nov 7 23:49:34.664680 systemd[1]: sshd@4-10.0.0.4:22-10.0.0.1:34272.service: Deactivated successfully. Nov 7 23:49:34.665523 systemd[1]: session-5.scope: Deactivated successfully. Nov 7 23:49:34.666228 systemd-logind[803]: Session 5 logged out. Waiting for processes to exit. Nov 7 23:49:34.666978 systemd-logind[803]: Removed session 5. Nov 7 23:49:34.705311 sshd[868]: Accepted publickey for core from 10.0.0.1 port 34278 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:34.705598 sshd[868]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:34.708728 systemd-logind[803]: New session 6 of user core. Nov 7 23:49:34.726386 systemd[1]: Started Session 6 of User core. Nov 7 23:49:34.780038 sudo[873]: 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 7 23:49:34.780261 sudo[873]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 7 23:49:34.783181 sudo[873]: pam_unix(sudo:session): session closed for user root Nov 7 23:49:34.787414 sudo[872]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Nov 7 23:49:34.787689 sudo[872]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 7 23:49:34.804578 systemd[1]: Stopping Load Security Auditing Rules... Nov 7 23:49:34.805000 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 7 23:49:34.806625 kernel: kauditd_printk_skb: 37 callbacks suppressed Nov 7 23:49:34.806652 kernel: audit: type=1305 audit(1762559374.805:48): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 7 23:49:34.806669 auditctl[876]: No rules Nov 7 23:49:34.806958 systemd[1]: audit-rules.service: Deactivated successfully. Nov 7 23:49:34.807222 systemd[1]: Stopped Load Security Auditing Rules. Nov 7 23:49:34.808991 systemd[1]: Starting Load Security Auditing Rules... Nov 7 23:49:34.825976 augenrules[893]: No rules Nov 7 23:49:34.826799 systemd[1]: Finished Load Security Auditing Rules. Nov 7 23:49:34.827794 sudo[872]: pam_unix(sudo:session): session closed for user root Nov 7 23:49:34.829201 sshd[868]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:34.837425 systemd[1]: sshd@5-10.0.0.4:22-10.0.0.1:34278.service: Deactivated successfully. Nov 7 23:49:34.838298 systemd[1]: session-6.scope: Deactivated successfully. Nov 7 23:49:34.839007 systemd-logind[803]: Session 6 logged out. Waiting for processes to exit. Nov 7 23:49:34.840157 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34288). Nov 7 23:49:34.840888 systemd-logind[803]: Removed session 6. Nov 7 23:49:34.884638 sshd[899]: Accepted publickey for core from 10.0.0.1 port 34288 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:34.885900 sshd[899]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:34.888510 kernel: audit: type=1006 audit(1762559374.885:49): pid=899 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 7 23:49:34.889114 systemd-logind[803]: New session 7 of user core. Nov 7 23:49:34.899678 systemd[1]: Started Session 7 of User core. Nov 7 23:49:34.950033 sshd[899]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:34.959969 systemd[1]: sshd@6-10.0.0.4:22-10.0.0.1:34288.service: Deactivated successfully. Nov 7 23:49:34.961019 systemd[1]: session-7.scope: Deactivated successfully. Nov 7 23:49:34.961904 systemd-logind[803]: Session 7 logged out. Waiting for processes to exit. Nov 7 23:49:34.963844 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34290). Nov 7 23:49:34.964822 systemd-logind[803]: Removed session 7. Nov 7 23:49:35.007808 sshd[905]: Accepted publickey for core from 10.0.0.1 port 34290 ssh2: RSA SHA256:3YTsyOqxThb5oMmYyOb/NHfJ2vG++00V4lPG9qria58 Nov 7 23:49:35.009048 sshd[905]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 7 23:49:35.011510 kernel: audit: type=1006 audit(1762559375.008:50): pid=905 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 7 23:49:35.012447 systemd-logind[803]: New session 8 of user core. Nov 7 23:49:35.023724 systemd[1]: Started Session 8 of User core. Nov 7 23:49:35.075876 sshd[905]: pam_unix(sshd:session): session closed for user core Nov 7 23:49:35.078309 systemd[1]: sshd@7-10.0.0.4:22-10.0.0.1:34290.service: Deactivated successfully. Nov 7 23:49:35.079005 systemd[1]: session-8.scope: Deactivated successfully. Nov 7 23:49:35.079575 systemd-logind[803]: Session 8 logged out. Waiting for processes to exit. Nov 7 23:49:35.080259 systemd-logind[803]: Removed session 8.