Nov 4 12:29:03.673926 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 4 12:29:03.673943 kernel: Linux version 5.10.107-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo 9.3.0-r1 p3) 9.3.0, GNU ld (Gentoo 2.36.1 p5) 2.36.1) #1 SMP PREEMPT Tue Mar 22 19:39:09 -00 2022 Nov 4 12:29:03.673951 kernel: efi: EFI v2.70 by EDK II Nov 4 12:29:03.673956 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Nov 4 12:29:03.673961 kernel: efi: seeding entropy pool Nov 4 12:29:03.673966 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Nov 4 12:29:03.673972 kernel: ACPI: Early table checksum verification disabled Nov 4 12:29:03.673977 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Nov 4 12:29:03.673982 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 4 12:29:03.673987 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:03.673993 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:03.673998 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:03.674003 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:03.674008 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:03.674014 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:03.674019 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:03.674025 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:03.674031 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:03.674036 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 4 12:29:03.674041 kernel: ACPI: NUMA: Failed to initialise from firmware Nov 4 12:29:03.674047 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:29:03.674052 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Nov 4 12:29:03.674057 kernel: Zone ranges: Nov 4 12:29:03.674062 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:29:03.674067 kernel: DMA32 empty Nov 4 12:29:03.674072 kernel: Normal empty Nov 4 12:29:03.674078 kernel: Movable zone start for each node Nov 4 12:29:03.674084 kernel: Early memory node ranges Nov 4 12:29:03.674089 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Nov 4 12:29:03.674094 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Nov 4 12:29:03.674099 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Nov 4 12:29:03.674105 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Nov 4 12:29:03.674110 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Nov 4 12:29:03.674115 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Nov 4 12:29:03.674120 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Nov 4 12:29:03.674125 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 4 12:29:03.674131 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 4 12:29:03.674136 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 4 12:29:03.674141 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 4 12:29:03.674146 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:29:03.674155 kernel: On node 0 totalpages: 643072 Nov 4 12:29:03.674160 kernel: DMA zone: 10048 pages used for memmap Nov 4 12:29:03.674166 kernel: DMA zone: 0 pages reserved Nov 4 12:29:03.674171 kernel: DMA zone: 643072 pages, LIFO batch:63 Nov 4 12:29:03.674176 kernel: psci: probing for conduit method from ACPI. Nov 4 12:29:03.674182 kernel: psci: PSCIv1.1 detected in firmware. Nov 4 12:29:03.674187 kernel: psci: Using standard PSCI v0.2 function IDs Nov 4 12:29:03.674193 kernel: psci: Trusted OS migration not required Nov 4 12:29:03.674199 kernel: psci: SMC Calling Convention v1.1 Nov 4 12:29:03.674205 kernel: ACPI: SRAT not present Nov 4 12:29:03.674210 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Nov 4 12:29:03.674216 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Nov 4 12:29:03.674221 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 4 12:29:03.674227 kernel: Detected PIPT I-cache on CPU0 Nov 4 12:29:03.674232 kernel: CPU features: detected: GIC system register CPU interface Nov 4 12:29:03.674244 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 4 12:29:03.674250 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 4 12:29:03.674256 kernel: CPU features: detected: Hardware dirty bit management Nov 4 12:29:03.674261 kernel: CPU features: detected: Spectre-v4 Nov 4 12:29:03.674268 kernel: CPU features: detected: ARM erratum 1418040 Nov 4 12:29:03.674273 kernel: CPU features: detected: Spectre-BHB Nov 4 12:29:03.674279 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 4 12:29:03.674284 kernel: Policy zone: DMA Nov 4 12:29:03.674291 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Nov 4 12:29:03.674297 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 4 12:29:03.674302 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 4 12:29:03.674308 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 4 12:29:03.674314 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Nov 4 12:29:03.674320 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Nov 4 12:29:03.674325 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 4 12:29:03.674332 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 4 12:29:03.674338 kernel: rcu: RCU event tracing is enabled. Nov 4 12:29:03.674344 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 4 12:29:03.674349 kernel: Trampoline variant of Tasks RCU enabled. Nov 4 12:29:03.674355 kernel: Tracing variant of Tasks RCU enabled. Nov 4 12:29:03.674360 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 4 12:29:03.674366 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 4 12:29:03.674372 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 4 12:29:03.674377 kernel: GICv3: 256 SPIs implemented Nov 4 12:29:03.674383 kernel: GICv3: 0 Extended SPIs implemented Nov 4 12:29:03.674388 kernel: GICv3: Distributor has no Range Selector support Nov 4 12:29:03.674393 kernel: GICv3: 16 PPIs implemented Nov 4 12:29:03.674400 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 4 12:29:03.674405 kernel: ACPI: SRAT not present Nov 4 12:29:03.674411 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 4 12:29:03.674416 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Nov 4 12:29:03.674422 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Nov 4 12:29:03.674428 kernel: GICv3: using LPI property table @0x00000000400d0000 Nov 4 12:29:03.674433 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Nov 4 12:29:03.674438 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:29:03.674444 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 4 12:29:03.674450 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 4 12:29:03.674455 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 4 12:29:03.674461 kernel: arm-pv: using stolen time PV Nov 4 12:29:03.674468 kernel: Console: colour dummy device 80x25 Nov 4 12:29:03.674479 kernel: ACPI: Core revision 20200925 Nov 4 12:29:03.674486 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 4 12:29:03.674492 kernel: pid_max: default: 32768 minimum: 301 Nov 4 12:29:03.674498 kernel: LSM: Security Framework initializing Nov 4 12:29:03.674504 kernel: SELinux: Initializing. Nov 4 12:29:03.674510 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:29:03.674516 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:29:03.674521 kernel: rcu: Hierarchical SRCU implementation. Nov 4 12:29:03.674528 kernel: Platform MSI: ITS@0x8080000 domain created Nov 4 12:29:03.674534 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 4 12:29:03.674540 kernel: Remapping and enabling EFI services. Nov 4 12:29:03.674545 kernel: smp: Bringing up secondary CPUs ... Nov 4 12:29:03.674551 kernel: Detected PIPT I-cache on CPU1 Nov 4 12:29:03.674557 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 4 12:29:03.674563 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Nov 4 12:29:03.674568 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:29:03.674574 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 4 12:29:03.674580 kernel: Detected PIPT I-cache on CPU2 Nov 4 12:29:03.674587 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 4 12:29:03.674593 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Nov 4 12:29:03.674598 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:29:03.674604 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 4 12:29:03.674610 kernel: Detected PIPT I-cache on CPU3 Nov 4 12:29:03.674620 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 4 12:29:03.674626 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Nov 4 12:29:03.674633 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:29:03.674639 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 4 12:29:03.674645 kernel: smp: Brought up 1 node, 4 CPUs Nov 4 12:29:03.674651 kernel: SMP: Total of 4 processors activated. Nov 4 12:29:03.674657 kernel: CPU features: detected: Privileged Access Never Nov 4 12:29:03.674663 kernel: CPU features: detected: LSE atomic instructions Nov 4 12:29:03.674668 kernel: CPU features: detected: User Access Override Nov 4 12:29:03.674674 kernel: CPU features: detected: 32-bit EL0 Support Nov 4 12:29:03.674680 kernel: CPU features: detected: Common not Private translations Nov 4 12:29:03.674687 kernel: CPU features: detected: RAS Extension Support Nov 4 12:29:03.674695 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 4 12:29:03.674701 kernel: CPU features: detected: CRC32 instructions Nov 4 12:29:03.674707 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 4 12:29:03.674713 kernel: CPU: All CPU(s) started at EL1 Nov 4 12:29:03.674719 kernel: alternatives: patching kernel code Nov 4 12:29:03.674726 kernel: devtmpfs: initialized Nov 4 12:29:03.674732 kernel: KASLR enabled Nov 4 12:29:03.674738 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 4 12:29:03.674744 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 4 12:29:03.674750 kernel: pinctrl core: initialized pinctrl subsystem Nov 4 12:29:03.674756 kernel: SMBIOS 3.0.0 present. Nov 4 12:29:03.674762 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Nov 4 12:29:03.674768 kernel: NET: Registered protocol family 16 Nov 4 12:29:03.674774 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 4 12:29:03.674780 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 4 12:29:03.674787 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 4 12:29:03.674793 kernel: audit: initializing netlink subsys (disabled) Nov 4 12:29:03.674799 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Nov 4 12:29:03.674805 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 4 12:29:03.674811 kernel: cpuidle: using governor menu Nov 4 12:29:03.674818 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 4 12:29:03.674824 kernel: ASID allocator initialised with 32768 entries Nov 4 12:29:03.674830 kernel: ACPI: bus type PCI registered Nov 4 12:29:03.674835 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 4 12:29:03.674843 kernel: Serial: AMBA PL011 UART driver Nov 4 12:29:03.674849 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 4 12:29:03.674855 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 4 12:29:03.674861 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 4 12:29:03.674867 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 4 12:29:03.674873 kernel: cryptd: max_cpu_qlen set to 1000 Nov 4 12:29:03.674879 kernel: ACPI: Added _OSI(Module Device) Nov 4 12:29:03.674885 kernel: ACPI: Added _OSI(Processor Device) Nov 4 12:29:03.674891 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 4 12:29:03.674898 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 4 12:29:03.674904 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 4 12:29:03.674910 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 4 12:29:03.674916 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 4 12:29:03.674922 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 4 12:29:03.674928 kernel: ACPI: Interpreter enabled Nov 4 12:29:03.674934 kernel: ACPI: Using GIC for interrupt routing Nov 4 12:29:03.674940 kernel: ACPI: MCFG table detected, 1 entries Nov 4 12:29:03.674946 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 4 12:29:03.674952 kernel: printk: console [ttyAMA0] enabled Nov 4 12:29:03.674959 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 4 12:29:03.675080 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 4 12:29:03.675139 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 4 12:29:03.675191 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 4 12:29:03.675252 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 4 12:29:03.675307 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 4 12:29:03.675315 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 4 12:29:03.675324 kernel: PCI host bridge to bus 0000:00 Nov 4 12:29:03.675384 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 4 12:29:03.675434 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 4 12:29:03.675507 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 4 12:29:03.675559 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 4 12:29:03.675624 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 4 12:29:03.675692 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 4 12:29:03.675757 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 4 12:29:03.675814 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 4 12:29:03.675869 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:29:03.675924 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:29:03.675981 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 4 12:29:03.676037 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 4 12:29:03.676087 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 4 12:29:03.676138 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 4 12:29:03.676187 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 4 12:29:03.676195 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Nov 4 12:29:03.676201 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Nov 4 12:29:03.676207 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Nov 4 12:29:03.676213 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Nov 4 12:29:03.676219 kernel: vgaarb: loaded Nov 4 12:29:03.676225 kernel: Registered efivars operations Nov 4 12:29:03.676231 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 4 12:29:03.676246 kernel: VFS: Disk quotas dquot_6.6.0 Nov 4 12:29:03.676253 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 4 12:29:03.676259 kernel: pnp: PnP ACPI init Nov 4 12:29:03.676326 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 4 12:29:03.676376 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Nov 4 12:29:03.676385 kernel: pnp: PnP ACPI: found 1 devices Nov 4 12:29:03.676391 kernel: NET: Registered protocol family 2 Nov 4 12:29:03.676397 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 4 12:29:03.676405 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 4 12:29:03.676411 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 4 12:29:03.676417 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 4 12:29:03.676424 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 4 12:29:03.676430 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:29:03.676436 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:29:03.676442 kernel: NET: Registered protocol family 1 Nov 4 12:29:03.676448 kernel: PCI: CLS 0 bytes, default 64 Nov 4 12:29:03.676454 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 4 12:29:03.676461 kernel: kvm [1]: HYP mode not available Nov 4 12:29:03.676467 kernel: Initialise system trusted keyrings Nov 4 12:29:03.676492 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 4 12:29:03.676499 kernel: Key type asymmetric registered Nov 4 12:29:03.676505 kernel: Asymmetric key parser 'x509' registered Nov 4 12:29:03.676511 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 4 12:29:03.676517 kernel: io scheduler mq-deadline registered Nov 4 12:29:03.676523 kernel: io scheduler kyber registered Nov 4 12:29:03.676529 kernel: io scheduler bfq registered Nov 4 12:29:03.676537 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 4 12:29:03.676543 kernel: ACPI: Power Button [PWRB] Nov 4 12:29:03.676549 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Nov 4 12:29:03.676605 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 4 12:29:03.676613 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 4 12:29:03.676619 kernel: msm_serial: driver initialized Nov 4 12:29:03.676625 kernel: random: fast init done Nov 4 12:29:03.676631 kernel: random: crng init done Nov 4 12:29:03.676637 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Nov 4 12:29:03.676644 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Nov 4 12:29:03.676651 kernel: thunder_xcv, ver 1.0 Nov 4 12:29:03.676657 kernel: thunder_bgx, ver 1.0 Nov 4 12:29:03.676663 kernel: nicpf, ver 1.0 Nov 4 12:29:03.676669 kernel: nicvf, ver 1.0 Nov 4 12:29:03.676730 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 4 12:29:03.676781 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-04T12:29:03 UTC (1762259343) Nov 4 12:29:03.676789 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 4 12:29:03.676795 kernel: NET: Registered protocol family 10 Nov 4 12:29:03.676802 kernel: Segment Routing with IPv6 Nov 4 12:29:03.676809 kernel: NET: Registered protocol family 17 Nov 4 12:29:03.676815 kernel: Key type dns_resolver registered Nov 4 12:29:03.676821 kernel: registered taskstats version 1 Nov 4 12:29:03.676826 kernel: Loading compiled-in X.509 certificates Nov 4 12:29:03.676833 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Nov 4 12:29:03.676839 kernel: Key type ._fscrypt registered Nov 4 12:29:03.676845 kernel: Key type .fscrypt registered Nov 4 12:29:03.676851 kernel: Key type fscrypt-provisioning registered Nov 4 12:29:03.676858 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 4 12:29:03.676864 kernel: ima: Allocated hash algorithm: sha1 Nov 4 12:29:03.676870 kernel: ima: No architecture policies found Nov 4 12:29:03.676876 kernel: Freeing unused kernel memory: 34240K Nov 4 12:29:03.676882 kernel: Run /init as init process Nov 4 12:29:03.676888 kernel: with arguments: Nov 4 12:29:03.676894 kernel: /init Nov 4 12:29:03.676900 kernel: with environment: Nov 4 12:29:03.676905 kernel: HOME=/ Nov 4 12:29:03.676911 kernel: TERM=linux Nov 4 12:29:03.676918 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 4 12:29:03.676926 systemd[1]: systemd 249 running in system mode (+PAM -AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Nov 4 12:29:03.676934 systemd[1]: Detected virtualization kvm. Nov 4 12:29:03.676941 systemd[1]: Detected architecture arm64. Nov 4 12:29:03.676948 systemd[1]: Running in initial RAM disk. Nov 4 12:29:03.676954 systemd[1]: No hostname configured, using default hostname. Nov 4 12:29:03.676960 systemd[1]: Hostname set to . Nov 4 12:29:03.676968 systemd[1]: Initializing machine ID from VM UUID. Nov 4 12:29:03.676975 systemd[1]: Queued start job for default target Initrd Default Target. Nov 4 12:29:03.676982 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:29:03.676988 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:29:03.676994 systemd[1]: Reached target Path Units. Nov 4 12:29:03.677001 systemd[1]: Reached target Slice Units. Nov 4 12:29:03.677007 systemd[1]: Reached target Swaps. Nov 4 12:29:03.677014 systemd[1]: Reached target Timer Units. Nov 4 12:29:03.677021 systemd[1]: Listening on Open-iSCSI iscsid Socket. Nov 4 12:29:03.677028 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Nov 4 12:29:03.677034 systemd[1]: Listening on Journal Audit Socket. Nov 4 12:29:03.677041 systemd[1]: Listening on Journal Socket (/dev/log). Nov 4 12:29:03.677047 systemd[1]: Listening on Journal Socket. Nov 4 12:29:03.677054 systemd[1]: Listening on Network Service Netlink Socket. Nov 4 12:29:03.677060 systemd[1]: Listening on udev Control Socket. Nov 4 12:29:03.677066 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:29:03.677073 systemd[1]: Reached target Socket Units. Nov 4 12:29:03.677080 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:29:03.677087 systemd[1]: Finished Network Cleanup. Nov 4 12:29:03.677093 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Nov 4 12:29:03.677100 systemd[1]: Starting Journal Service... Nov 4 12:29:03.677106 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:29:03.677113 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:29:03.677119 systemd[1]: Starting Setup Virtual Console... Nov 4 12:29:03.677126 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:29:03.677132 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:29:03.677138 systemd[1]: Finished Setup Virtual Console. Nov 4 12:29:03.677146 systemd[1]: Starting dracut ask for additional cmdline parameters... Nov 4 12:29:03.677155 systemd-journald[280]: Journal started Nov 4 12:29:03.677188 systemd-journald[280]: Runtime Journal (/run/log/journal/16f6fa2dccca4829a561ef7b9ce1664c) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:29:03.680087 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:29:03.681494 systemd[1]: Started Journal Service. Nov 4 12:29:03.681839 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:29:03.693410 systemd[1]: Finished dracut ask for additional cmdline parameters. Nov 4 12:29:03.695120 systemd[1]: Starting dracut cmdline hook... Nov 4 12:29:03.703686 dracut-cmdline[297]: dracut-dracut-053 Nov 4 12:29:03.705856 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 4 12:29:03.762502 kernel: SCSI subsystem initialized Nov 4 12:29:03.766493 kernel: Loading iSCSI transport class v2.0-870. Nov 4 12:29:03.772493 kernel: iscsi: registered transport (tcp) Nov 4 12:29:03.783790 kernel: iscsi: registered transport (qla4xxx) Nov 4 12:29:03.783807 kernel: QLogic iSCSI HBA Driver Nov 4 12:29:03.793749 systemd[1]: Finished dracut cmdline hook. Nov 4 12:29:03.795266 systemd[1]: Starting dracut pre-udev hook... Nov 4 12:29:03.808806 kernel: device-mapper: uevent: version 1.0.3 Nov 4 12:29:03.808845 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Nov 4 12:29:03.844520 kernel: raid6: neonx8 gen() 13800 MB/s Nov 4 12:29:03.861500 kernel: raid6: neonx8 xor() 10765 MB/s Nov 4 12:29:03.878515 kernel: raid6: neonx4 gen() 13596 MB/s Nov 4 12:29:03.895501 kernel: raid6: neonx4 xor() 11590 MB/s Nov 4 12:29:03.912698 kernel: raid6: neonx2 gen() 13025 MB/s Nov 4 12:29:03.929509 kernel: raid6: neonx2 xor() 8225 MB/s Nov 4 12:29:03.946505 kernel: raid6: neonx1 gen() 10992 MB/s Nov 4 12:29:03.963503 kernel: raid6: neonx1 xor() 8792 MB/s Nov 4 12:29:03.980504 kernel: raid6: int64x8 gen() 6812 MB/s Nov 4 12:29:03.997504 kernel: raid6: int64x8 xor() 3796 MB/s Nov 4 12:29:04.014502 kernel: raid6: int64x4 gen() 6902 MB/s Nov 4 12:29:04.031512 kernel: raid6: int64x4 xor() 3838 MB/s Nov 4 12:29:04.048512 kernel: raid6: int64x2 gen() 6166 MB/s Nov 4 12:29:04.065502 kernel: raid6: int64x2 xor() 3314 MB/s Nov 4 12:29:04.082516 kernel: raid6: int64x1 gen() 5005 MB/s Nov 4 12:29:04.099669 kernel: raid6: int64x1 xor() 2597 MB/s Nov 4 12:29:04.099681 kernel: raid6: using algorithm neonx8 gen() 13800 MB/s Nov 4 12:29:04.099689 kernel: raid6: .... xor() 10765 MB/s, rmw enabled Nov 4 12:29:04.100857 kernel: raid6: using neon recovery algorithm Nov 4 12:29:04.110509 kernel: xor: measuring software checksum speed Nov 4 12:29:04.111501 kernel: 8regs : 17148 MB/sec Nov 4 12:29:04.112502 kernel: 32regs : 20760 MB/sec Nov 4 12:29:04.113900 kernel: arm64_neon : 28906 MB/sec Nov 4 12:29:04.113923 kernel: xor: using function: arm64_neon (28906 MB/sec) Nov 4 12:29:04.158495 kernel: Btrfs loaded, crc32c=crc32c-generic Nov 4 12:29:04.168147 systemd[1]: Finished dracut pre-udev hook. Nov 4 12:29:04.169000 audit: BPF prog-id=6 op=LOAD Nov 4 12:29:04.170081 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:29:04.173302 kernel: audit: type=1334 audit(1762259344.169:2): prog-id=6 op=LOAD Nov 4 12:29:04.173321 kernel: audit: type=1334 audit(1762259344.169:3): prog-id=7 op=LOAD Nov 4 12:29:04.173329 kernel: audit: type=1334 audit(1762259344.169:4): prog-id=8 op=LOAD Nov 4 12:29:04.169000 audit: BPF prog-id=7 op=LOAD Nov 4 12:29:04.169000 audit: BPF prog-id=8 op=LOAD Nov 4 12:29:04.183145 systemd-udevd[417]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:29:04.184852 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:29:04.186570 systemd[1]: Starting dracut pre-trigger hook... Nov 4 12:29:04.189981 kernel: audit: type=1334 audit(1762259344.187:5): prog-id=9 op=LOAD Nov 4 12:29:04.187000 audit: BPF prog-id=9 op=LOAD Nov 4 12:29:04.188932 systemd[1]: Starting Network Configuration... Nov 4 12:29:04.199696 dracut-pre-trigger[424]: rd.md=0: removing MD RAID activation Nov 4 12:29:04.205059 systemd-networkd[431]: lo: Link UP Nov 4 12:29:04.206000 audit: BPF prog-id=10 op=LOAD Nov 4 12:29:04.205065 systemd-networkd[431]: lo: Gained carrier Nov 4 12:29:04.210772 kernel: audit: type=1334 audit(1762259344.206:6): prog-id=10 op=LOAD Nov 4 12:29:04.205344 systemd-networkd[431]: Enumeration completed Nov 4 12:29:04.205425 systemd[1]: Started Network Configuration. Nov 4 12:29:04.207179 systemd[1]: Starting Network Name Resolution... Nov 4 12:29:04.228571 systemd[1]: Finished dracut pre-trigger hook. Nov 4 12:29:04.230014 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:29:04.235016 systemd-resolved[445]: Positive Trust Anchors: Nov 4 12:29:04.235037 systemd-resolved[445]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 4 12:29:04.235066 systemd-resolved[445]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Nov 4 12:29:04.235333 systemd-resolved[445]: Defaulting to hostname 'linux'. Nov 4 12:29:04.235958 systemd[1]: Started Network Name Resolution. Nov 4 12:29:04.236798 systemd[1]: Reached target Network. Nov 4 12:29:04.238641 systemd[1]: Reached target Host and Network Name Lookups. Nov 4 12:29:04.239362 systemd-udevd[417]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:29:04.247647 systemd[1]: Starting iSCSI UserSpace I/O driver... Nov 4 12:29:04.253720 systemd[1]: Started iSCSI UserSpace I/O driver. Nov 4 12:29:04.255473 systemd[1]: Starting Open-iSCSI... Nov 4 12:29:04.259014 iscsid[485]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:29:04.259014 iscsid[485]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Nov 4 12:29:04.259014 iscsid[485]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 4 12:29:04.259014 iscsid[485]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 4 12:29:04.259014 iscsid[485]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:29:04.273765 iscsid[485]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 4 12:29:04.263707 systemd[1]: Started Open-iSCSI. Nov 4 12:29:04.274498 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:29:04.276464 systemd[1]: Starting dracut initqueue hook... Nov 4 12:29:04.292190 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 4 12:29:04.292354 kernel: vda: detected capacity change from 0 to 4756340736 Nov 4 12:29:04.302498 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:29:04.305371 systemd-udevd[468]: Using default interface naming scheme 'v249'. Nov 4 12:29:04.310864 systemd-networkd[431]: eth0: Link UP Nov 4 12:29:04.322496 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (465) Nov 4 12:29:04.324468 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Nov 4 12:29:04.327172 systemd[1]: Found device /dev/disk/by-label/ROOT. Nov 4 12:29:04.329429 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Nov 4 12:29:04.330409 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Nov 4 12:29:04.334061 systemd[1]: Found device /dev/disk/by-label/OEM. Nov 4 12:29:04.334970 systemd[1]: Reached target Initrd Root Device. Nov 4 12:29:04.336981 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Nov 4 12:29:04.338155 systemd[1]: Finished dracut initqueue hook. Nov 4 12:29:04.339637 systemd[1]: Reached target Preparation for Remote File Systems. Nov 4 12:29:04.341274 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:29:04.343083 systemd[1]: Reached target Remote File Systems. Nov 4 12:29:04.345617 systemd[1]: Starting dracut pre-mount hook... Nov 4 12:29:04.351686 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:29:04.354906 systemd[1]: Finished dracut pre-mount hook. Nov 4 12:29:05.331506 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Nov 4 12:29:05.331497 systemd-networkd[431]: eth0: Gained carrier Nov 4 12:29:05.341537 systemd-networkd[431]: eth0: DHCPv4 address 10.0.0.5/16 via 10.0.0.1 Nov 4 12:29:05.354504 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:29:05.354968 disk-uuid[505]: The operation has completed successfully. Nov 4 12:29:05.385437 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 4 12:29:05.385593 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Nov 4 12:29:05.388208 systemd[1]: Starting Ignition (setup)... Nov 4 12:29:05.396490 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 4 12:29:05.396527 kernel: BTRFS info (device vda6): has skinny extents Nov 4 12:29:05.402139 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 4 12:29:05.407638 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 4 12:29:05.407746 systemd[1]: Finished Ignition (setup). Nov 4 12:29:05.409898 systemd[1]: Starting Ignition (disks)... Nov 4 12:29:05.418995 ignition[542]: Ignition v0.36.1-15-gde4e6cc9 Nov 4 12:29:05.419013 ignition[542]: Stage: disks Nov 4 12:29:05.419022 ignition[542]: reading system config file "/usr/lib/ignition/base.ign" Nov 4 12:29:05.419032 ignition[542]: no config at "/usr/lib/ignition/base.ign" Nov 4 12:29:05.419073 ignition[542]: parsed url from cmdline: "" Nov 4 12:29:05.419076 ignition[542]: no config URL provided Nov 4 12:29:05.419081 ignition[542]: reading system config file "/usr/lib/ignition/user.ign" Nov 4 12:29:05.419088 ignition[542]: no config at "/usr/lib/ignition/user.ign" Nov 4 12:29:05.419107 ignition[542]: op(1): [started] loading QEMU firmware config module Nov 4 12:29:05.419111 ignition[542]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 4 12:29:05.419943 ignition[542]: op(1): [finished] loading QEMU firmware config module Nov 4 12:29:05.433700 ignition[542]: parsing config with SHA512: 6b437659a0b95929d71684b4b0f56e9917c28236b79c3f3d6a69d43494a379e13d3d2af3e6dc8e9a7c2f7eedd3b0a9f08ed3b560420c25d09c1a71507d748bd1 Nov 4 12:29:05.435575 ignition[542]: disks: disks passed Nov 4 12:29:05.435584 ignition[542]: Ignition finished successfully Nov 4 12:29:05.436585 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 4 12:29:05.436702 systemd[1]: Finished Ignition (disks). Nov 4 12:29:05.438102 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:29:05.440542 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Nov 4 12:29:05.443008 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Nov 4 12:29:05.450179 systemd-fsck[555]: ROOT: clean, 528/553792 files, 37752/553472 blocks Nov 4 12:29:05.453552 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 4 12:29:05.515599 systemd[1]: Found device /dev/mapper/usr. Nov 4 12:29:05.517695 systemd[1]: Starting File System Check on /dev/mapper/usr... Nov 4 12:29:05.519583 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Nov 4 12:29:05.528406 systemd-fsck[568]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Nov 4 12:29:05.528406 systemd-fsck[568]: You must have r/w access to the filesystem or be root Nov 4 12:29:05.529809 systemd-fsck[565]: fsck failed with exit status 8. Nov 4 12:29:05.529813 systemd-fsck[565]: Ignoring error. Nov 4 12:29:05.530797 systemd[1]: Finished File System Check on /dev/mapper/usr. Nov 4 12:29:05.532862 systemd[1]: Mounting /sysusr/usr... Nov 4 12:29:05.571498 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Nov 4 12:29:05.571609 systemd[1]: Mounted /sysusr/usr. Nov 4 12:29:05.572326 systemd[1]: Reached target Local File Systems. Nov 4 12:29:05.573595 systemd[1]: Reached target System Initialization. Nov 4 12:29:05.576851 systemd[1]: Reached target Basic System. Nov 4 12:29:05.580089 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Nov 4 12:29:05.581970 systemd[1]: Mounting /sysroot... Nov 4 12:29:05.590808 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Nov 4 12:29:05.590846 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Nov 4 12:29:05.591412 systemd[1]: Mounted /sysroot. Nov 4 12:29:05.592220 systemd[1]: Reached target Initrd Root File System. Nov 4 12:29:05.594461 systemd[1]: Mounting /sysroot/usr... Nov 4 12:29:05.596532 systemd[1]: Mounted /sysroot/usr. Nov 4 12:29:05.597868 systemd[1]: Starting Root filesystem setup... Nov 4 12:29:05.621252 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 4 12:29:05.621376 systemd[1]: Finished Root filesystem setup. Nov 4 12:29:05.623784 systemd[1]: Starting Ignition (files)... Nov 4 12:29:05.625022 systemd[1]: Starting /sysroot/boot... Nov 4 12:29:05.627179 ignition[586]: Ignition v0.36.1-15-gde4e6cc9 Nov 4 12:29:05.627196 ignition[586]: Stage: files Nov 4 12:29:05.627206 ignition[586]: reading system config file "/usr/lib/ignition/base.ign" Nov 4 12:29:05.627216 ignition[586]: no config at "/usr/lib/ignition/base.ign" Nov 4 12:29:05.627741 ignition[586]: files: compiled without relabeling support, skipping Nov 4 12:29:05.640621 systemd[1]: Finished /sysroot/boot. Nov 4 12:29:05.645587 ignition[586]: files: createUsers: op(1): [started] creating or modifying user "core" Nov 4 12:29:05.645601 ignition[586]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Nov 4 12:29:05.647315 ignition[586]: files: createUsers: op(1): [finished] creating or modifying user "core" Nov 4 12:29:05.647326 ignition[586]: files: createUsers: op(2): [started] adding ssh keys to user "core" Nov 4 12:29:05.648556 ignition[586]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Nov 4 12:29:05.650388 systemd[1]: ignition-files.service: Deactivated successfully. Nov 4 12:29:05.648586 ignition[586]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Nov 4 12:29:05.650501 systemd[1]: Finished Ignition (files). Nov 4 12:29:05.648817 ignition[586]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Nov 4 12:29:05.652289 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Nov 4 12:29:05.648824 ignition[586]: files: op(4): [started] processing unit "coreos-metadata.service" Nov 4 12:29:05.662567 kernel: audit: type=1334 audit(1762259345.660:7): prog-id=9 op=UNLOAD Nov 4 12:29:05.660000 audit: BPF prog-id=9 op=UNLOAD Nov 4 12:29:05.652921 systemd[1]: Starting Ignition (record completion)... Nov 4 12:29:05.648910 ignition[586]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Nov 4 12:29:05.654450 systemd[1]: Starting Reload Configuration from the Real Root... Nov 4 12:29:05.649265 ignition[586]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Nov 4 12:29:05.656391 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 4 12:29:05.674394 kernel: audit: type=1334 audit(1762259345.667:8): prog-id=3 op=UNLOAD Nov 4 12:29:05.674413 kernel: audit: type=1334 audit(1762259345.668:9): prog-id=10 op=UNLOAD Nov 4 12:29:05.674421 kernel: audit: type=1334 audit(1762259345.669:10): prog-id=6 op=UNLOAD Nov 4 12:29:05.667000 audit: BPF prog-id=3 op=UNLOAD Nov 4 12:29:05.668000 audit: BPF prog-id=10 op=UNLOAD Nov 4 12:29:05.669000 audit: BPF prog-id=6 op=UNLOAD Nov 4 12:29:05.649270 ignition[586]: files: op(4): [finished] processing unit "coreos-metadata.service" Nov 4 12:29:05.656556 systemd[1]: Finished Ignition (record completion). Nov 4 12:29:05.649275 ignition[586]: files: files passed Nov 4 12:29:05.658860 systemd[1]: Reloading. Nov 4 12:29:05.649279 ignition[586]: Ignition finished successfully Nov 4 12:29:05.750000 audit: BPF prog-id=11 op=LOAD Nov 4 12:29:05.750000 audit: BPF prog-id=12 op=LOAD Nov 4 12:29:05.750000 audit: BPF prog-id=13 op=LOAD Nov 4 12:29:05.750000 audit: BPF prog-id=14 op=LOAD Nov 4 12:29:05.750000 audit: BPF prog-id=4 op=UNLOAD Nov 4 12:29:05.750000 audit: BPF prog-id=5 op=UNLOAD Nov 4 12:29:05.750000 audit: BPF prog-id=15 op=LOAD Nov 4 12:29:05.751000 audit: BPF prog-id=16 op=LOAD Nov 4 12:29:05.751000 audit: BPF prog-id=17 op=LOAD Nov 4 12:29:05.751000 audit: BPF prog-id=18 op=LOAD Nov 4 12:29:05.751000 audit: BPF prog-id=7 op=UNLOAD Nov 4 12:29:05.751000 audit: BPF prog-id=8 op=UNLOAD Nov 4 12:29:05.768783 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 4 12:29:05.768913 systemd[1]: Finished Reload Configuration from the Real Root. Nov 4 12:29:05.770858 systemd[1]: Reached target Initrd File Systems. Nov 4 12:29:05.772332 systemd[1]: Reached target Initrd Default Target. Nov 4 12:29:05.773903 systemd[1]: Condition check resulted in dracut mount hook being skipped. Nov 4 12:29:05.774602 systemd[1]: Starting dracut pre-pivot and cleanup hook... Nov 4 12:29:05.784652 systemd[1]: Finished dracut pre-pivot and cleanup hook. Nov 4 12:29:05.786293 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Nov 4 12:29:05.792240 systemd[1]: Stopped target Host and Network Name Lookups. Nov 4 12:29:05.793302 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 4 12:29:05.795042 systemd[1]: Stopped target Timer Units. Nov 4 12:29:05.796531 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 4 12:29:05.796640 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Nov 4 12:29:05.798103 systemd[1]: Stopped target Initrd Default Target. Nov 4 12:29:05.799696 systemd[1]: Stopped target Basic System. Nov 4 12:29:05.801144 systemd[1]: Stopped target Initrd Root Device. Nov 4 12:29:05.802618 systemd[1]: Stopped target Path Units. Nov 4 12:29:05.803870 systemd[1]: Stopped target Remote File Systems. Nov 4 12:29:05.805355 systemd[1]: Stopped target Preparation for Remote File Systems. Nov 4 12:29:05.806911 systemd[1]: Stopped target Slice Units. Nov 4 12:29:05.808293 systemd[1]: Stopped target Socket Units. Nov 4 12:29:05.809858 systemd[1]: Stopped target System Initialization. Nov 4 12:29:05.811255 systemd[1]: Stopped target Local File Systems. Nov 4 12:29:05.812591 systemd[1]: Stopped target Preparation for Local File Systems. Nov 4 12:29:05.814302 systemd[1]: Stopped target Swaps. Nov 4 12:29:05.815577 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 4 12:29:05.815681 systemd[1]: Stopped dracut pre-mount hook. Nov 4 12:29:05.817268 systemd[1]: Stopped target Local Encrypted Volumes. Nov 4 12:29:05.818528 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 4 12:29:05.823524 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 4 12:29:05.824688 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 4 12:29:05.824797 systemd[1]: Stopped dracut initqueue hook. Nov 4 12:29:05.827988 iscsid[485]: iscsid shutting down. Nov 4 12:29:05.827608 systemd[1]: Stopping Open-iSCSI... Nov 4 12:29:05.829268 systemd[1]: Stopping /sysroot/boot... Nov 4 12:29:05.830364 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 4 12:29:05.830514 systemd[1]: Stopped Coldplug All udev Devices. Nov 4 12:29:05.831947 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 4 12:29:05.832036 systemd[1]: Stopped dracut pre-trigger hook. Nov 4 12:29:05.834641 systemd[1]: iscsid.service: Deactivated successfully. Nov 4 12:29:05.834773 systemd[1]: Stopped Open-iSCSI. Nov 4 12:29:05.836613 systemd[1]: iscsid.socket: Deactivated successfully. Nov 4 12:29:05.836678 systemd[1]: Closed Open-iSCSI iscsid Socket. Nov 4 12:29:05.838037 systemd[1]: Stopping iSCSI UserSpace I/O driver... Nov 4 12:29:05.841036 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 4 12:29:05.841161 systemd[1]: Stopped iSCSI UserSpace I/O driver. Nov 4 12:29:05.842372 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 4 12:29:05.842498 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Nov 4 12:29:05.844003 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 4 12:29:05.844116 systemd[1]: Stopped /sysroot/boot. Nov 4 12:29:05.845954 systemd[1]: Stopped target Network. Nov 4 12:29:05.846716 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 4 12:29:05.846787 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Nov 4 12:29:05.848315 systemd[1]: Stopping Network Name Resolution... Nov 4 12:29:05.855749 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 4 12:29:05.855875 systemd[1]: Stopped Network Name Resolution. Nov 4 12:29:05.857572 systemd[1]: Stopping Network Configuration... Nov 4 12:29:05.861000 audit: BPF prog-id=15 op=UNLOAD Nov 4 12:29:05.861666 systemd-networkd[431]: eth0: DHCP lease lost Nov 4 12:29:05.875522 systemd-networkd[431]: eth0: DHCPv6 lease lost Nov 4 12:29:05.876623 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 4 12:29:05.876750 systemd[1]: Stopped Network Configuration. Nov 4 12:29:05.878439 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 4 12:29:05.878468 systemd[1]: Closed Network Service Netlink Socket. Nov 4 12:29:05.880444 systemd[1]: Stopping Network Cleanup... Nov 4 12:29:05.885000 audit: BPF prog-id=11 op=UNLOAD Nov 4 12:29:05.881284 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 4 12:29:05.881354 systemd[1]: Stopped Apply Kernel Variables. Nov 4 12:29:05.883076 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Nov 4 12:29:05.888724 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 4 12:29:05.888838 systemd[1]: Stopped Network Cleanup. Nov 4 12:29:05.892122 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 4 12:29:05.892246 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Nov 4 12:29:05.894278 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 4 12:29:05.894316 systemd[1]: Closed udev Control Socket. Nov 4 12:29:05.895751 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 4 12:29:05.895788 systemd[1]: Closed udev Kernel Socket. Nov 4 12:29:05.900000 audit: BPF prog-id=16 op=UNLOAD Nov 4 12:29:05.897231 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 4 12:29:05.897279 systemd[1]: Stopped dracut pre-udev hook. Nov 4 12:29:05.898602 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 4 12:29:05.898644 systemd[1]: Stopped dracut cmdline hook. Nov 4 12:29:05.900341 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 4 12:29:05.900383 systemd[1]: Stopped dracut ask for additional cmdline parameters. Nov 4 12:29:05.902635 systemd[1]: Starting Cleanup udev Database... Nov 4 12:29:05.903666 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Nov 4 12:29:05.904928 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 4 12:29:05.904983 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 4 12:29:05.906637 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 4 12:29:05.906679 systemd[1]: Stopped Create List of Static Device Nodes. Nov 4 12:29:05.908165 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 4 12:29:05.908207 systemd[1]: Stopped Setup Virtual Console. Nov 4 12:29:05.909980 systemd[1]: rngd.service: Deactivated successfully. Nov 4 12:29:05.920000 audit: BPF prog-id=12 op=UNLOAD Nov 4 12:29:05.910090 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Nov 4 12:29:05.911642 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 4 12:29:05.911736 systemd[1]: Finished Cleanup udev Database. Nov 4 12:29:05.913004 systemd[1]: Reached target Switch Root. Nov 4 12:29:05.915024 systemd[1]: Starting Switch Root... Nov 4 12:29:05.920150 systemd[1]: Switching root. Nov 4 12:29:05.937797 systemd-journald[280]: Journal stopped Nov 4 12:29:08.089655 systemd-journald[280]: Received SIGTERM from PID 1 (systemd). Nov 4 12:29:08.089710 kernel: SELinux: policy capability network_peer_controls=1 Nov 4 12:29:08.089722 kernel: SELinux: policy capability open_perms=1 Nov 4 12:29:08.089732 kernel: SELinux: policy capability extended_socket_class=1 Nov 4 12:29:08.089741 kernel: SELinux: policy capability always_check_network=0 Nov 4 12:29:08.089751 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 4 12:29:08.089763 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 4 12:29:08.089773 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 4 12:29:08.089782 systemd[1]: Successfully loaded SELinux policy in 31.803ms. Nov 4 12:29:08.089798 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.495ms. Nov 4 12:29:08.089809 systemd[1]: systemd 249 running in system mode (+PAM -AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Nov 4 12:29:08.089820 systemd[1]: Detected virtualization kvm. Nov 4 12:29:08.089829 systemd[1]: Detected architecture arm64. Nov 4 12:29:08.089840 systemd[1]: Detected first boot. Nov 4 12:29:08.089850 systemd[1]: Initializing machine ID from VM UUID. Nov 4 12:29:08.089860 systemd[1]: Populated /etc with preset unit settings. Nov 4 12:29:08.089871 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Nov 4 12:29:08.089884 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 4 12:29:08.089895 kernel: kauditd_printk_skb: 24 callbacks suppressed Nov 4 12:29:08.089904 kernel: audit: type=1334 audit(1762259347.953:35): prog-id=21 op=LOAD Nov 4 12:29:08.089914 kernel: audit: type=1334 audit(1762259347.953:36): prog-id=22 op=LOAD Nov 4 12:29:08.089923 kernel: audit: type=1334 audit(1762259347.954:37): prog-id=23 op=LOAD Nov 4 12:29:08.089933 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 4 12:29:08.089943 kernel: audit: type=1334 audit(1762259347.954:38): prog-id=13 op=UNLOAD Nov 4 12:29:08.089952 systemd[1]: Stopped Switch Root. Nov 4 12:29:08.089962 kernel: audit: type=1334 audit(1762259347.954:39): prog-id=14 op=UNLOAD Nov 4 12:29:08.089973 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 4 12:29:08.089983 systemd[1]: Created slice Slice /system/addon-config. Nov 4 12:29:08.089993 systemd[1]: Created slice Slice /system/addon-run. Nov 4 12:29:08.090003 systemd[1]: Created slice Slice /system/getty. Nov 4 12:29:08.090012 kernel: audit: type=1334 audit(1762259347.968:40): prog-id=21 op=UNLOAD Nov 4 12:29:08.090022 systemd[1]: Created slice Slice /system/modprobe. Nov 4 12:29:08.090031 systemd[1]: Created slice Slice /system/serial-getty. Nov 4 12:29:08.090041 systemd[1]: Created slice Slice /system/system-cloudinit. Nov 4 12:29:08.090051 systemd[1]: Created slice Slice /system/systemd-fsck. Nov 4 12:29:08.090064 systemd[1]: Created slice User and Session Slice. Nov 4 12:29:08.090074 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:29:08.090084 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Nov 4 12:29:08.090094 systemd[1]: Set up automount Boot partition Automount Point. Nov 4 12:29:08.090103 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 4 12:29:08.090120 systemd[1]: Stopped target Switch Root. Nov 4 12:29:08.090138 systemd[1]: Stopped target Initrd File Systems. Nov 4 12:29:08.090147 systemd[1]: Stopped target Initrd Root File System. Nov 4 12:29:08.090157 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:29:08.090168 systemd[1]: Reached target Remote File Systems. Nov 4 12:29:08.090179 systemd[1]: Reached target Slice Units. Nov 4 12:29:08.090189 systemd[1]: Reached target Swaps. Nov 4 12:29:08.090199 systemd[1]: Reached target Verify torcx succeeded. Nov 4 12:29:08.090216 systemd[1]: Reached target Local Verity Protected Volumes. Nov 4 12:29:08.090229 systemd[1]: Listening on Process Core Dump Socket. Nov 4 12:29:08.090239 systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 4 12:29:08.090249 systemd[1]: Listening on Network Service Netlink Socket. Nov 4 12:29:08.090258 systemd[1]: Listening on udev Control Socket. Nov 4 12:29:08.090268 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:29:08.090278 systemd[1]: Mounting Huge Pages File System... Nov 4 12:29:08.090291 systemd[1]: Mounting POSIX Message Queue File System... Nov 4 12:29:08.090301 systemd[1]: Mounting External Media Directory... Nov 4 12:29:08.090310 systemd[1]: Mounting Kernel Debug File System... Nov 4 12:29:08.090320 systemd[1]: Mounting Kernel Trace File System... Nov 4 12:29:08.090330 systemd[1]: Mounting Temporary Directory /tmp... Nov 4 12:29:08.090339 systemd[1]: Starting Create missing system files... Nov 4 12:29:08.090349 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:29:08.090359 systemd[1]: Starting Load Kernel Module configfs... Nov 4 12:29:08.090368 systemd[1]: Starting Load Kernel Module drm... Nov 4 12:29:08.090379 systemd[1]: Starting Load Kernel Module fuse... Nov 4 12:29:08.090389 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Nov 4 12:29:08.090399 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 4 12:29:08.090408 systemd[1]: Stopped File System Check on Root Device. Nov 4 12:29:08.090418 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 4 12:29:08.090427 systemd[1]: Stopped systemd-fsck-usr.service. Nov 4 12:29:08.090437 systemd[1]: Stopped Journal Service. Nov 4 12:29:08.090446 kernel: fuse: init (API version 7.32) Nov 4 12:29:08.090455 kernel: audit: type=1334 audit(1762259348.074:41): prog-id=24 op=LOAD Nov 4 12:29:08.090464 kernel: audit: type=1334 audit(1762259348.075:42): prog-id=25 op=LOAD Nov 4 12:29:08.090480 kernel: audit: type=1334 audit(1762259348.076:43): prog-id=26 op=LOAD Nov 4 12:29:08.090492 systemd[1]: Starting Journal Service... Nov 4 12:29:08.090502 kernel: audit: type=1334 audit(1762259348.076:44): prog-id=22 op=UNLOAD Nov 4 12:29:08.090511 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:29:08.090521 systemd[1]: Starting Remount Root and Kernel File Systems... Nov 4 12:29:08.090530 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:29:08.090540 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:29:08.090549 systemd[1]: verity-setup.service: Deactivated successfully. Nov 4 12:29:08.090563 systemd-journald[801]: Journal started Nov 4 12:29:08.090597 systemd-journald[801]: Runtime Journal (/run/log/journal/16f6fa2dccca4829a561ef7b9ce1664c) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:29:06.001000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 4 12:29:06.032000 audit[1]: AVC avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Nov 4 12:29:06.032000 audit[1]: AVC avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Nov 4 12:29:06.032000 audit: BPF prog-id=19 op=LOAD Nov 4 12:29:06.032000 audit: BPF prog-id=19 op=UNLOAD Nov 4 12:29:06.032000 audit: BPF prog-id=20 op=LOAD Nov 4 12:29:06.032000 audit: BPF prog-id=20 op=UNLOAD Nov 4 12:29:06.067000 audit[751]: AVC avc: denied { associate } for pid=751 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Nov 4 12:29:07.953000 audit: BPF prog-id=21 op=LOAD Nov 4 12:29:07.953000 audit: BPF prog-id=22 op=LOAD Nov 4 12:29:07.954000 audit: BPF prog-id=23 op=LOAD Nov 4 12:29:07.954000 audit: BPF prog-id=13 op=UNLOAD Nov 4 12:29:07.954000 audit: BPF prog-id=14 op=UNLOAD Nov 4 12:29:07.968000 audit: BPF prog-id=21 op=UNLOAD Nov 4 12:29:08.074000 audit: BPF prog-id=24 op=LOAD Nov 4 12:29:08.075000 audit: BPF prog-id=25 op=LOAD Nov 4 12:29:08.076000 audit: BPF prog-id=26 op=LOAD Nov 4 12:29:08.076000 audit: BPF prog-id=22 op=UNLOAD Nov 4 12:29:08.076000 audit: BPF prog-id=23 op=UNLOAD Nov 4 12:29:08.088000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Nov 4 12:29:07.945656 systemd[1]: Queued start job for default target Multi-User System. Nov 4 12:29:06.066308 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3033.2.4 /usr/share/oem/torcx/store /var/lib/torcx/store/3033.2.4 /var/lib/torcx/store]" Nov 4 12:29:07.955919 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 4 12:29:06.066599 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:29:06.066618 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:29:06.066736 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 4 12:29:06.066748 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 4 12:29:08.091636 systemd[1]: Stopped verity-setup.service. Nov 4 12:29:06.066780 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 4 12:29:06.066793 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 4 12:29:06.067001 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 4 12:29:06.067035 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:29:06.067050 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:29:06.067426 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Nov 4 12:29:06.067459 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Nov 4 12:29:06.067496 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3033.2.4: no such file or directory" path=/usr/share/oem/torcx/store/3033.2.4 Nov 4 12:29:06.067512 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Nov 4 12:29:06.067532 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3033.2.4: no such file or directory" path=/var/lib/torcx/store/3033.2.4 Nov 4 12:29:06.067546 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:06Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 4 12:29:07.767247 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:07Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:29:07.767544 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:07Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:29:07.767648 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:07Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:29:07.767778 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:07Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:29:07.767831 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:07Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 4 12:29:07.767891 /usr/lib/systemd/system-generators/torcx-generator[751]: time="2025-11-04T12:29:07Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Nov 4 12:29:08.095494 systemd[1]: Started Journal Service. Nov 4 12:29:08.095676 systemd[1]: Mounted Huge Pages File System. Nov 4 12:29:08.096587 systemd[1]: Mounted POSIX Message Queue File System. Nov 4 12:29:08.097596 systemd[1]: Mounted External Media Directory. Nov 4 12:29:08.098512 systemd[1]: Mounted Kernel Debug File System. Nov 4 12:29:08.099546 systemd[1]: Mounted Kernel Trace File System. Nov 4 12:29:08.100490 systemd[1]: Mounted Temporary Directory /tmp. Nov 4 12:29:08.101686 systemd[1]: Finished Create missing system files. Nov 4 12:29:08.102951 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:29:08.104262 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 4 12:29:08.104446 systemd[1]: Finished Load Kernel Module configfs. Nov 4 12:29:08.117737 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 4 12:29:08.117926 systemd[1]: Finished Load Kernel Module drm. Nov 4 12:29:08.119029 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 4 12:29:08.119221 systemd[1]: Finished Load Kernel Module fuse. Nov 4 12:29:08.120437 systemd[1]: Finished Remount Root and Kernel File Systems. Nov 4 12:29:08.121830 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:29:08.124749 systemd[1]: Mounting FUSE Control File System... Nov 4 12:29:08.126574 systemd[1]: Mounting Kernel Configuration File System... Nov 4 12:29:08.127431 systemd[1]: Condition check resulted in Remount Root File System being skipped. Nov 4 12:29:08.129104 systemd[1]: Starting Rebuild Hardware Database... Nov 4 12:29:08.130947 systemd[1]: Starting Flush Journal to Persistent Storage... Nov 4 12:29:08.132046 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Nov 4 12:29:08.134685 systemd-journald[801]: Time spent on flushing to /var/log/journal/16f6fa2dccca4829a561ef7b9ce1664c is 8.920ms for 770 entries. Nov 4 12:29:08.134685 systemd-journald[801]: System Journal (/var/log/journal/16f6fa2dccca4829a561ef7b9ce1664c) is 8.0M, max 203.0M, 195.0M free. Nov 4 12:29:08.133155 systemd[1]: Starting Load/Save Random Seed... Nov 4 12:29:08.135162 systemd[1]: Starting Create System Users... Nov 4 12:29:08.139780 systemd[1]: Mounted FUSE Control File System. Nov 4 12:29:08.140694 systemd[1]: Mounted Kernel Configuration File System. Nov 4 12:29:08.144289 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:29:08.145573 systemd[1]: Finished Load/Save Random Seed. Nov 4 12:29:08.146629 systemd[1]: Reached target First Boot Complete. Nov 4 12:29:08.158301 systemd[1]: Starting Wait for udev To Complete Device Initialization... Nov 4 12:29:08.159768 systemd[1]: Finished Flush Journal to Persistent Storage. Nov 4 12:29:08.161410 systemd-sysusers[813]: Creating group sgx with gid 999. Nov 4 12:29:08.162417 systemd-sysusers[813]: Creating group systemd-oom with gid 998. Nov 4 12:29:08.162933 systemd-sysusers[813]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Nov 4 12:29:08.163551 systemd-sysusers[813]: Creating group systemd-timesync with gid 997. Nov 4 12:29:08.164010 systemd-sysusers[813]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Nov 4 12:29:08.164602 systemd-sysusers[813]: Creating group systemd-coredump with gid 996. Nov 4 12:29:08.165061 systemd-sysusers[813]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Nov 4 12:29:08.173575 systemd[1]: Finished Create System Users. Nov 4 12:29:08.175391 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:29:08.195796 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:29:08.386608 systemd[1]: Finished Rebuild Hardware Database. Nov 4 12:29:08.398000 audit: BPF prog-id=27 op=LOAD Nov 4 12:29:08.398000 audit: BPF prog-id=28 op=LOAD Nov 4 12:29:08.398000 audit: BPF prog-id=29 op=LOAD Nov 4 12:29:08.398000 audit: BPF prog-id=17 op=UNLOAD Nov 4 12:29:08.398000 audit: BPF prog-id=18 op=UNLOAD Nov 4 12:29:08.399766 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:29:08.422309 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:29:08.429000 audit: BPF prog-id=30 op=LOAD Nov 4 12:29:08.430594 systemd[1]: Starting Network Configuration... Nov 4 12:29:08.457083 systemd-networkd[839]: lo: Link UP Nov 4 12:29:08.457091 systemd-networkd[839]: lo: Gained carrier Nov 4 12:29:08.457381 systemd-networkd[839]: Enumeration completed Nov 4 12:29:08.457471 systemd[1]: Started Network Configuration. Nov 4 12:29:08.470100 systemd-udevd[822]: Using default interface naming scheme 'v249'. Nov 4 12:29:08.484888 udevadm[816]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Nov 4 12:29:08.501733 systemd-networkd[839]: eth0: Link UP Nov 4 12:29:08.512537 systemd-networkd[839]: eth0: Gained carrier Nov 4 12:29:08.513851 systemd[1]: Finished Wait for udev To Complete Device Initialization. Nov 4 12:29:08.522598 systemd-networkd[839]: eth0: DHCPv4 address 10.0.0.5/16 via 10.0.0.1 Nov 4 12:29:08.523442 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:29:08.531889 lvm[847]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:29:08.562557 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:29:08.563642 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:29:08.578512 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:29:08.581967 lvm[848]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:29:08.610562 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:29:08.611638 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:29:08.612713 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Nov 4 12:29:08.612739 systemd[1]: Reached target Containers. Nov 4 12:29:08.622736 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Nov 4 12:29:08.635516 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Nov 4 12:29:08.637816 systemd[1]: Mounting /usr/share/oem... Nov 4 12:29:08.643888 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 4 12:29:08.643943 kernel: BTRFS info (device vda6): has skinny extents Nov 4 12:29:08.646125 systemd[1]: Mounted /usr/share/oem. Nov 4 12:29:08.646977 systemd[1]: Reached target Local File Systems. Nov 4 12:29:08.648919 systemd[1]: Starting Rebuild Dynamic Linker Cache... Nov 4 12:29:08.650253 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 4 12:29:08.650323 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Nov 4 12:29:08.651445 systemd[1]: Starting Commit a transient machine-id on disk... Nov 4 12:29:08.653682 systemd[1]: Starting Create Volatile Files and Directories... Nov 4 12:29:08.660369 systemd-tmpfiles[873]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 4 12:29:08.663137 systemd-tmpfiles[873]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Nov 4 12:29:08.667787 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 4 12:29:08.668549 systemd[1]: Finished Commit a transient machine-id on disk. Nov 4 12:29:08.705224 systemd-tmpfiles[873]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:29:08.705398 systemd-tmpfiles[873]: Skipping /boot Nov 4 12:29:08.713392 systemd-tmpfiles[873]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:29:08.713607 systemd-tmpfiles[873]: Skipping /boot Nov 4 12:29:08.719200 systemd[1]: Finished Rebuild Dynamic Linker Cache. Nov 4 12:29:08.747531 systemd[1]: Finished Create Volatile Files and Directories. Nov 4 12:29:08.759440 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:29:08.761324 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Nov 4 12:29:08.763532 systemd[1]: Starting Rebuild Journal Catalog... Nov 4 12:29:08.764000 audit: BPF prog-id=31 op=LOAD Nov 4 12:29:08.765903 systemd[1]: Starting Network Name Resolution... Nov 4 12:29:08.767000 audit: BPF prog-id=32 op=LOAD Nov 4 12:29:08.769047 systemd[1]: Starting Network Time Synchronization... Nov 4 12:29:08.770951 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Nov 4 12:29:08.772589 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Nov 4 12:29:08.774116 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Nov 4 12:29:08.777944 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Nov 4 12:29:08.780709 systemd[1]: Finished Rebuild Journal Catalog. Nov 4 12:29:08.782682 systemd[1]: Starting Update is Completed... Nov 4 12:29:08.788131 systemd[1]: Finished Update is Completed. Nov 4 12:29:08.792000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Nov 4 12:29:08.792832 augenrules[895]: No rules Nov 4 12:29:08.793551 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:29:08.809992 systemd-resolved[881]: Positive Trust Anchors: Nov 4 12:29:08.810127 systemd-resolved[881]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 4 12:29:08.810156 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 4 12:29:08.810876 systemd-resolved[881]: Defaulting to hostname 'linux'. Nov 4 12:29:08.811624 systemd-timesyncd[884]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Nov 4 12:29:08.813668 systemd[1]: Started Network Time Synchronization. Nov 4 12:29:08.814705 systemd[1]: Started Network Name Resolution. Nov 4 12:29:08.815586 systemd[1]: Reached target Network. Nov 4 12:29:08.816306 systemd[1]: Reached target Host and Network Name Lookups. Nov 4 12:29:08.817335 systemd[1]: Reached target System Initialization. Nov 4 12:29:08.818343 systemd[1]: Started Watch for update engine configuration changes. Nov 4 12:29:08.819532 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 4 12:29:08.820714 systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 4 12:29:08.821735 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Nov 4 12:29:08.821766 systemd[1]: Reached target Path Units. Nov 4 12:29:08.822547 systemd[1]: Reached target System Time Set. Nov 4 12:29:08.823542 systemd[1]: Started Daily Log Rotation. Nov 4 12:29:08.824421 systemd[1]: Started Weekly check for MD array's redundancy information.. Nov 4 12:29:08.825626 systemd[1]: Reached target Timer Units. Nov 4 12:29:08.826744 systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 4 12:29:08.839173 systemd[1]: Starting Docker Socket for the API... Nov 4 12:29:08.842387 systemd[1]: Listening on OpenSSH Server Socket. Nov 4 12:29:08.843775 systemd[1]: Listening on Docker Socket for the API. Nov 4 12:29:08.844744 systemd[1]: Reached target Socket Units. Nov 4 12:29:08.845561 systemd[1]: Reached target Basic System. Nov 4 12:29:08.846385 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Nov 4 12:29:08.846418 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Nov 4 12:29:08.847372 systemd[1]: Started D-Bus System Message Bus. Nov 4 12:29:08.850770 systemd[1]: Starting Extend Filesystems... Nov 4 12:29:08.851688 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Nov 4 12:29:08.852801 systemd[1]: Starting Generate /run/flatcar/motd... Nov 4 12:29:08.854842 systemd[1]: Starting Install an ssh key from /proc/cmdline... Nov 4 12:29:08.857022 systemd[1]: Starting Generate sshd host keys... Nov 4 12:29:08.857916 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Nov 4 12:29:08.857955 systemd[1]: Reached target Load system-provided cloud configs. Nov 4 12:29:08.861660 systemd[1]: Starting User Login Management... Nov 4 12:29:08.862816 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 4 12:29:08.863770 extend-filesystems[905]: Found vda Nov 4 12:29:08.867082 extend-filesystems[905]: Found vda1 Nov 4 12:29:08.867082 extend-filesystems[905]: Found vda2 Nov 4 12:29:08.867082 extend-filesystems[905]: Found vda3 Nov 4 12:29:08.867082 extend-filesystems[905]: Found usr Nov 4 12:29:08.867082 extend-filesystems[905]: Found vda4 Nov 4 12:29:08.867082 extend-filesystems[905]: Found vda6 Nov 4 12:29:08.867082 extend-filesystems[905]: Found vda7 Nov 4 12:29:08.867082 extend-filesystems[905]: Found vda9 Nov 4 12:29:08.867082 extend-filesystems[905]: Checking size of /dev/vda9 Nov 4 12:29:08.864041 systemd[1]: Starting Update Engine... Nov 4 12:29:08.864840 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Nov 4 12:29:08.864865 systemd[1]: Reached target Load user-provided cloud configs. Nov 4 12:29:08.866563 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 4 12:29:08.866792 systemd[1]: Finished Install an ssh key from /proc/cmdline. Nov 4 12:29:08.868970 systemd[1]: motdgen.service: Deactivated successfully. Nov 4 12:29:08.869192 systemd[1]: Finished Generate /run/flatcar/motd. Nov 4 12:29:08.884908 extend-filesystems[905]: Old size kept for /dev/vda9 Nov 4 12:29:08.885154 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 4 12:29:08.885378 systemd[1]: Finished Extend Filesystems. Nov 4 12:29:08.897993 systemd-logind[917]: Watching system buttons on /dev/input/event0 (Power Button) Nov 4 12:29:08.898226 systemd-logind[917]: New seat seat0. Nov 4 12:29:08.903693 systemd[1]: Started User Login Management. Nov 4 12:29:08.906333 update_engine[919]: I1104 12:29:08.906075 919 main.cc:89] Flatcar Update Engine starting Nov 4 12:29:08.908080 systemd[1]: Started Update Engine. Nov 4 12:29:08.909617 update_engine[919]: I1104 12:29:08.909583 919 update_check_scheduler.cc:74] Next update check in 4m44s Nov 4 12:29:08.919876 systemd[1]: Started Cluster reboot manager. Nov 4 12:29:08.945236 locksmithd[928]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 4 12:29:09.181263 sshd_keygen[922]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Nov 4 12:29:09.198656 systemd[1]: Finished Generate sshd host keys. Nov 4 12:29:09.209484 systemd[1]: Starting Generate /run/issue... Nov 4 12:29:09.213462 systemd[1]: issuegen.service: Deactivated successfully. Nov 4 12:29:09.213679 systemd[1]: Finished Generate /run/issue. Nov 4 12:29:09.215597 systemd[1]: Starting Permit User Sessions... Nov 4 12:29:09.219629 systemd[1]: Finished Permit User Sessions. Nov 4 12:29:09.221565 systemd[1]: Started Getty on tty1. Nov 4 12:29:09.223210 systemd[1]: Started Serial Getty on ttyAMA0. Nov 4 12:29:09.224180 systemd[1]: Reached target Login Prompts. Nov 4 12:29:09.225086 systemd[1]: Reached target Multi-User System. Nov 4 12:29:09.226864 systemd[1]: Starting Record Runlevel Change in UTMP... Nov 4 12:29:09.231555 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 4 12:29:09.231750 systemd[1]: Finished Record Runlevel Change in UTMP. Nov 4 12:29:09.232786 systemd[1]: Startup finished in 688ms (kernel) + 2.411s (initrd) + 3.264s (userspace) = 6.365s. Nov 4 12:29:10.130697 systemd-networkd[839]: eth0: Gained IPv6LL Nov 4 12:29:15.177214 systemd[1]: Created slice Slice /system/sshd. Nov 4 12:29:15.178383 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55526). Nov 4 12:29:15.214844 sshd[950]: Accepted publickey for core from 10.0.0.1 port 55526 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:15.216743 sshd[950]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:15.229900 systemd[1]: Created slice User Slice of UID 500. Nov 4 12:29:15.230784 systemd[1]: Starting User Runtime Directory /run/user/500... Nov 4 12:29:15.232280 systemd-logind[917]: New session 1 of user core. Nov 4 12:29:15.236386 systemd[1]: Finished User Runtime Directory /run/user/500. Nov 4 12:29:15.237504 systemd[1]: Starting User Manager for UID 500... Nov 4 12:29:15.239377 systemd[953]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:15.283395 systemd[953]: Queued start job for default target Main User Target. Nov 4 12:29:15.283540 systemd[953]: Reached target Paths. Nov 4 12:29:15.283554 systemd[953]: Reached target Sockets. Nov 4 12:29:15.283565 systemd[953]: Reached target Timers. Nov 4 12:29:15.283575 systemd[953]: Reached target Basic System. Nov 4 12:29:15.283612 systemd[953]: Reached target Main User Target. Nov 4 12:29:15.283624 systemd[953]: Startup finished in 40ms. Nov 4 12:29:15.283810 systemd[1]: Started User Manager for UID 500. Nov 4 12:29:15.291826 systemd[1]: Started Session 1 of User core. Nov 4 12:29:15.351074 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55532). Nov 4 12:29:15.385770 sshd[962]: Accepted publickey for core from 10.0.0.1 port 55532 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:15.387272 sshd[962]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:15.389951 systemd-logind[917]: New session 2 of user core. Nov 4 12:29:15.410291 systemd[1]: Started Session 2 of User core. Nov 4 12:29:15.464378 sshd[962]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:15.472665 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55542). Nov 4 12:29:15.473080 systemd[1]: sshd@1-10.0.0.5:22-10.0.0.1:55532.service: Deactivated successfully. Nov 4 12:29:15.473699 systemd[1]: session-2.scope: Deactivated successfully. Nov 4 12:29:15.474244 systemd-logind[917]: Session 2 logged out. Waiting for processes to exit. Nov 4 12:29:15.474830 systemd-logind[917]: Removed session 2. Nov 4 12:29:15.510412 sshd[967]: Accepted publickey for core from 10.0.0.1 port 55542 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:15.511500 sshd[967]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:15.513971 systemd-logind[917]: New session 3 of user core. Nov 4 12:29:15.534485 systemd[1]: Started Session 3 of User core. Nov 4 12:29:15.583084 sshd[967]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:15.600122 systemd[1]: sshd@2-10.0.0.5:22-10.0.0.1:55542.service: Deactivated successfully. Nov 4 12:29:15.600691 systemd[1]: session-3.scope: Deactivated successfully. Nov 4 12:29:15.601232 systemd-logind[917]: Session 3 logged out. Waiting for processes to exit. Nov 4 12:29:15.602263 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55558). Nov 4 12:29:15.602853 systemd-logind[917]: Removed session 3. Nov 4 12:29:15.635264 sshd[975]: Accepted publickey for core from 10.0.0.1 port 55558 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:15.636225 sshd[975]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:15.638852 systemd-logind[917]: New session 4 of user core. Nov 4 12:29:15.647616 systemd[1]: Started Session 4 of User core. Nov 4 12:29:15.697258 sshd[975]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:15.710003 systemd[1]: sshd@3-10.0.0.5:22-10.0.0.1:55558.service: Deactivated successfully. Nov 4 12:29:15.710563 systemd[1]: session-4.scope: Deactivated successfully. Nov 4 12:29:15.711057 systemd-logind[917]: Session 4 logged out. Waiting for processes to exit. Nov 4 12:29:15.712034 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55560). Nov 4 12:29:15.712556 systemd-logind[917]: Removed session 4. Nov 4 12:29:15.744814 sshd[981]: Accepted publickey for core from 10.0.0.1 port 55560 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:15.745925 sshd[981]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:15.748389 systemd-logind[917]: New session 5 of user core. Nov 4 12:29:15.765613 systemd[1]: Started Session 5 of User core. Nov 4 12:29:15.817505 sudo[984]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Nov 4 12:29:15.817701 sudo[984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:29:15.829405 sudo[984]: pam_unix(sudo:session): session closed for user root Nov 4 12:29:15.831102 sshd[981]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:15.844918 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55568). Nov 4 12:29:15.847057 dbus-daemon[904]: [system] Reloaded configuration Nov 4 12:29:15.849561 systemd[1]: sshd@4-10.0.0.5:22-10.0.0.1:55560.service: Deactivated successfully. Nov 4 12:29:15.850201 systemd[1]: session-5.scope: Deactivated successfully. Nov 4 12:29:15.850884 systemd-logind[917]: Session 5 logged out. Waiting for processes to exit. Nov 4 12:29:15.851526 systemd-logind[917]: Removed session 5. Nov 4 12:29:15.877390 sshd[987]: Accepted publickey for core from 10.0.0.1 port 55568 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:15.878491 sshd[987]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:15.880677 systemd-logind[917]: New session 6 of user core. Nov 4 12:29:15.886609 systemd[1]: Started Session 6 of User core. Nov 4 12:29:15.935135 sudo[992]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Nov 4 12:29:15.935341 sudo[992]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:29:15.937508 sudo[992]: pam_unix(sudo:session): session closed for user root Nov 4 12:29:15.940879 sudo[991]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Nov 4 12:29:15.941060 sudo[991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:29:15.959264 systemd[1]: Stopping Load Security Auditing Rules... Nov 4 12:29:15.958000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 4 12:29:15.960979 kernel: kauditd_printk_skb: 11 callbacks suppressed Nov 4 12:29:15.961021 kernel: audit: type=1305 audit(1762259355.958:56): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 4 12:29:15.961065 auditctl[995]: No rules Nov 4 12:29:15.962937 systemd[1]: audit-rules.service: Deactivated successfully. Nov 4 12:29:15.963154 systemd[1]: Stopped Load Security Auditing Rules. Nov 4 12:29:15.964419 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:29:15.978442 augenrules[1012]: No rules Nov 4 12:29:15.979070 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:29:15.979840 sudo[991]: pam_unix(sudo:session): session closed for user root Nov 4 12:29:15.980967 sshd[987]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:15.982883 systemd[1]: sshd@5-10.0.0.5:22-10.0.0.1:55568.service: Deactivated successfully. Nov 4 12:29:15.983388 systemd[1]: session-6.scope: Deactivated successfully. Nov 4 12:29:15.983973 systemd-logind[917]: Session 6 logged out. Waiting for processes to exit. Nov 4 12:29:15.985012 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55576). Nov 4 12:29:15.985624 systemd-logind[917]: Removed session 6. Nov 4 12:29:16.016936 sshd[1018]: Accepted publickey for core from 10.0.0.1 port 55576 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:16.018354 sshd[1018]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:16.020493 kernel: audit: type=1006 audit(1762259356.017:57): pid=1018 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Nov 4 12:29:16.022419 systemd-logind[917]: New session 7 of user core. Nov 4 12:29:16.035608 systemd[1]: Started Session 7 of User core. Nov 4 12:29:16.083870 sudo[1021]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/bash -c cat >/etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem </etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem < Nov 4 12:29:18.710756 update_engine[1267]: Nov 4 12:29:18.710756 update_engine[1267]: Nov 4 12:29:18.710756 update_engine[1267]: Nov 4 12:29:18.710756 update_engine[1267]: Nov 4 12:29:18.710756 update_engine[1267]: Nov 4 12:29:18.710756 update_engine[1267]: Nov 4 12:29:18.710756 update_engine[1267]: Nov 4 12:29:18.710756 update_engine[1267]: Nov 4 12:29:18.710756 update_engine[1267]: I1104 12:29:18.710754 1267 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Nov 4 12:29:18.712585 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55772). Nov 4 12:29:18.712690 update_engine[1267]: I1104 12:29:18.712658 1267 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Nov 4 12:29:18.712935 update_engine[1267]: I1104 12:29:18.712913 1267 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Nov 4 12:29:18.713557 systemd-logind[917]: Session 24 logged out. Waiting for processes to exit. Nov 4 12:29:18.714040 update_engine[1267]: I1104 12:29:18.713901 1267 libcurl_http_fetcher.cc:248] HTTP response code: 200 Nov 4 12:29:18.714040 update_engine[1267]: I1104 12:29:18.713976 1267 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Nov 4 12:29:18.714040 update_engine[1267]: I1104 12:29:18.713984 1267 omaha_request_action.cc:619] Omaha request response: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.714040 update_engine[1267]: Nov 4 12:29:18.715971 update_engine[1267]: I1104 12:29:18.715942 1267 omaha_request_action.cc:447] Omaha Response manifest version = Nov 4 12:29:18.715971 update_engine[1267]: I1104 12:29:18.715971 1267 omaha_request_action.cc:470] Found 1 url(s) Nov 4 12:29:18.716042 update_engine[1267]: I1104 12:29:18.715983 1267 omaha_request_action.cc:506] Processing first of 1 package(s) Nov 4 12:29:18.716042 update_engine[1267]: I1104 12:29:18.715986 1267 omaha_request_action.cc:513] Omaha Response package name = update.gz Nov 4 12:29:18.716042 update_engine[1267]: I1104 12:29:18.715989 1267 omaha_request_action.cc:529] Url0: http://10.0.0.4:34567/packages/update.gz Nov 4 12:29:18.716042 update_engine[1267]: I1104 12:29:18.715997 1267 omaha_request_action.cc:541] Payload size = 439965385 bytes Nov 4 12:29:18.716042 update_engine[1267]: I1104 12:29:18.716007 1267 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Nov 4 12:29:18.716042 update_engine[1267]: I1104 12:29:18.716020 1267 payload_state.cc:51] Resetting all persisted state as this is a new response Nov 4 12:29:18.716042 update_engine[1267]: I1104 12:29:18.716024 1267 payload_state.cc:360] Current Response Signature = Nov 4 12:29:18.716042 update_engine[1267]: NumURLs = 1 Nov 4 12:29:18.716042 update_engine[1267]: Url0 = http://10.0.0.4:34567/packages/update.gz Nov 4 12:29:18.716042 update_engine[1267]: Payload Size = 439965385 Nov 4 12:29:18.716042 update_engine[1267]: Payload Sha256 Hash = +42QG3ah2EOUXfyDwaJG/hKpihone22jwnvEw5N2E4k= Nov 4 12:29:18.716042 update_engine[1267]: Is Delta Payload = 0 Nov 4 12:29:18.716042 update_engine[1267]: Max Failure Count Per Url = 10 Nov 4 12:29:18.716042 update_engine[1267]: Disable Payload Backoff = 1 Nov 4 12:29:18.716280 update_engine[1267]: I1104 12:29:18.716101 1267 payload_state.cc:381] Payload Attempt Number = 0 Nov 4 12:29:18.716280 update_engine[1267]: I1104 12:29:18.716132 1267 payload_state.cc:404] Current URL Index = 0 Nov 4 12:29:18.716280 update_engine[1267]: I1104 12:29:18.716158 1267 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Nov 4 12:29:18.716280 update_engine[1267]: I1104 12:29:18.716187 1267 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Nov 4 12:29:18.716280 update_engine[1267]: I1104 12:29:18.716192 1267 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Nov 4 12:29:18.716280 update_engine[1267]: I1104 12:29:18.716223 1267 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Nov 4 12:29:18.716280 update_engine[1267]: I1104 12:29:18.716238 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Nov 4 12:29:18.716280 update_engine[1267]: I1104 12:29:18.716241 1267 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Nov 4 12:29:18.716280 update_engine[1267]: I1104 12:29:18.716254 1267 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Nov 4 12:29:18.716280 update_engine[1267]: E1104 12:29:18.716259 1267 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Nov 4 12:29:18.716717 update_engine[1267]: I1104 12:29:18.716697 1267 omaha_response_handler_action.cc:85] Using this install plan: Nov 4 12:29:18.716717 update_engine[1267]: I1104 12:29:18.716710 1267 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.4:34567/packages/update.gz, payload size: 439965385, payload hash: +42QG3ah2EOUXfyDwaJG/hKpihone22jwnvEw5N2E4k=, partition_path: /dev/vda4, kernel_path: /boot/flatcar/vmlinuz-b, pcr_policy_path: /var/lib/update_engine/pcrs-b.zip, old_partition_path: /dev/vda3, old_kernel_path: /boot/flatcar/vmlinuz-a Nov 4 12:29:18.716804 update_engine[1267]: I1104 12:29:18.716789 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Nov 4 12:29:18.717413 systemd-logind[917]: Removed session 24. Nov 4 12:29:18.718125 update_engine[1267]: I1104 12:29:18.718096 1267 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Nov 4 12:29:18.755506 sshd[1288]: Accepted publickey for core from 10.0.0.1 port 55772 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:18.756169 sshd[1288]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:18.760011 systemd-logind[917]: New session 25 of user core. Nov 4 12:29:18.770675 systemd[1]: Started Session 25 of User core. Nov 4 12:29:18.825776 sshd[1288]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:18.827956 systemd[1]: sshd@24-10.0.0.5:22-10.0.0.1:55772.service: Deactivated successfully. Nov 4 12:29:18.828788 systemd[1]: session-25.scope: Deactivated successfully. Nov 4 12:29:18.829669 systemd-logind[917]: Session 25 logged out. Waiting for processes to exit. Nov 4 12:29:18.830326 systemd-logind[917]: Removed session 25. Nov 4 12:29:20.344654 update_engine[1267]: I1104 12:29:20.344606 1267 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Nov 4 12:29:20.344654 update_engine[1267]: I1104 12:29:20.344645 1267 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Nov 4 12:29:20.405224 update_engine[1267]: E1104 12:29:20.405169 1267 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Nov 4 12:29:20.405224 update_engine[1267]: I1104 12:29:20.405212 1267 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Nov 4 12:29:20.405224 update_engine[1267]: I1104 12:29:20.405217 1267 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Nov 4 12:29:20.405224 update_engine[1267]: I1104 12:29:20.405220 1267 update_attempter.cc:302] Processing Done. Nov 4 12:29:20.405537 update_engine[1267]: E1104 12:29:20.405264 1267 update_attempter.cc:615] Update failed. Nov 4 12:29:20.405537 update_engine[1267]: I1104 12:29:20.405268 1267 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Nov 4 12:29:20.405537 update_engine[1267]: I1104 12:29:20.405272 1267 payload_state.cc:276] Incrementing the URL failure count Nov 4 12:29:20.405537 update_engine[1267]: I1104 12:29:20.405275 1267 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Nov 4 12:29:20.413010 update_engine[1267]: I1104 12:29:20.412979 1267 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Nov 4 12:29:20.413065 update_engine[1267]: I1104 12:29:20.413015 1267 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.4:34567/v1/update Nov 4 12:29:20.413065 update_engine[1267]: I1104 12:29:20.413020 1267 omaha_request_action.cc:269] Request: Nov 4 12:29:20.413065 update_engine[1267]: Nov 4 12:29:20.413065 update_engine[1267]: Nov 4 12:29:20.413065 update_engine[1267]: Nov 4 12:29:20.413065 update_engine[1267]: Nov 4 12:29:20.413065 update_engine[1267]: Nov 4 12:29:20.413065 update_engine[1267]: Nov 4 12:29:20.413065 update_engine[1267]: I1104 12:29:20.413024 1267 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Nov 4 12:29:20.413232 update_engine[1267]: I1104 12:29:20.413103 1267 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Nov 4 12:29:20.413232 update_engine[1267]: I1104 12:29:20.413215 1267 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Nov 4 12:29:20.566351 update_engine[1267]: I1104 12:29:20.566283 1267 libcurl_http_fetcher.cc:248] HTTP response code: 200 Nov 4 12:29:20.566464 update_engine[1267]: I1104 12:29:20.566387 1267 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Nov 4 12:29:20.566464 update_engine[1267]: I1104 12:29:20.566395 1267 omaha_request_action.cc:619] Omaha request response: Nov 4 12:29:20.566464 update_engine[1267]: Nov 4 12:29:20.566464 update_engine[1267]: Nov 4 12:29:20.566464 update_engine[1267]: Nov 4 12:29:20.566464 update_engine[1267]: Nov 4 12:29:20.566464 update_engine[1267]: Nov 4 12:29:20.566464 update_engine[1267]: Nov 4 12:29:20.566464 update_engine[1267]: E1104 12:29:20.566409 1267 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Nov 4 12:29:20.566464 update_engine[1267]: I1104 12:29:20.566414 1267 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 4 12:29:20.566464 update_engine[1267]: I1104 12:29:20.566417 1267 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 4 12:29:20.566464 update_engine[1267]: I1104 12:29:20.566421 1267 update_attempter.cc:302] Processing Done. Nov 4 12:29:20.566464 update_engine[1267]: I1104 12:29:20.566424 1267 update_attempter.cc:306] Error event sent. Nov 4 12:29:28.761161 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45772). Nov 4 12:29:28.796032 sshd[1300]: Accepted publickey for core from 10.0.0.1 port 45772 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:28.797430 sshd[1300]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:28.798000 kernel: kauditd_printk_skb: 287 callbacks suppressed Nov 4 12:29:28.798064 kernel: audit: type=1006 audit(1762259368.795:353): pid=1300 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=26 res=1 Nov 4 12:29:28.800096 systemd-logind[917]: New session 26 of user core. Nov 4 12:29:28.809618 systemd[1]: Started Session 26 of User core. Nov 4 12:29:28.865878 sshd[1300]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:28.874505 systemd[1]: sshd@25-10.0.0.5:22-10.0.0.1:45772.service: Deactivated successfully. Nov 4 12:29:28.875170 systemd[1]: session-26.scope: Deactivated successfully. Nov 4 12:29:28.875786 systemd-logind[917]: Session 26 logged out. Waiting for processes to exit. Nov 4 12:29:28.876808 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45774). Nov 4 12:29:28.877458 systemd-logind[917]: Removed session 26. Nov 4 12:29:28.908967 sshd[1307]: Accepted publickey for core from 10.0.0.1 port 45774 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:28.910128 sshd[1307]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:28.912521 kernel: audit: type=1006 audit(1762259368.908:354): pid=1307 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=27 res=1 Nov 4 12:29:28.912688 systemd-logind[917]: New session 27 of user core. Nov 4 12:29:28.924630 systemd[1]: Started Session 27 of User core. Nov 4 12:29:28.978160 sshd[1307]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:28.990355 systemd[1]: sshd@26-10.0.0.5:22-10.0.0.1:45774.service: Deactivated successfully. Nov 4 12:29:28.990965 systemd[1]: session-27.scope: Deactivated successfully. Nov 4 12:29:28.991580 systemd-logind[917]: Session 27 logged out. Waiting for processes to exit. Nov 4 12:29:28.992602 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45788). Nov 4 12:29:28.993245 systemd-logind[917]: Removed session 27. Nov 4 12:29:29.024700 sshd[1315]: Accepted publickey for core from 10.0.0.1 port 45788 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:29.025749 sshd[1315]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:29.027499 kernel: audit: type=1006 audit(1762259369.025:355): pid=1315 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=28 res=1 Nov 4 12:29:29.028294 systemd-logind[917]: New session 28 of user core. Nov 4 12:29:29.035603 systemd[1]: Started Session 28 of User core. Nov 4 12:29:29.083031 sshd[1315]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:29.095323 systemd[1]: sshd@27-10.0.0.5:22-10.0.0.1:45788.service: Deactivated successfully. Nov 4 12:29:29.096012 systemd[1]: session-28.scope: Deactivated successfully. Nov 4 12:29:29.096610 systemd-logind[917]: Session 28 logged out. Waiting for processes to exit. Nov 4 12:29:29.098081 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45796). Nov 4 12:29:29.098809 systemd-logind[917]: Removed session 28. Nov 4 12:29:29.130256 sshd[1321]: Accepted publickey for core from 10.0.0.1 port 45796 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:29.131865 sshd[1321]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:29.133507 kernel: audit: type=1006 audit(1762259369.129:356): pid=1321 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=29 res=1 Nov 4 12:29:29.134380 systemd-logind[917]: New session 29 of user core. Nov 4 12:29:29.142670 systemd[1]: Started Session 29 of User core. Nov 4 12:29:29.190834 sshd[1321]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:29.207032 systemd[1]: sshd@28-10.0.0.5:22-10.0.0.1:45796.service: Deactivated successfully. Nov 4 12:29:29.207547 systemd[1]: session-29.scope: Deactivated successfully. Nov 4 12:29:29.208116 systemd-logind[917]: Session 29 logged out. Waiting for processes to exit. Nov 4 12:29:29.208973 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:45810). Nov 4 12:29:29.209552 systemd-logind[917]: Removed session 29. Nov 4 12:29:29.240998 sshd[1327]: Accepted publickey for core from 10.0.0.1 port 45810 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:29.242134 sshd[1327]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:29.244492 kernel: audit: type=1006 audit(1762259369.241:357): pid=1327 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=30 res=1 Nov 4 12:29:29.245949 systemd-logind[917]: New session 30 of user core. Nov 4 12:29:29.256602 systemd[1]: Started Session 30 of User core. Nov 4 12:29:29.306166 sudo[1331]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Nov 4 12:29:29.306557 sudo[1331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:29:29.312091 systemd[1]: sshd.socket: Deactivated successfully. Nov 4 12:29:29.312427 systemd[1]: Closed OpenSSH Server Socket. Nov 4 12:29:29.313284 sudo[1331]: pam_unix(sudo:session): session closed for user root Nov 4 12:29:29.316727 sudo[1330]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Nov 4 12:29:29.316917 sudo[1330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:29:29.332655 systemd[1]: Stopping Session 1 of User core... Nov 4 12:29:29.333009 sshd[950]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:29.334562 sshd[1327]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:29.334745 systemd[1]: Stopping Session 30 of User core... Nov 4 12:29:29.334978 sudo[1330]: pam_unix(sudo:session): session closed for user root Nov 4 12:29:29.336089 systemd[1]: Removed slice Slice /system/addon-config. Nov 4 12:29:29.337492 systemd[1]: Removed slice Slice /system/addon-run. Nov 4 12:29:29.338774 systemd[1]: Removed slice Slice /system/modprobe. Nov 4 12:29:29.340053 systemd[1]: Removed slice Slice /system/system-cloudinit. Nov 4 12:29:29.341252 systemd[1]: Stopped target Multi-User System. Nov 4 12:29:29.342366 systemd[1]: Stopped target Login Prompts. Nov 4 12:29:29.343279 systemd[1]: Stopped target Containers. Nov 4 12:29:29.344310 systemd[1]: Stopped target Host and Network Name Lookups. Nov 4 12:29:29.345444 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 4 12:29:29.346511 systemd[1]: Stopped target Timer Units. Nov 4 12:29:29.347355 systemd[1]: logrotate.timer: Deactivated successfully. Nov 4 12:29:29.347679 systemd[1]: Stopped Daily Log Rotation. Nov 4 12:29:29.348518 systemd[1]: mdadm.timer: Deactivated successfully. Nov 4 12:29:29.348667 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Nov 4 12:29:29.349839 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Nov 4 12:29:29.349983 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Nov 4 12:29:29.351108 systemd[1]: Stopped target System Time Set. Nov 4 12:29:29.352133 systemd[1]: Stopped target Load user-provided cloud configs. Nov 4 12:29:29.353303 systemd[1]: Stopped target Load system-provided cloud configs. Nov 4 12:29:29.354570 systemd[1]: systemd-coredump.socket: Deactivated successfully. Nov 4 12:29:29.354768 systemd[1]: Closed Process Core Dump Socket. Nov 4 12:29:29.356722 systemd[1]: Unmounting Boot partition... Nov 4 12:29:29.357797 systemd[1]: Stopping Getty on tty1... Nov 4 12:29:29.358759 systemd[1]: Stopping Serial Getty on ttyAMA0... Nov 4 12:29:29.360687 systemd[1]: Stopping OpenSSH per-connection server daemon... Nov 4 12:29:29.361712 sshd[1327]: pam_systemd(sshd:session): Failed to release session: Interrupted system call Nov 4 12:29:29.361959 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:45810)... Nov 4 12:29:29.363261 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Nov 4 12:29:29.363493 systemd[1]: Stopped Commit a transient machine-id on disk. Nov 4 12:29:29.364657 systemd[1]: Stopped target First Boot Complete. Nov 4 12:29:29.366660 systemd[1]: Stopping Load/Save Random Seed... Nov 4 12:29:29.367624 systemd[1]: Stopping Update Engine... Nov 4 12:29:29.371067 systemd[1]: getty@tty1.service: Deactivated successfully. Nov 4 12:29:29.371285 systemd[1]: Stopped Getty on tty1. Nov 4 12:29:29.372621 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Nov 4 12:29:29.372812 systemd[1]: Stopped Serial Getty on ttyAMA0. Nov 4 12:29:29.374130 systemd[1]: sshd@0-10.0.0.5:22-10.0.0.1:55526.service: Deactivated successfully. Nov 4 12:29:29.374317 systemd[1]: Stopped OpenSSH per-connection server daemon. Nov 4 12:29:29.375996 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Nov 4 12:29:29.376077 systemd[1]: update-engine.service: Failed with result 'exit-code'. Nov 4 12:29:29.376320 systemd[1]: Stopped Update Engine. Nov 4 12:29:29.377248 systemd[1]: update-engine.service: Consumed 2.232s CPU time. Nov 4 12:29:29.377468 systemd[1]: sshd@29-10.0.0.5:22-10.0.0.1:45810.service: Deactivated successfully. Nov 4 12:29:29.377666 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:45810). Nov 4 12:29:29.386217 systemd[1]: systemd-random-seed.service: Deactivated successfully. Nov 4 12:29:29.386447 systemd[1]: Stopped Load/Save Random Seed. Nov 4 12:29:29.387589 systemd[1]: session-30.scope: Deactivated successfully. Nov 4 12:29:29.387834 systemd[1]: Stopped Session 30 of User core. Nov 4 12:29:29.388930 systemd[1]: boot.mount: Deactivated successfully. Nov 4 12:29:29.389173 systemd[1]: Unmounted Boot partition. Nov 4 12:29:29.390189 systemd[1]: session-1.scope: Deactivated successfully. Nov 4 12:29:29.390418 systemd[1]: Stopped Session 1 of User core. Nov 4 12:29:29.391842 systemd-logind[917]: Session 1 logged out. Waiting for processes to exit. Nov 4 12:29:29.392754 systemd-logind[917]: Session 30 logged out. Waiting for processes to exit. Nov 4 12:29:29.392996 systemd[1]: Removed slice Slice /system/getty. Nov 4 12:29:29.394168 systemd[1]: Removed slice Slice /system/serial-getty. Nov 4 12:29:29.395561 systemd[1]: Removed slice Slice /system/sshd. Nov 4 12:29:29.396417 systemd[1]: sshd-keygen.service: Deactivated successfully. Nov 4 12:29:29.396541 systemd[1]: Stopped Generate sshd host keys. Nov 4 12:29:29.397443 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Nov 4 12:29:29.397590 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Nov 4 12:29:29.398879 systemd[1]: Stopping User Login Management... Nov 4 12:29:29.399680 systemd[1]: Stopping User Manager for UID 500... Nov 4 12:29:29.401070 systemd[953]: Stopped target Main User Target. Nov 4 12:29:29.401088 systemd[953]: Stopped target Basic System. Nov 4 12:29:29.401098 systemd[953]: Stopped target Paths. Nov 4 12:29:29.401106 systemd[953]: Stopped target Sockets. Nov 4 12:29:29.401123 systemd[953]: Reached target Shutdown. Nov 4 12:29:29.401130 systemd[953]: Stopped target Timers. Nov 4 12:29:29.401234 systemd[953]: Finished Exit the Session. Nov 4 12:29:29.401257 systemd[953]: Reached target Exit the Session. Nov 4 12:29:29.402233 systemd-logind[917]: Removed session 30. Nov 4 12:29:29.403682 systemd[1]: user@500.service: Deactivated successfully. Nov 4 12:29:29.403977 systemd[1]: Stopped User Manager for UID 500. Nov 4 12:29:29.405729 systemd[1]: Stopping User Runtime Directory /run/user/500... Nov 4 12:29:29.410897 systemd[1]: run-user-500.mount: Deactivated successfully. Nov 4 12:29:29.410971 systemd[1]: Unmounted /run/user/500. Nov 4 12:29:29.412293 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Nov 4 12:29:29.412513 systemd[1]: Stopped User Runtime Directory /run/user/500. Nov 4 12:29:29.413956 systemd[1]: Removed slice User Slice of UID 500. Nov 4 12:29:29.415640 systemd[1]: Stopping D-Bus System Message Bus... Nov 4 12:29:29.417172 systemd[1]: Stopping Permit User Sessions... Nov 4 12:29:29.418460 systemd[1]: dbus.service: Deactivated successfully. Nov 4 12:29:29.418716 systemd[1]: Stopped D-Bus System Message Bus. Nov 4 12:29:29.419743 systemd[1]: systemd-logind.service: Deactivated successfully. Nov 4 12:29:29.420013 systemd[1]: Stopped User Login Management. Nov 4 12:29:29.421492 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Nov 4 12:29:29.421694 systemd[1]: Stopped Permit User Sessions. Nov 4 12:29:29.422549 systemd[1]: Stopped target Basic System. Nov 4 12:29:29.423284 systemd[1]: Stopped target Network. Nov 4 12:29:29.424012 systemd[1]: Stopped target Path Units. Nov 4 12:29:29.424721 systemd[1]: motdgen.path: Deactivated successfully. Nov 4 12:29:29.428532 systemd[1]: Stopped Watch for update engine configuration changes. Nov 4 12:29:29.429515 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Nov 4 12:29:29.429000 audit: BPF prog-id=55 op=UNLOAD Nov 4 12:29:29.431561 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 4 12:29:29.432509 kernel: audit: type=1334 audit(1762259369.429:358): prog-id=55 op=UNLOAD Nov 4 12:29:29.432612 systemd[1]: Stopped target Remote File Systems. Nov 4 12:29:29.433382 systemd[1]: Stopped target Slice Units. Nov 4 12:29:29.434400 systemd[1]: Removed slice User and Session Slice. Nov 4 12:29:29.435272 systemd[1]: Stopped target Socket Units. Nov 4 12:29:29.436069 systemd[1]: dbus.socket: Deactivated successfully. Nov 4 12:29:29.436123 systemd[1]: Closed D-Bus System Message Bus Socket. Nov 4 12:29:29.437086 systemd[1]: docker.socket: Deactivated successfully. Nov 4 12:29:29.437311 systemd[1]: Closed Docker Socket for the API. Nov 4 12:29:29.438148 systemd[1]: Stopped target System Initialization. Nov 4 12:29:29.439013 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Nov 4 12:29:29.439142 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Nov 4 12:29:29.440241 systemd[1]: Stopped target Local Verity Protected Volumes. Nov 4 12:29:29.442065 systemd[1]: Stopping Load Security Auditing Rules... Nov 4 12:29:29.443210 systemd[1]: Stopping Network Name Resolution... Nov 4 12:29:29.444150 systemd[1]: Stopping Network Time Synchronization... Nov 4 12:29:29.444506 auditctl[1347]: No rules Nov 4 12:29:29.444940 systemd[1]: systemd-update-done.service: Deactivated successfully. Nov 4 12:29:29.445012 systemd[1]: Stopped Update is Completed. Nov 4 12:29:29.445782 systemd[1]: ldconfig.service: Deactivated successfully. Nov 4 12:29:29.445845 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Nov 4 12:29:29.446699 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Nov 4 12:29:29.446757 systemd[1]: Stopped Rebuild Hardware Database. Nov 4 12:29:29.447570 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Nov 4 12:29:29.447628 systemd[1]: Stopped Rebuild Journal Catalog. Nov 4 12:29:29.449219 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Nov 4 12:29:29.451754 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 4 12:29:29.452005 systemd[1]: Stopped Network Name Resolution. Nov 4 12:29:29.453100 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Nov 4 12:29:29.453326 systemd[1]: Stopped Network Time Synchronization. Nov 4 12:29:29.454547 systemd[1]: audit-rules.service: Deactivated successfully. Nov 4 12:29:29.454758 systemd[1]: Stopped Load Security Auditing Rules. Nov 4 12:29:29.457010 systemd[1]: Stopping Network Configuration... Nov 4 12:29:29.472558 systemd-networkd[839]: eth0: DHCPv6 lease lost Nov 4 12:29:29.471000 audit: BPF prog-id=54 op=UNLOAD Nov 4 12:29:29.472933 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Nov 4 12:29:29.473134 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Nov 4 12:29:29.471000 audit: BPF prog-id=61 op=UNLOAD Nov 4 12:29:29.474510 kernel: audit: type=1334 audit(1762259369.471:359): prog-id=54 op=UNLOAD Nov 4 12:29:29.474548 kernel: audit: type=1334 audit(1762259369.471:360): prog-id=61 op=UNLOAD Nov 4 12:29:29.475630 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 4 12:29:29.475871 systemd[1]: Stopped Network Configuration. Nov 4 12:29:29.477360 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 4 12:29:29.477443 systemd[1]: Closed Network Service Netlink Socket. Nov 4 12:29:29.478401 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 4 12:29:29.478459 systemd[1]: Stopped Apply Kernel Variables. Nov 4 12:29:29.479276 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 4 12:29:29.479334 systemd[1]: Stopped Create Volatile Files and Directories. Nov 4 12:29:29.480333 systemd[1]: Stopped target Local File Systems. Nov 4 12:29:29.482093 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Nov 4 12:29:29.483575 systemd[1]: Unmounting External Media Directory... Nov 4 12:29:29.485168 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Nov 4 12:29:29.485000 audit: BPF prog-id=53 op=UNLOAD Nov 4 12:29:29.487494 kernel: audit: type=1334 audit(1762259369.485:361): prog-id=53 op=UNLOAD Nov 4 12:29:29.487961 systemd[1]: Unmounting /run/torcx/unpack... Nov 4 12:29:29.489187 systemd[1]: Unmounting Temporary Directory /tmp... Nov 4 12:29:29.490513 systemd[1]: Unmounting /usr/share/oem... Nov 4 12:29:29.492071 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Nov 4 12:29:29.494839 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Nov 4 12:29:29.495062 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Nov 4 12:29:29.496322 systemd[1]: media.mount: Deactivated successfully. Nov 4 12:29:29.496590 systemd[1]: Unmounted External Media Directory. Nov 4 12:29:29.497514 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Nov 4 12:29:29.497749 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Nov 4 12:29:29.498969 systemd[1]: tmp.mount: Deactivated successfully. Nov 4 12:29:29.499210 systemd[1]: Unmounted Temporary Directory /tmp. Nov 4 12:29:29.500296 systemd[1]: usr-share-oem.mount: Deactivated successfully. Nov 4 12:29:29.500560 systemd[1]: Unmounted /usr/share/oem. Nov 4 12:29:29.501401 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Nov 4 12:29:29.501648 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Nov 4 12:29:29.503142 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Nov 4 12:29:29.503220 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Nov 4 12:29:29.504567 systemd[1]: Removed slice Slice /system/systemd-fsck. Nov 4 12:29:29.508807 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Nov 4 12:29:29.509028 systemd[1]: Unmounted /run/torcx/unpack. Nov 4 12:29:29.509995 systemd[1]: Stopped target Preparation for Local File Systems. Nov 4 12:29:29.511029 systemd[1]: Stopped target Swaps. Nov 4 12:29:29.511734 systemd[1]: Reached target Unmount All Filesystems. Nov 4 12:29:29.512776 systemd[1]: lvm2-activation.service: Deactivated successfully. Nov 4 12:29:29.512852 systemd[1]: Stopped Activation of LVM2 logical volumes. Nov 4 12:29:29.513785 systemd[1]: Stopped target Local Encrypted Volumes. Nov 4 12:29:29.514639 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 4 12:29:29.514700 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 4 12:29:29.515758 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Nov 4 12:29:29.517517 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Nov 4 12:29:29.518581 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Nov 4 12:29:29.518667 systemd[1]: Stopped Activation of LVM2 logical volumes. Nov 4 12:29:29.519633 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 4 12:29:29.519694 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 4 12:29:29.521342 systemd[1]: systemd-sysusers.service: Deactivated successfully. Nov 4 12:29:29.521402 systemd[1]: Stopped Create System Users. Nov 4 12:29:29.522389 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Nov 4 12:29:29.522445 systemd[1]: Stopped Remount Root and Kernel File Systems. Nov 4 12:29:29.523454 systemd[1]: Reached target System Shutdown. Nov 4 12:29:29.524225 systemd[1]: Reached target Late Shutdown Services. Nov 4 12:29:29.525266 systemd[1]: systemd-reboot.service: Deactivated successfully. Nov 4 12:29:29.525304 systemd[1]: Finished System Reboot. Nov 4 12:29:29.526052 systemd[1]: Reached target System Reboot. Nov 4 12:29:29.526833 systemd[1]: Shutting down. Nov 4 12:29:29.528000 audit: BPF prog-id=52 op=UNLOAD Nov 4 12:29:29.528000 audit: BPF prog-id=51 op=UNLOAD Nov 4 12:29:29.528000 audit: BPF prog-id=50 op=UNLOAD Nov 4 12:29:29.529000 audit: BPF prog-id=57 op=UNLOAD Nov 4 12:29:29.529000 audit: BPF prog-id=56 op=UNLOAD Nov 4 12:29:29.531490 kernel: audit: type=1334 audit(1762259369.528:362): prog-id=52 op=UNLOAD Nov 4 12:29:29.530000 audit: BPF prog-id=60 op=UNLOAD Nov 4 12:29:29.530000 audit: BPF prog-id=59 op=UNLOAD Nov 4 12:29:29.530000 audit: BPF prog-id=58 op=UNLOAD Nov 4 12:29:29.566496 systemd-shutdown[1]: Syncing filesystems and block devices. Nov 4 12:29:29.572567 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Nov 4 12:29:29.572623 systemd-journald[801]: Journal stopped -- Reboot -- Nov 4 12:29:36.669487 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 4 12:29:36.669503 kernel: Linux version 5.10.107-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo 9.3.0-r1 p3) 9.3.0, GNU ld (Gentoo 2.36.1 p5) 2.36.1) #1 SMP PREEMPT Tue Mar 22 19:39:09 -00 2022 Nov 4 12:29:36.669512 kernel: efi: EFI v2.70 by EDK II Nov 4 12:29:36.669517 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Nov 4 12:29:36.669522 kernel: efi: seeding entropy pool Nov 4 12:29:36.669527 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Nov 4 12:29:36.669533 kernel: ACPI: Early table checksum verification disabled Nov 4 12:29:36.669538 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Nov 4 12:29:36.669543 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 4 12:29:36.669548 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:36.669555 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:36.669560 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:36.669565 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:36.669570 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:36.669576 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:36.669581 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:36.669588 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:36.669594 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:29:36.669599 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 4 12:29:36.669604 kernel: ACPI: NUMA: Failed to initialise from firmware Nov 4 12:29:36.669610 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:29:36.669615 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Nov 4 12:29:36.669620 kernel: Zone ranges: Nov 4 12:29:36.669625 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:29:36.669631 kernel: DMA32 empty Nov 4 12:29:36.669651 kernel: Normal empty Nov 4 12:29:36.669657 kernel: Movable zone start for each node Nov 4 12:29:36.669663 kernel: Early memory node ranges Nov 4 12:29:36.669669 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Nov 4 12:29:36.669674 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Nov 4 12:29:36.669679 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Nov 4 12:29:36.669685 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Nov 4 12:29:36.669690 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Nov 4 12:29:36.669695 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Nov 4 12:29:36.669700 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Nov 4 12:29:36.669706 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 4 12:29:36.669711 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 4 12:29:36.669716 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 4 12:29:36.669721 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 4 12:29:36.669727 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:29:36.669735 kernel: On node 0 totalpages: 643072 Nov 4 12:29:36.669741 kernel: DMA zone: 10048 pages used for memmap Nov 4 12:29:36.669746 kernel: DMA zone: 0 pages reserved Nov 4 12:29:36.669752 kernel: DMA zone: 643072 pages, LIFO batch:63 Nov 4 12:29:36.669757 kernel: psci: probing for conduit method from ACPI. Nov 4 12:29:36.669763 kernel: psci: PSCIv1.1 detected in firmware. Nov 4 12:29:36.669768 kernel: psci: Using standard PSCI v0.2 function IDs Nov 4 12:29:36.669774 kernel: psci: Trusted OS migration not required Nov 4 12:29:36.669780 kernel: psci: SMC Calling Convention v1.1 Nov 4 12:29:36.669786 kernel: ACPI: SRAT not present Nov 4 12:29:36.669792 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Nov 4 12:29:36.669798 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Nov 4 12:29:36.669803 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 4 12:29:36.669809 kernel: Detected PIPT I-cache on CPU0 Nov 4 12:29:36.669814 kernel: CPU features: detected: GIC system register CPU interface Nov 4 12:29:36.669820 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 4 12:29:36.669825 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 4 12:29:36.669831 kernel: CPU features: detected: Hardware dirty bit management Nov 4 12:29:36.669837 kernel: CPU features: detected: Spectre-v4 Nov 4 12:29:36.669843 kernel: CPU features: detected: ARM erratum 1418040 Nov 4 12:29:36.669849 kernel: CPU features: detected: Spectre-BHB Nov 4 12:29:36.669854 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 4 12:29:36.669860 kernel: Policy zone: DMA Nov 4 12:29:36.669866 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Nov 4 12:29:36.669872 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 4 12:29:36.669878 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 4 12:29:36.669883 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 4 12:29:36.669889 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Nov 4 12:29:36.669895 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Nov 4 12:29:36.669901 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 4 12:29:36.669912 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 4 12:29:36.669919 kernel: rcu: RCU event tracing is enabled. Nov 4 12:29:36.669924 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 4 12:29:36.669930 kernel: Trampoline variant of Tasks RCU enabled. Nov 4 12:29:36.669936 kernel: Tracing variant of Tasks RCU enabled. Nov 4 12:29:36.669941 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 4 12:29:36.669947 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 4 12:29:36.669953 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 4 12:29:36.669958 kernel: GICv3: 256 SPIs implemented Nov 4 12:29:36.669964 kernel: GICv3: 0 Extended SPIs implemented Nov 4 12:29:36.669969 kernel: GICv3: Distributor has no Range Selector support Nov 4 12:29:36.669975 kernel: GICv3: 16 PPIs implemented Nov 4 12:29:36.669982 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 4 12:29:36.669987 kernel: ACPI: SRAT not present Nov 4 12:29:36.669992 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 4 12:29:36.669998 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Nov 4 12:29:36.670004 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Nov 4 12:29:36.670010 kernel: GICv3: using LPI property table @0x00000000400d0000 Nov 4 12:29:36.670015 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Nov 4 12:29:36.670021 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:29:36.670026 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 4 12:29:36.670032 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 4 12:29:36.670038 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 4 12:29:36.670044 kernel: arm-pv: using stolen time PV Nov 4 12:29:36.670051 kernel: Console: colour dummy device 80x25 Nov 4 12:29:36.670057 kernel: ACPI: Core revision 20200925 Nov 4 12:29:36.670063 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 4 12:29:36.670069 kernel: pid_max: default: 32768 minimum: 301 Nov 4 12:29:36.670074 kernel: LSM: Security Framework initializing Nov 4 12:29:36.670080 kernel: SELinux: Initializing. Nov 4 12:29:36.670086 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:29:36.670092 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:29:36.670097 kernel: rcu: Hierarchical SRCU implementation. Nov 4 12:29:36.670104 kernel: Platform MSI: ITS@0x8080000 domain created Nov 4 12:29:36.670110 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 4 12:29:36.670116 kernel: Remapping and enabling EFI services. Nov 4 12:29:36.670122 kernel: smp: Bringing up secondary CPUs ... Nov 4 12:29:36.670127 kernel: Detected PIPT I-cache on CPU1 Nov 4 12:29:36.670133 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 4 12:29:36.670139 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Nov 4 12:29:36.670145 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:29:36.670150 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 4 12:29:36.670156 kernel: Detected PIPT I-cache on CPU2 Nov 4 12:29:36.670163 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 4 12:29:36.670169 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Nov 4 12:29:36.670175 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:29:36.670181 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 4 12:29:36.670187 kernel: Detected PIPT I-cache on CPU3 Nov 4 12:29:36.670196 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 4 12:29:36.670202 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Nov 4 12:29:36.670210 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:29:36.670215 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 4 12:29:36.670222 kernel: smp: Brought up 1 node, 4 CPUs Nov 4 12:29:36.670227 kernel: SMP: Total of 4 processors activated. Nov 4 12:29:36.670234 kernel: CPU features: detected: Privileged Access Never Nov 4 12:29:36.670240 kernel: CPU features: detected: LSE atomic instructions Nov 4 12:29:36.670250 kernel: CPU features: detected: User Access Override Nov 4 12:29:36.670256 kernel: CPU features: detected: 32-bit EL0 Support Nov 4 12:29:36.670262 kernel: CPU features: detected: Common not Private translations Nov 4 12:29:36.670269 kernel: CPU features: detected: RAS Extension Support Nov 4 12:29:36.670276 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 4 12:29:36.670283 kernel: CPU features: detected: CRC32 instructions Nov 4 12:29:36.670289 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 4 12:29:36.670295 kernel: CPU: All CPU(s) started at EL1 Nov 4 12:29:36.670301 kernel: alternatives: patching kernel code Nov 4 12:29:36.670308 kernel: devtmpfs: initialized Nov 4 12:29:36.670314 kernel: KASLR enabled Nov 4 12:29:36.670320 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 4 12:29:36.670326 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 4 12:29:36.670333 kernel: pinctrl core: initialized pinctrl subsystem Nov 4 12:29:36.670339 kernel: SMBIOS 3.0.0 present. Nov 4 12:29:36.670345 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Nov 4 12:29:36.670351 kernel: NET: Registered protocol family 16 Nov 4 12:29:36.670358 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 4 12:29:36.670364 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 4 12:29:36.670372 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 4 12:29:36.670378 kernel: audit: initializing netlink subsys (disabled) Nov 4 12:29:36.670384 kernel: audit: type=2000 audit(0.031:1): state=initialized audit_enabled=0 res=1 Nov 4 12:29:36.670391 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 4 12:29:36.670397 kernel: cpuidle: using governor menu Nov 4 12:29:36.670403 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 4 12:29:36.670411 kernel: ASID allocator initialised with 32768 entries Nov 4 12:29:36.670417 kernel: ACPI: bus type PCI registered Nov 4 12:29:36.670423 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 4 12:29:36.670431 kernel: Serial: AMBA PL011 UART driver Nov 4 12:29:36.670437 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 4 12:29:36.670443 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 4 12:29:36.670450 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 4 12:29:36.670459 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 4 12:29:36.670466 kernel: cryptd: max_cpu_qlen set to 1000 Nov 4 12:29:36.670473 kernel: ACPI: Added _OSI(Module Device) Nov 4 12:29:36.670480 kernel: ACPI: Added _OSI(Processor Device) Nov 4 12:29:36.670486 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 4 12:29:36.670494 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 4 12:29:36.670500 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 4 12:29:36.670506 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 4 12:29:36.670512 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 4 12:29:36.670519 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 4 12:29:36.670524 kernel: ACPI: Interpreter enabled Nov 4 12:29:36.670531 kernel: ACPI: Using GIC for interrupt routing Nov 4 12:29:36.670537 kernel: ACPI: MCFG table detected, 1 entries Nov 4 12:29:36.670543 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 4 12:29:36.670549 kernel: printk: console [ttyAMA0] enabled Nov 4 12:29:36.670557 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 4 12:29:36.670681 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 4 12:29:36.670740 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 4 12:29:36.670792 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 4 12:29:36.670844 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 4 12:29:36.670897 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 4 12:29:36.670905 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 4 12:29:36.670913 kernel: PCI host bridge to bus 0000:00 Nov 4 12:29:36.670972 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 4 12:29:36.671021 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 4 12:29:36.671068 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 4 12:29:36.671115 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 4 12:29:36.671180 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 4 12:29:36.671243 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 4 12:29:36.671309 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 4 12:29:36.671364 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 4 12:29:36.671418 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:29:36.671471 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:29:36.671524 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 4 12:29:36.671577 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 4 12:29:36.671626 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 4 12:29:36.671687 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 4 12:29:36.671735 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 4 12:29:36.671743 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Nov 4 12:29:36.671749 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Nov 4 12:29:36.671756 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Nov 4 12:29:36.671762 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Nov 4 12:29:36.671768 kernel: vgaarb: loaded Nov 4 12:29:36.671774 kernel: Registered efivars operations Nov 4 12:29:36.671780 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 4 12:29:36.671788 kernel: VFS: Disk quotas dquot_6.6.0 Nov 4 12:29:36.671794 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 4 12:29:36.671800 kernel: pnp: PnP ACPI init Nov 4 12:29:36.671863 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 4 12:29:36.671912 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Nov 4 12:29:36.671920 kernel: pnp: PnP ACPI: found 1 devices Nov 4 12:29:36.671926 kernel: NET: Registered protocol family 2 Nov 4 12:29:36.671932 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 4 12:29:36.671940 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 4 12:29:36.671947 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 4 12:29:36.671953 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 4 12:29:36.671959 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 4 12:29:36.671966 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:29:36.671972 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:29:36.671978 kernel: NET: Registered protocol family 1 Nov 4 12:29:36.671984 kernel: PCI: CLS 0 bytes, default 64 Nov 4 12:29:36.671990 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 4 12:29:36.671998 kernel: kvm [1]: HYP mode not available Nov 4 12:29:36.672004 kernel: Initialise system trusted keyrings Nov 4 12:29:36.672010 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 4 12:29:36.672016 kernel: Key type asymmetric registered Nov 4 12:29:36.672022 kernel: Asymmetric key parser 'x509' registered Nov 4 12:29:36.672028 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 4 12:29:36.672034 kernel: io scheduler mq-deadline registered Nov 4 12:29:36.672040 kernel: io scheduler kyber registered Nov 4 12:29:36.672046 kernel: io scheduler bfq registered Nov 4 12:29:36.672054 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 4 12:29:36.672060 kernel: ACPI: Power Button [PWRB] Nov 4 12:29:36.672066 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Nov 4 12:29:36.672123 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 4 12:29:36.672132 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 4 12:29:36.672141 kernel: msm_serial: driver initialized Nov 4 12:29:36.672148 kernel: random: fast init done Nov 4 12:29:36.672154 kernel: random: crng init done Nov 4 12:29:36.672161 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Nov 4 12:29:36.672167 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Nov 4 12:29:36.672175 kernel: thunder_xcv, ver 1.0 Nov 4 12:29:36.672182 kernel: thunder_bgx, ver 1.0 Nov 4 12:29:36.672188 kernel: nicpf, ver 1.0 Nov 4 12:29:36.672198 kernel: nicvf, ver 1.0 Nov 4 12:29:36.672279 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 4 12:29:36.672331 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-04T12:29:36 UTC (1762259376) Nov 4 12:29:36.672339 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 4 12:29:36.672345 kernel: NET: Registered protocol family 10 Nov 4 12:29:36.672353 kernel: Segment Routing with IPv6 Nov 4 12:29:36.672359 kernel: NET: Registered protocol family 17 Nov 4 12:29:36.672365 kernel: Key type dns_resolver registered Nov 4 12:29:36.672371 kernel: registered taskstats version 1 Nov 4 12:29:36.672377 kernel: Loading compiled-in X.509 certificates Nov 4 12:29:36.672383 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Nov 4 12:29:36.672389 kernel: Key type ._fscrypt registered Nov 4 12:29:36.672395 kernel: Key type .fscrypt registered Nov 4 12:29:36.672401 kernel: Key type fscrypt-provisioning registered Nov 4 12:29:36.672409 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 4 12:29:36.672415 kernel: ima: Allocated hash algorithm: sha1 Nov 4 12:29:36.672421 kernel: ima: No architecture policies found Nov 4 12:29:36.672427 kernel: Freeing unused kernel memory: 34240K Nov 4 12:29:36.672433 kernel: Run /init as init process Nov 4 12:29:36.672439 kernel: with arguments: Nov 4 12:29:36.672445 kernel: /init Nov 4 12:29:36.672451 kernel: with environment: Nov 4 12:29:36.672457 kernel: HOME=/ Nov 4 12:29:36.672463 kernel: TERM=linux Nov 4 12:29:36.672470 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 4 12:29:36.672478 systemd[1]: systemd 249 running in system mode (+PAM -AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Nov 4 12:29:36.672487 systemd[1]: Detected virtualization kvm. Nov 4 12:29:36.672493 systemd[1]: Detected architecture arm64. Nov 4 12:29:36.672500 systemd[1]: Running in initial RAM disk. Nov 4 12:29:36.672506 systemd[1]: No hostname configured, using default hostname. Nov 4 12:29:36.672512 systemd[1]: Hostname set to . Nov 4 12:29:36.672520 systemd[1]: Initializing machine ID from VM UUID. Nov 4 12:29:36.672527 systemd[1]: Queued start job for default target Initrd Default Target. Nov 4 12:29:36.672533 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:29:36.672540 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:29:36.672546 systemd[1]: Reached target Path Units. Nov 4 12:29:36.672552 systemd[1]: Reached target Slice Units. Nov 4 12:29:36.672559 systemd[1]: Reached target Swaps. Nov 4 12:29:36.672565 systemd[1]: Reached target Timer Units. Nov 4 12:29:36.672573 systemd[1]: Listening on Open-iSCSI iscsid Socket. Nov 4 12:29:36.672580 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Nov 4 12:29:36.672586 systemd[1]: Listening on Journal Audit Socket. Nov 4 12:29:36.672593 systemd[1]: Listening on Journal Socket (/dev/log). Nov 4 12:29:36.672600 systemd[1]: Listening on Journal Socket. Nov 4 12:29:36.672606 systemd[1]: Listening on udev Control Socket. Nov 4 12:29:36.672612 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:29:36.672619 systemd[1]: Reached target Socket Units. Nov 4 12:29:36.672625 systemd[1]: Starting iSCSI UserSpace I/O driver... Nov 4 12:29:36.672643 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:29:36.672650 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Nov 4 12:29:36.672657 systemd[1]: Starting Journal Service... Nov 4 12:29:36.672663 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:29:36.672670 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:29:36.672676 systemd[1]: Starting Setup Virtual Console... Nov 4 12:29:36.672683 systemd[1]: Started iSCSI UserSpace I/O driver. Nov 4 12:29:36.672689 kernel: SCSI subsystem initialized Nov 4 12:29:36.672695 kernel: Loading iSCSI transport class v2.0-870. Nov 4 12:29:36.672701 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:29:36.672711 systemd-journald[269]: Journal started Nov 4 12:29:36.672747 systemd-journald[269]: Runtime Journal (/run/log/journal/16f6fa2dccca4829a561ef7b9ce1664c) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:29:36.674657 systemd[1]: Started Journal Service. Nov 4 12:29:36.674745 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:29:36.675695 systemd[1]: Finished Setup Virtual Console. Nov 4 12:29:36.677592 systemd[1]: Starting dracut ask for additional cmdline parameters... Nov 4 12:29:36.679138 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:29:36.682169 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:29:36.689008 systemd[1]: Finished dracut ask for additional cmdline parameters. Nov 4 12:29:36.690604 systemd[1]: Starting dracut cmdline hook... Nov 4 12:29:36.698933 dracut-cmdline[290]: dracut-dracut-053 Nov 4 12:29:36.701090 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 4 12:29:36.752664 kernel: iscsi: registered transport (tcp) Nov 4 12:29:36.763681 kernel: iscsi: registered transport (qla4xxx) Nov 4 12:29:36.763704 kernel: QLogic iSCSI HBA Driver Nov 4 12:29:36.772667 systemd[1]: Finished dracut cmdline hook. Nov 4 12:29:36.774012 systemd[1]: Starting dracut pre-udev hook... Nov 4 12:29:36.775196 systemd[1]: Starting Open-iSCSI... Nov 4 12:29:36.777305 iscsid[376]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:29:36.777305 iscsid[376]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Nov 4 12:29:36.777305 iscsid[376]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 4 12:29:36.777305 iscsid[376]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 4 12:29:36.777305 iscsid[376]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:29:36.777305 iscsid[376]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 4 12:29:36.790855 kernel: device-mapper: uevent: version 1.0.3 Nov 4 12:29:36.790871 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Nov 4 12:29:36.781718 systemd[1]: Started Open-iSCSI. Nov 4 12:29:36.823669 kernel: raid6: neonx8 gen() 13759 MB/s Nov 4 12:29:36.840663 kernel: raid6: neonx8 xor() 10733 MB/s Nov 4 12:29:36.857662 kernel: raid6: neonx4 gen() 13614 MB/s Nov 4 12:29:36.874663 kernel: raid6: neonx4 xor() 11569 MB/s Nov 4 12:29:36.891661 kernel: raid6: neonx2 gen() 12999 MB/s Nov 4 12:29:36.908662 kernel: raid6: neonx2 xor() 9875 MB/s Nov 4 12:29:36.925662 kernel: raid6: neonx1 gen() 10905 MB/s Nov 4 12:29:36.943652 kernel: raid6: neonx1 xor() 8805 MB/s Nov 4 12:29:36.959659 kernel: raid6: int64x8 gen() 6751 MB/s Nov 4 12:29:36.976656 kernel: raid6: int64x8 xor() 3785 MB/s Nov 4 12:29:36.993657 kernel: raid6: int64x4 gen() 6889 MB/s Nov 4 12:29:37.010657 kernel: raid6: int64x4 xor() 3823 MB/s Nov 4 12:29:37.027656 kernel: raid6: int64x2 gen() 6174 MB/s Nov 4 12:29:37.044655 kernel: raid6: int64x2 xor() 3304 MB/s Nov 4 12:29:37.061656 kernel: raid6: int64x1 gen() 4999 MB/s Nov 4 12:29:37.078770 kernel: raid6: int64x1 xor() 2588 MB/s Nov 4 12:29:37.078783 kernel: raid6: using algorithm neonx8 gen() 13759 MB/s Nov 4 12:29:37.078791 kernel: raid6: .... xor() 10733 MB/s, rmw enabled Nov 4 12:29:37.079909 kernel: raid6: using neon recovery algorithm Nov 4 12:29:37.089652 kernel: xor: measuring software checksum speed Nov 4 12:29:37.090656 kernel: 8regs : 17170 MB/sec Nov 4 12:29:37.092139 kernel: 32regs : 20776 MB/sec Nov 4 12:29:37.092160 kernel: arm64_neon : 29173 MB/sec Nov 4 12:29:37.092174 kernel: xor: using function: arm64_neon (29173 MB/sec) Nov 4 12:29:37.137654 kernel: Btrfs loaded, crc32c=crc32c-generic Nov 4 12:29:37.146893 systemd[1]: Finished dracut pre-udev hook. Nov 4 12:29:37.147000 audit: BPF prog-id=6 op=LOAD Nov 4 12:29:37.147000 audit: BPF prog-id=7 op=LOAD Nov 4 12:29:37.147000 audit: BPF prog-id=8 op=LOAD Nov 4 12:29:37.148757 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:29:37.151791 kernel: audit: type=1334 audit(1762259377.147:2): prog-id=6 op=LOAD Nov 4 12:29:37.151807 kernel: audit: type=1334 audit(1762259377.147:3): prog-id=7 op=LOAD Nov 4 12:29:37.151816 kernel: audit: type=1334 audit(1762259377.147:4): prog-id=8 op=LOAD Nov 4 12:29:37.161902 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:29:37.163585 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:29:37.165204 systemd[1]: Starting dracut pre-trigger hook... Nov 4 12:29:37.176807 dracut-pre-trigger[415]: rd.md=0: removing MD RAID activation Nov 4 12:29:37.197985 systemd[1]: Finished dracut pre-trigger hook. Nov 4 12:29:37.199319 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:29:37.208423 systemd-udevd[408]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:29:37.232348 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:29:37.233794 systemd[1]: Starting dracut initqueue hook... Nov 4 12:29:37.244147 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 4 12:29:37.244293 kernel: vda: detected capacity change from 0 to 4756340736 Nov 4 12:29:37.260559 systemd-udevd[457]: Using default interface naming scheme 'v249'. Nov 4 12:29:37.262646 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:29:37.281646 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (465) Nov 4 12:29:37.282355 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Nov 4 12:29:37.283553 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Nov 4 12:29:37.287281 systemd[1]: Found device /dev/disk/by-label/ROOT. Nov 4 12:29:37.294808 systemd[1]: Reached target Initrd Root Device. Nov 4 12:29:37.296159 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Nov 4 12:29:37.297340 systemd[1]: Finished dracut initqueue hook. Nov 4 12:29:37.298830 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 4 12:29:37.298927 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Nov 4 12:29:37.300331 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:29:37.301850 systemd[1]: Reached target Preparation for Remote File Systems. Nov 4 12:29:37.303581 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:29:37.305221 systemd[1]: Reached target Remote File Systems. Nov 4 12:29:37.307317 systemd[1]: Starting dracut pre-mount hook... Nov 4 12:29:37.308603 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Nov 4 12:29:37.315980 systemd[1]: Finished dracut pre-mount hook. Nov 4 12:29:37.317286 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Nov 4 12:29:37.323683 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 4 12:29:37.326380 systemd-fsck[504]: ROOT: clean, 640/553792 files, 39961/553472 blocks Nov 4 12:29:37.328825 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Nov 4 12:29:37.330902 systemd[1]: Mounting /sysroot... Nov 4 12:29:37.348625 systemd[1]: Found device /dev/mapper/usr. Nov 4 12:29:37.350731 systemd[1]: Starting File System Check on /dev/mapper/usr... Nov 4 12:29:37.351771 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Nov 4 12:29:37.359419 systemd-fsck[517]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Nov 4 12:29:37.359419 systemd-fsck[517]: You must have r/w access to the filesystem or be root Nov 4 12:29:37.360278 systemd-fsck[514]: fsck failed with exit status 8. Nov 4 12:29:37.360282 systemd-fsck[514]: Ignoring error. Nov 4 12:29:37.361019 systemd[1]: Finished File System Check on /dev/mapper/usr. Nov 4 12:29:37.362697 systemd[1]: Mounting /sysusr/usr... Nov 4 12:29:37.373650 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Nov 4 12:29:37.373682 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Nov 4 12:29:37.373746 systemd[1]: Mounted /sysusr/usr. Nov 4 12:29:37.376798 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Nov 4 12:29:37.376745 systemd[1]: Mounted /sysroot. Nov 4 12:29:37.377518 systemd[1]: Reached target Initrd Root File System. Nov 4 12:29:37.378567 systemd[1]: Reached target Local File Systems. Nov 4 12:29:37.380121 systemd[1]: Reached target System Initialization. Nov 4 12:29:37.381488 systemd[1]: Reached target Basic System. Nov 4 12:29:37.384097 systemd[1]: Mounting /sysroot/usr... Nov 4 12:29:37.385174 systemd[1]: Starting Reload Configuration from the Real Root... Nov 4 12:29:37.386691 systemd[1]: Mounted /sysroot/usr. Nov 4 12:29:37.389040 systemd[1]: Reloading. Nov 4 12:29:37.390000 audit: BPF prog-id=6 op=UNLOAD Nov 4 12:29:37.391651 kernel: audit: type=1334 audit(1762259377.390:5): prog-id=6 op=UNLOAD Nov 4 12:29:37.396000 audit: BPF prog-id=3 op=UNLOAD Nov 4 12:29:37.402585 kernel: audit: type=1334 audit(1762259377.396:6): prog-id=3 op=UNLOAD Nov 4 12:29:37.467000 audit: BPF prog-id=9 op=LOAD Nov 4 12:29:37.468000 audit: BPF prog-id=10 op=LOAD Nov 4 12:29:37.469698 kernel: audit: type=1334 audit(1762259377.467:7): prog-id=9 op=LOAD Nov 4 12:29:37.469715 kernel: audit: type=1334 audit(1762259377.468:8): prog-id=10 op=LOAD Nov 4 12:29:37.469730 kernel: audit: type=1334 audit(1762259377.469:9): prog-id=11 op=LOAD Nov 4 12:29:37.469000 audit: BPF prog-id=11 op=LOAD Nov 4 12:29:37.469000 audit: BPF prog-id=7 op=UNLOAD Nov 4 12:29:37.471318 kernel: audit: type=1334 audit(1762259377.469:10): prog-id=7 op=UNLOAD Nov 4 12:29:37.469000 audit: BPF prog-id=8 op=UNLOAD Nov 4 12:29:37.469000 audit: BPF prog-id=12 op=LOAD Nov 4 12:29:37.470000 audit: BPF prog-id=13 op=LOAD Nov 4 12:29:37.470000 audit: BPF prog-id=14 op=LOAD Nov 4 12:29:37.470000 audit: BPF prog-id=4 op=UNLOAD Nov 4 12:29:37.470000 audit: BPF prog-id=5 op=UNLOAD Nov 4 12:29:37.484145 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 4 12:29:37.484257 systemd[1]: Finished Reload Configuration from the Real Root. Nov 4 12:29:37.486091 systemd[1]: Reached target Initrd File Systems. Nov 4 12:29:37.487556 systemd[1]: Reached target Initrd Default Target. Nov 4 12:29:37.489043 systemd[1]: Condition check resulted in dracut mount hook being skipped. Nov 4 12:29:37.489655 systemd[1]: Starting dracut pre-pivot and cleanup hook... Nov 4 12:29:37.499474 systemd[1]: Finished dracut pre-pivot and cleanup hook. Nov 4 12:29:37.500984 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Nov 4 12:29:37.506061 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 4 12:29:37.507020 systemd[1]: Stopped target Timer Units. Nov 4 12:29:37.508415 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 4 12:29:37.508508 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Nov 4 12:29:37.509963 systemd[1]: Stopped target Initrd Default Target. Nov 4 12:29:37.511471 systemd[1]: Stopped target Basic System. Nov 4 12:29:37.512902 systemd[1]: Stopped target Initrd Root Device. Nov 4 12:29:37.514330 systemd[1]: Stopped target Path Units. Nov 4 12:29:37.515569 systemd[1]: Stopped target Remote File Systems. Nov 4 12:29:37.517018 systemd[1]: Stopped target Preparation for Remote File Systems. Nov 4 12:29:37.518592 systemd[1]: Stopped target Slice Units. Nov 4 12:29:37.520058 systemd[1]: Stopped target Socket Units. Nov 4 12:29:37.521623 systemd[1]: Stopped target System Initialization. Nov 4 12:29:37.523019 systemd[1]: Stopped target Local File Systems. Nov 4 12:29:37.524345 systemd[1]: Stopped target Preparation for Local File Systems. Nov 4 12:29:37.525958 systemd[1]: Stopped target Swaps. Nov 4 12:29:37.527210 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 4 12:29:37.527317 systemd[1]: Stopped dracut pre-mount hook. Nov 4 12:29:37.528757 systemd[1]: Stopped target Local Encrypted Volumes. Nov 4 12:29:37.530078 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 4 12:29:37.531669 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 4 12:29:37.536553 iscsid[376]: iscsid shutting down. Nov 4 12:29:37.532750 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 4 12:29:37.532844 systemd[1]: Stopped dracut initqueue hook. Nov 4 12:29:37.534261 systemd[1]: Stopping Open-iSCSI... Nov 4 12:29:37.535536 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 4 12:29:37.535659 systemd[1]: Stopped Apply Kernel Variables. Nov 4 12:29:37.537353 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 4 12:29:37.537436 systemd[1]: Stopped Coldplug All udev Devices. Nov 4 12:29:37.538665 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 4 12:29:37.538750 systemd[1]: Stopped dracut pre-trigger hook. Nov 4 12:29:37.540343 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Nov 4 12:29:37.545342 systemd[1]: iscsid.service: Deactivated successfully. Nov 4 12:29:37.545454 systemd[1]: Stopped Open-iSCSI. Nov 4 12:29:37.546880 systemd[1]: iscsid.socket: Deactivated successfully. Nov 4 12:29:37.546926 systemd[1]: Closed Open-iSCSI iscsid Socket. Nov 4 12:29:37.548251 systemd[1]: Stopping iSCSI UserSpace I/O driver... Nov 4 12:29:37.550749 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 4 12:29:37.550869 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Nov 4 12:29:37.552780 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 4 12:29:37.552888 systemd[1]: Stopped iSCSI UserSpace I/O driver. Nov 4 12:29:37.554226 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 4 12:29:37.554334 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Nov 4 12:29:37.556524 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 4 12:29:37.556570 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Nov 4 12:29:37.557462 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 4 12:29:37.557502 systemd[1]: Closed udev Control Socket. Nov 4 12:29:37.558777 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 4 12:29:37.558810 systemd[1]: Closed udev Kernel Socket. Nov 4 12:29:37.560125 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 4 12:29:37.579000 audit: BPF prog-id=9 op=UNLOAD Nov 4 12:29:37.560166 systemd[1]: Stopped dracut pre-udev hook. Nov 4 12:29:37.561414 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 4 12:29:37.561455 systemd[1]: Stopped dracut cmdline hook. Nov 4 12:29:37.562855 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 4 12:29:37.562894 systemd[1]: Stopped dracut ask for additional cmdline parameters. Nov 4 12:29:37.584000 audit: BPF prog-id=12 op=UNLOAD Nov 4 12:29:37.565238 systemd[1]: Starting Cleanup udev Database... Nov 4 12:29:37.566392 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Nov 4 12:29:37.567922 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 4 12:29:37.567977 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 4 12:29:37.569544 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 4 12:29:37.569586 systemd[1]: Stopped Create List of Static Device Nodes. Nov 4 12:29:37.571377 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 4 12:29:37.571420 systemd[1]: Stopped Setup Virtual Console. Nov 4 12:29:37.573154 systemd[1]: rngd.service: Deactivated successfully. Nov 4 12:29:37.573269 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Nov 4 12:29:37.574720 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 4 12:29:37.574820 systemd[1]: Finished Cleanup udev Database. Nov 4 12:29:37.576100 systemd[1]: Reached target Switch Root. Nov 4 12:29:37.578138 systemd[1]: Starting Switch Root... Nov 4 12:29:37.583406 systemd[1]: Switching root. Nov 4 12:29:37.599794 systemd-journald[269]: Journal stopped Nov 4 12:29:39.662631 systemd-journald[269]: Received SIGTERM from PID 1 (n/a). Nov 4 12:29:39.662690 kernel: SELinux: policy capability network_peer_controls=1 Nov 4 12:29:39.662726 kernel: SELinux: policy capability open_perms=1 Nov 4 12:29:39.662737 kernel: SELinux: policy capability extended_socket_class=1 Nov 4 12:29:39.662747 kernel: SELinux: policy capability always_check_network=0 Nov 4 12:29:39.662759 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 4 12:29:39.662769 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 4 12:29:39.662778 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 4 12:29:39.662788 systemd[1]: Successfully loaded SELinux policy in 30.554ms. Nov 4 12:29:39.662802 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.058ms. Nov 4 12:29:39.662813 systemd[1]: systemd 249 running in system mode (+PAM -AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Nov 4 12:29:39.662825 systemd[1]: Detected virtualization kvm. Nov 4 12:29:39.662835 systemd[1]: Detected architecture arm64. Nov 4 12:29:39.662846 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Nov 4 12:29:39.662857 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 4 12:29:39.662872 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 4 12:29:39.662882 systemd[1]: Stopped Switch Root. Nov 4 12:29:39.662892 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 4 12:29:39.662902 systemd[1]: Created slice Slice /system/addon-config. Nov 4 12:29:39.662913 systemd[1]: Created slice Slice /system/addon-run. Nov 4 12:29:39.662923 systemd[1]: Created slice Slice /system/getty. Nov 4 12:29:39.662933 systemd[1]: Created slice Slice /system/modprobe. Nov 4 12:29:39.662943 systemd[1]: Created slice Slice /system/serial-getty. Nov 4 12:29:39.662953 systemd[1]: Created slice Slice /system/system-cloudinit. Nov 4 12:29:39.662962 systemd[1]: Created slice Slice /system/systemd-fsck. Nov 4 12:29:39.662972 systemd[1]: Created slice User and Session Slice. Nov 4 12:29:39.662982 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:29:39.662993 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Nov 4 12:29:39.663004 systemd[1]: Set up automount Boot partition Automount Point. Nov 4 12:29:39.663014 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 4 12:29:39.663024 systemd[1]: Stopped target Switch Root. Nov 4 12:29:39.663034 systemd[1]: Stopped target Initrd File Systems. Nov 4 12:29:39.663046 systemd[1]: Stopped target Initrd Root File System. Nov 4 12:29:39.663056 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:29:39.663066 systemd[1]: Reached target Remote File Systems. Nov 4 12:29:39.663076 systemd[1]: Reached target Slice Units. Nov 4 12:29:39.663088 systemd[1]: Reached target Swaps. Nov 4 12:29:39.663098 systemd[1]: Reached target Verify torcx succeeded. Nov 4 12:29:39.663108 systemd[1]: Reached target Local Verity Protected Volumes. Nov 4 12:29:39.663118 systemd[1]: Listening on Process Core Dump Socket. Nov 4 12:29:39.663128 systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 4 12:29:39.663138 systemd[1]: Listening on Network Service Netlink Socket. Nov 4 12:29:39.663147 systemd[1]: Listening on udev Control Socket. Nov 4 12:29:39.663157 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:29:39.663166 systemd[1]: Mounting Huge Pages File System... Nov 4 12:29:39.663176 systemd[1]: Mounting POSIX Message Queue File System... Nov 4 12:29:39.663185 systemd[1]: Mounting External Media Directory... Nov 4 12:29:39.663196 systemd[1]: Mounting Kernel Debug File System... Nov 4 12:29:39.663207 systemd[1]: Mounting Kernel Trace File System... Nov 4 12:29:39.663217 systemd[1]: Mounting Temporary Directory /tmp... Nov 4 12:29:39.663231 systemd[1]: Starting Create missing system files... Nov 4 12:29:39.663242 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:29:39.663253 systemd[1]: Starting Load Kernel Module configfs... Nov 4 12:29:39.663262 systemd[1]: Starting Load Kernel Module drm... Nov 4 12:29:39.663271 systemd[1]: Starting Load Kernel Module fuse... Nov 4 12:29:39.663282 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Nov 4 12:29:39.663293 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 4 12:29:39.663303 systemd[1]: Stopped File System Check on Root Device. Nov 4 12:29:39.663313 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 4 12:29:39.663323 systemd[1]: Stopped systemd-fsck-usr.service. Nov 4 12:29:39.663333 kernel: fuse: init (API version 7.32) Nov 4 12:29:39.663343 systemd[1]: Stopped Journal Service. Nov 4 12:29:39.663352 systemd[1]: Starting Journal Service... Nov 4 12:29:39.663362 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:29:39.663372 systemd[1]: Starting Remount Root and Kernel File Systems... Nov 4 12:29:39.663381 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:29:39.663392 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:29:39.663401 systemd[1]: verity-setup.service: Deactivated successfully. Nov 4 12:29:39.663411 systemd[1]: Stopped verity-setup.service. Nov 4 12:29:39.663421 systemd-journald[693]: Journal started Nov 4 12:29:39.663457 systemd-journald[693]: Runtime Journal (/run/log/journal/16f6fa2dccca4829a561ef7b9ce1664c) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:29:37.670000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 4 12:29:37.697000 audit[1]: AVC avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Nov 4 12:29:37.697000 audit[1]: AVC avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Nov 4 12:29:37.697000 audit: BPF prog-id=15 op=LOAD Nov 4 12:29:37.697000 audit: BPF prog-id=15 op=UNLOAD Nov 4 12:29:37.697000 audit: BPF prog-id=16 op=LOAD Nov 4 12:29:37.697000 audit: BPF prog-id=16 op=UNLOAD Nov 4 12:29:37.730000 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 4 12:29:39.536000 audit: BPF prog-id=17 op=LOAD Nov 4 12:29:39.536000 audit: BPF prog-id=18 op=LOAD Nov 4 12:29:39.536000 audit: BPF prog-id=19 op=LOAD Nov 4 12:29:39.536000 audit: BPF prog-id=13 op=UNLOAD Nov 4 12:29:39.536000 audit: BPF prog-id=14 op=UNLOAD Nov 4 12:29:39.536000 audit: BPF prog-id=20 op=LOAD Nov 4 12:29:39.536000 audit: BPF prog-id=17 op=UNLOAD Nov 4 12:29:39.536000 audit: BPF prog-id=21 op=LOAD Nov 4 12:29:39.536000 audit: BPF prog-id=22 op=LOAD Nov 4 12:29:39.536000 audit: BPF prog-id=18 op=UNLOAD Nov 4 12:29:39.536000 audit: BPF prog-id=19 op=UNLOAD Nov 4 12:29:39.537000 audit: BPF prog-id=23 op=LOAD Nov 4 12:29:39.537000 audit: BPF prog-id=20 op=UNLOAD Nov 4 12:29:39.537000 audit: BPF prog-id=24 op=LOAD Nov 4 12:29:39.537000 audit: BPF prog-id=25 op=LOAD Nov 4 12:29:39.537000 audit: BPF prog-id=21 op=UNLOAD Nov 4 12:29:39.537000 audit: BPF prog-id=22 op=UNLOAD Nov 4 12:29:39.547000 audit: BPF prog-id=23 op=UNLOAD Nov 4 12:29:39.647000 audit: BPF prog-id=26 op=LOAD Nov 4 12:29:39.647000 audit: BPF prog-id=27 op=LOAD Nov 4 12:29:39.647000 audit: BPF prog-id=28 op=LOAD Nov 4 12:29:39.647000 audit: BPF prog-id=24 op=UNLOAD Nov 4 12:29:39.647000 audit: BPF prog-id=25 op=UNLOAD Nov 4 12:29:39.660000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Nov 4 12:29:39.524357 systemd[1]: Queued start job for default target Multi-User System. Nov 4 12:29:37.729009 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3033.2.4 /usr/share/oem/torcx/store /var/lib/torcx/store/3033.2.4 /var/lib/torcx/store]" Nov 4 12:29:39.538306 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 4 12:29:37.729234 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:29:37.729260 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:29:37.729514 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 4 12:29:37.729525 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 4 12:29:37.729558 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 4 12:29:37.729570 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 4 12:29:37.729863 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 4 12:29:37.729899 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:29:37.729914 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:29:37.730391 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Nov 4 12:29:37.730421 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Nov 4 12:29:39.665041 systemd[1]: Started Journal Service. Nov 4 12:29:37.730443 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3033.2.4: no such file or directory" path=/usr/share/oem/torcx/store/3033.2.4 Nov 4 12:29:37.730459 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Nov 4 12:29:37.730550 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3033.2.4: no such file or directory" path=/var/lib/torcx/store/3033.2.4 Nov 4 12:29:37.730565 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:37Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 4 12:29:39.436564 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:39Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:29:39.436862 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:39Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:29:39.436969 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:39Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:29:39.437092 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:39Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:29:39.437190 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:39Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 4 12:29:39.437267 /usr/lib/systemd/system-generators/torcx-generator[645]: time="2025-11-04T12:29:39Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Nov 4 12:29:39.665567 systemd[1]: Mounted Huge Pages File System. Nov 4 12:29:39.666589 systemd[1]: Mounted POSIX Message Queue File System. Nov 4 12:29:39.667690 systemd[1]: Mounted External Media Directory. Nov 4 12:29:39.668583 systemd[1]: Mounted Kernel Debug File System. Nov 4 12:29:39.669598 systemd[1]: Mounted Kernel Trace File System. Nov 4 12:29:39.670570 systemd[1]: Mounted Temporary Directory /tmp. Nov 4 12:29:39.671796 systemd[1]: Finished Create missing system files. Nov 4 12:29:39.672994 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:29:39.674136 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 4 12:29:39.674360 systemd[1]: Finished Load Kernel Module configfs. Nov 4 12:29:39.675486 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 4 12:29:39.675703 systemd[1]: Finished Load Kernel Module drm. Nov 4 12:29:39.676736 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 4 12:29:39.676908 systemd[1]: Finished Load Kernel Module fuse. Nov 4 12:29:39.677993 systemd[1]: Finished Remount Root and Kernel File Systems. Nov 4 12:29:39.679268 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:29:39.691738 systemd[1]: Mounting FUSE Control File System... Nov 4 12:29:39.693484 systemd[1]: Mounting Kernel Configuration File System... Nov 4 12:29:39.694391 systemd[1]: Condition check resulted in Remount Root File System being skipped. Nov 4 12:29:39.695336 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Nov 4 12:29:39.696273 systemd[1]: Starting Flush Journal to Persistent Storage... Nov 4 12:29:39.697404 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Nov 4 12:29:39.698477 systemd[1]: Starting Load/Save Random Seed... Nov 4 12:29:39.699381 systemd[1]: Condition check resulted in Create System Users being skipped. Nov 4 12:29:39.701630 systemd-journald[693]: Time spent on flushing to /var/log/journal/16f6fa2dccca4829a561ef7b9ce1664c is 12.570ms for 667 entries. Nov 4 12:29:39.701630 systemd-journald[693]: System Journal (/var/log/journal/16f6fa2dccca4829a561ef7b9ce1664c) is 8.0M, max 203.0M, 195.0M free. Nov 4 12:29:39.718000 audit: BPF prog-id=29 op=LOAD Nov 4 12:29:39.718000 audit: BPF prog-id=30 op=LOAD Nov 4 12:29:39.718000 audit: BPF prog-id=31 op=LOAD Nov 4 12:29:39.718000 audit: BPF prog-id=10 op=UNLOAD Nov 4 12:29:39.718000 audit: BPF prog-id=11 op=UNLOAD Nov 4 12:29:39.700381 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:29:39.702402 systemd[1]: Mounted FUSE Control File System. Nov 4 12:29:39.703896 systemd[1]: Mounted Kernel Configuration File System. Nov 4 12:29:39.707849 systemd[1]: Finished Load/Save Random Seed. Nov 4 12:29:39.709011 systemd[1]: Condition check resulted in First Boot Complete being skipped. Nov 4 12:29:39.711312 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:29:39.715562 systemd[1]: Starting Wait for udev To Complete Device Initialization... Nov 4 12:29:39.717008 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:29:39.719349 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:29:39.726678 systemd[1]: Finished Flush Journal to Persistent Storage. Nov 4 12:29:39.741853 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:29:39.743000 audit: BPF prog-id=32 op=LOAD Nov 4 12:29:39.744716 systemd[1]: Starting Network Configuration... Nov 4 12:29:39.777119 systemd-networkd[716]: lo: Link UP Nov 4 12:29:39.777126 systemd-networkd[716]: lo: Gained carrier Nov 4 12:29:39.777423 systemd-networkd[716]: Enumeration completed Nov 4 12:29:39.777510 systemd[1]: Started Network Configuration. Nov 4 12:29:39.780511 systemd-udevd[713]: Using default interface naming scheme 'v249'. Nov 4 12:29:39.801987 udevadm[705]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Nov 4 12:29:39.809134 systemd-networkd[716]: eth0: Link UP Nov 4 12:29:39.818703 systemd-networkd[716]: eth0: Gained carrier Nov 4 12:29:39.829858 systemd[1]: Finished Wait for udev To Complete Device Initialization. Nov 4 12:29:39.831750 systemd-networkd[716]: eth0: DHCPv4 address 10.0.0.5/16 via 10.0.0.1 Nov 4 12:29:39.839599 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:29:39.848323 lvm[734]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:29:39.874592 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:29:39.875728 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:29:39.888599 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:29:39.892285 lvm[735]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:29:39.920724 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:29:39.921799 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:29:39.922860 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Nov 4 12:29:39.922886 systemd[1]: Reached target Containers. Nov 4 12:29:39.941927 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Nov 4 12:29:39.954731 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Nov 4 12:29:39.964517 systemd[1]: Mounting /usr/share/oem... Nov 4 12:29:39.970667 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 4 12:29:39.970729 kernel: BTRFS info (device vda6): has skinny extents Nov 4 12:29:39.972805 systemd[1]: Mounted /usr/share/oem. Nov 4 12:29:39.973578 systemd[1]: Reached target Local File Systems. Nov 4 12:29:39.974511 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Nov 4 12:29:39.974872 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 4 12:29:39.974909 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Nov 4 12:29:39.974936 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Nov 4 12:29:39.975867 systemd[1]: Starting Create Volatile Files and Directories... Nov 4 12:29:39.981805 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 4 12:29:39.982854 systemd-tmpfiles[758]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Nov 4 12:29:40.009270 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:29:40.009281 systemd-tmpfiles[758]: Skipping /boot Nov 4 12:29:40.014728 systemd-tmpfiles[758]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:29:40.014744 systemd-tmpfiles[758]: Skipping /boot Nov 4 12:29:40.043602 systemd[1]: Finished Create Volatile Files and Directories. Nov 4 12:29:40.055979 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:29:40.058181 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Nov 4 12:29:40.059296 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Nov 4 12:29:40.059000 audit: BPF prog-id=33 op=LOAD Nov 4 12:29:40.060937 systemd[1]: Starting Network Name Resolution... Nov 4 12:29:40.062000 audit: BPF prog-id=34 op=LOAD Nov 4 12:29:40.063656 systemd[1]: Starting Network Time Synchronization... Nov 4 12:29:40.065713 systemd[1]: Condition check resulted in Update is Completed being skipped. Nov 4 12:29:40.066825 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Nov 4 12:29:40.068402 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Nov 4 12:29:40.069795 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Nov 4 12:29:40.084038 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Nov 4 12:29:40.088000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Nov 4 12:29:40.089548 augenrules[779]: No rules Nov 4 12:29:40.090341 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:29:40.101246 systemd-resolved[762]: Positive Trust Anchors: Nov 4 12:29:40.101257 systemd-resolved[762]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 4 12:29:40.101285 systemd-resolved[762]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Nov 4 12:29:40.102072 systemd-resolved[762]: Defaulting to hostname 'linux'. Nov 4 12:29:40.103361 systemd[1]: Started Network Time Synchronization. Nov 4 12:29:40.104509 systemd-timesyncd[768]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Nov 4 12:29:40.104615 systemd[1]: Started Network Name Resolution. Nov 4 12:29:40.105477 systemd[1]: Reached target Network. Nov 4 12:29:40.106299 systemd[1]: Reached target Host and Network Name Lookups. Nov 4 12:29:40.107300 systemd[1]: Reached target System Initialization. Nov 4 12:29:40.108302 systemd[1]: Started Watch for update engine configuration changes. Nov 4 12:29:40.109444 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 4 12:29:40.110595 systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 4 12:29:40.111622 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Nov 4 12:29:40.111654 systemd[1]: Reached target Path Units. Nov 4 12:29:40.112364 systemd[1]: Reached target System Time Set. Nov 4 12:29:40.113396 systemd[1]: Started Daily Log Rotation. Nov 4 12:29:40.114284 systemd[1]: Started Weekly check for MD array's redundancy information.. Nov 4 12:29:40.115452 systemd[1]: Reached target Timer Units. Nov 4 12:29:40.116589 systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 4 12:29:40.130249 systemd[1]: Starting Docker Socket for the API... Nov 4 12:29:40.133477 systemd[1]: Listening on OpenSSH Server Socket. Nov 4 12:29:40.134785 systemd[1]: Listening on Docker Socket for the API. Nov 4 12:29:40.135702 systemd[1]: Reached target Socket Units. Nov 4 12:29:40.136460 systemd[1]: Reached target Basic System. Nov 4 12:29:40.137287 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Nov 4 12:29:40.137316 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Nov 4 12:29:40.138240 systemd[1]: Started D-Bus System Message Bus. Nov 4 12:29:40.141668 systemd[1]: Starting Extend Filesystems... Nov 4 12:29:40.142482 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Nov 4 12:29:40.143525 systemd[1]: Starting Generate /run/flatcar/motd... Nov 4 12:29:40.145306 systemd[1]: Starting Install an ssh key from /proc/cmdline... Nov 4 12:29:40.147355 systemd[1]: Starting Generate sshd host keys... Nov 4 12:29:40.148244 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Nov 4 12:29:40.148283 systemd[1]: Reached target Load system-provided cloud configs. Nov 4 12:29:40.151594 systemd[1]: Starting User Login Management... Nov 4 12:29:40.153710 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 4 12:29:40.154318 systemd[1]: Starting Update Engine... Nov 4 12:29:40.155079 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Nov 4 12:29:40.156604 extend-filesystems[788]: Found vda Nov 4 12:29:40.156604 extend-filesystems[788]: Found vda1 Nov 4 12:29:40.156604 extend-filesystems[788]: Found vda2 Nov 4 12:29:40.156604 extend-filesystems[788]: Found vda3 Nov 4 12:29:40.155108 systemd[1]: Reached target Load user-provided cloud configs. Nov 4 12:29:40.163133 extend-filesystems[788]: Found usr Nov 4 12:29:40.163133 extend-filesystems[788]: Found vda4 Nov 4 12:29:40.163133 extend-filesystems[788]: Found vda6 Nov 4 12:29:40.163133 extend-filesystems[788]: Found vda7 Nov 4 12:29:40.163133 extend-filesystems[788]: Found vda9 Nov 4 12:29:40.163133 extend-filesystems[788]: Checking size of /dev/vda9 Nov 4 12:29:40.157781 systemd[1]: motdgen.service: Deactivated successfully. Nov 4 12:29:40.158078 systemd[1]: Finished Generate /run/flatcar/motd. Nov 4 12:29:40.160140 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 4 12:29:40.160416 systemd[1]: Finished Install an ssh key from /proc/cmdline. Nov 4 12:29:40.174970 extend-filesystems[788]: Old size kept for /dev/vda9 Nov 4 12:29:40.171718 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 4 12:29:40.172031 systemd[1]: Finished Extend Filesystems. Nov 4 12:29:40.194367 systemd-logind[801]: Watching system buttons on /dev/input/event0 (Power Button) Nov 4 12:29:40.194554 systemd-logind[801]: New seat seat0. Nov 4 12:29:40.198655 systemd[1]: Started User Login Management. Nov 4 12:29:40.204811 update_engine[803]: I1104 12:29:40.204483 803 main.cc:89] Flatcar Update Engine starting Nov 4 12:29:40.205302 update_engine[803]: I1104 12:29:40.205284 803 payload_state.cc:360] Current Response Signature = Nov 4 12:29:40.205302 update_engine[803]: NumURLs = 1 Nov 4 12:29:40.205302 update_engine[803]: Url0 = http://10.0.0.4:34567/packages/update.gz Nov 4 12:29:40.205302 update_engine[803]: Payload Size = 439965385 Nov 4 12:29:40.205302 update_engine[803]: Payload Sha256 Hash = +42QG3ah2EOUXfyDwaJG/hKpihone22jwnvEw5N2E4k= Nov 4 12:29:40.205302 update_engine[803]: Is Delta Payload = 0 Nov 4 12:29:40.205302 update_engine[803]: Max Failure Count Per Url = 10 Nov 4 12:29:40.205302 update_engine[803]: Disable Payload Backoff = 1 Nov 4 12:29:40.205488 update_engine[803]: I1104 12:29:40.205476 803 payload_state.cc:381] Payload Attempt Number = 0 Nov 4 12:29:40.205667 update_engine[803]: I1104 12:29:40.205626 803 payload_state.cc:404] Current URL Index = 0 Nov 4 12:29:40.205790 update_engine[803]: I1104 12:29:40.205778 803 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Nov 4 12:29:40.205938 update_engine[803]: I1104 12:29:40.205912 803 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Nov 4 12:29:40.207531 systemd[1]: Started Update Engine. Nov 4 12:29:40.208384 update_engine[803]: I1104 12:29:40.208353 803 update_check_scheduler.cc:74] Next update check in 6m35s Nov 4 12:29:40.211600 systemd[1]: Finished Generate sshd host keys. Nov 4 12:29:40.229603 systemd[1]: Starting Generate /run/issue... Nov 4 12:29:40.233977 systemd[1]: issuegen.service: Deactivated successfully. Nov 4 12:29:40.234190 systemd[1]: Finished Generate /run/issue. Nov 4 12:29:40.236285 systemd[1]: Starting Permit User Sessions... Nov 4 12:29:40.241142 systemd[1]: Finished Permit User Sessions. Nov 4 12:29:40.243214 systemd[1]: Started Getty on tty1. Nov 4 12:29:40.245190 systemd[1]: Started Serial Getty on ttyAMA0. Nov 4 12:29:40.246272 systemd[1]: Reached target Login Prompts. Nov 4 12:29:40.247212 systemd[1]: Reached target Multi-User System. Nov 4 12:29:40.249117 systemd[1]: Starting Record Runlevel Change in UTMP... Nov 4 12:29:40.254245 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 4 12:29:40.254453 systemd[1]: Finished Record Runlevel Change in UTMP. Nov 4 12:29:40.255530 systemd[1]: Startup finished in 683ms (kernel) + 1.082s (initrd) + 2.617s (userspace) = 4.383s. Nov 4 12:29:40.958861 systemd-networkd[716]: eth0: Gained IPv6LL Nov 4 12:29:50.296814 systemd[1]: Created slice Slice /system/sshd. Nov 4 12:29:50.300021 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53520). Nov 4 12:29:50.337874 sshd[828]: Accepted publickey for core from 10.0.0.1 port 53520 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:50.339816 sshd[828]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:50.356233 systemd[1]: Created slice User Slice of UID 500. Nov 4 12:29:50.357436 systemd[1]: Starting User Runtime Directory /run/user/500... Nov 4 12:29:50.359184 systemd-logind[801]: New session 1 of user core. Nov 4 12:29:50.364093 systemd[1]: Finished User Runtime Directory /run/user/500. Nov 4 12:29:50.365529 systemd[1]: Starting User Manager for UID 500... Nov 4 12:29:50.367951 systemd[831]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:50.416454 systemd[831]: Queued start job for default target Main User Target. Nov 4 12:29:50.416643 systemd[831]: Reached target Paths. Nov 4 12:29:50.416680 systemd[831]: Reached target Sockets. Nov 4 12:29:50.416691 systemd[831]: Reached target Timers. Nov 4 12:29:50.416701 systemd[831]: Reached target Basic System. Nov 4 12:29:50.416746 systemd[831]: Reached target Main User Target. Nov 4 12:29:50.416759 systemd[831]: Startup finished in 44ms. Nov 4 12:29:50.416987 systemd[1]: Started User Manager for UID 500. Nov 4 12:29:50.427134 systemd[1]: Started Session 1 of User core. Nov 4 12:29:50.489006 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53526). Nov 4 12:29:50.523895 sshd[840]: Accepted publickey for core from 10.0.0.1 port 53526 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:50.525345 sshd[840]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:50.528156 systemd-logind[801]: New session 2 of user core. Nov 4 12:29:50.537836 systemd[1]: Started Session 2 of User core. Nov 4 12:29:50.593727 sshd[840]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:50.603816 systemd[1]: sshd@1-10.0.0.5:22-10.0.0.1:53526.service: Deactivated successfully. Nov 4 12:29:50.604469 systemd[1]: session-2.scope: Deactivated successfully. Nov 4 12:29:50.605138 systemd-logind[801]: Session 2 logged out. Waiting for processes to exit. Nov 4 12:29:50.606337 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53542). Nov 4 12:29:50.607049 systemd-logind[801]: Removed session 2. Nov 4 12:29:50.639698 sshd[846]: Accepted publickey for core from 10.0.0.1 port 53542 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:50.640722 sshd[846]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:50.643704 systemd-logind[801]: New session 3 of user core. Nov 4 12:29:50.653829 systemd[1]: Started Session 3 of User core. Nov 4 12:29:50.703891 sshd[846]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:50.714852 systemd[1]: sshd@2-10.0.0.5:22-10.0.0.1:53542.service: Deactivated successfully. Nov 4 12:29:50.715677 systemd[1]: session-3.scope: Deactivated successfully. Nov 4 12:29:50.716548 systemd-logind[801]: Session 3 logged out. Waiting for processes to exit. Nov 4 12:29:50.717988 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53556). Nov 4 12:29:50.718847 systemd-logind[801]: Removed session 3. Nov 4 12:29:50.750917 sshd[853]: Accepted publickey for core from 10.0.0.1 port 53556 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:50.751942 sshd[853]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:50.754935 systemd-logind[801]: New session 4 of user core. Nov 4 12:29:50.766820 systemd[1]: Started Session 4 of User core. Nov 4 12:29:50.821084 sshd[853]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:50.834287 systemd[1]: sshd@3-10.0.0.5:22-10.0.0.1:53556.service: Deactivated successfully. Nov 4 12:29:50.834870 systemd[1]: session-4.scope: Deactivated successfully. Nov 4 12:29:50.835495 systemd-logind[801]: Session 4 logged out. Waiting for processes to exit. Nov 4 12:29:50.836470 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53562). Nov 4 12:29:50.837491 systemd-logind[801]: Removed session 4. Nov 4 12:29:50.871675 sshd[859]: Accepted publickey for core from 10.0.0.1 port 53562 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:50.872889 sshd[859]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:50.876163 systemd-logind[801]: New session 5 of user core. Nov 4 12:29:50.884810 systemd[1]: Started Session 5 of User core. Nov 4 12:29:50.944687 sudo[863]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Nov 4 12:29:50.944910 sudo[863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:29:50.956662 sudo[863]: pam_unix(sudo:session): session closed for user root Nov 4 12:29:50.959588 sshd[859]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:50.971537 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53564). Nov 4 12:29:50.974125 dbus-daemon[787]: [system] Reloaded configuration Nov 4 12:29:50.979137 systemd[1]: sshd@4-10.0.0.5:22-10.0.0.1:53562.service: Deactivated successfully. Nov 4 12:29:50.979925 systemd[1]: session-5.scope: Deactivated successfully. Nov 4 12:29:50.980627 systemd-logind[801]: Session 5 logged out. Waiting for processes to exit. Nov 4 12:29:50.981323 systemd-logind[801]: Removed session 5. Nov 4 12:29:51.010553 sshd[866]: Accepted publickey for core from 10.0.0.1 port 53564 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:51.011721 sshd[866]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:51.015828 systemd-logind[801]: New session 6 of user core. Nov 4 12:29:51.025860 systemd[1]: Started Session 6 of User core. Nov 4 12:29:51.077170 sudo[871]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Nov 4 12:29:51.077385 sudo[871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:29:51.079754 sudo[871]: pam_unix(sudo:session): session closed for user root Nov 4 12:29:51.084489 sudo[870]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Nov 4 12:29:51.084740 sudo[870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:29:51.108800 systemd[1]: Stopping Load Security Auditing Rules... Nov 4 12:29:51.108000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 4 12:29:51.110942 auditctl[874]: No rules Nov 4 12:29:51.113582 kernel: kauditd_printk_skb: 49 callbacks suppressed Nov 4 12:29:51.113643 kernel: audit: type=1305 audit(1762259391.108:60): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 4 12:29:51.111395 systemd[1]: audit-rules.service: Deactivated successfully. Nov 4 12:29:51.111706 systemd[1]: Stopped Load Security Auditing Rules. Nov 4 12:29:51.113268 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:29:51.130593 augenrules[891]: No rules Nov 4 12:29:51.131773 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:29:51.132888 sudo[870]: pam_unix(sudo:session): session closed for user root Nov 4 12:29:51.134235 sshd[866]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:51.150899 systemd[1]: sshd@5-10.0.0.5:22-10.0.0.1:53564.service: Deactivated successfully. Nov 4 12:29:51.151501 systemd[1]: session-6.scope: Deactivated successfully. Nov 4 12:29:51.152745 systemd-logind[801]: Session 6 logged out. Waiting for processes to exit. Nov 4 12:29:51.170379 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53570). Nov 4 12:29:51.174280 systemd-logind[801]: Removed session 6. Nov 4 12:29:51.204949 sshd[898]: Accepted publickey for core from 10.0.0.1 port 53570 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:51.206370 sshd[898]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:51.211097 kernel: audit: type=1006 audit(1762259391.205:61): pid=898 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Nov 4 12:29:51.212757 systemd-logind[801]: New session 7 of user core. Nov 4 12:29:51.223849 systemd[1]: Started Session 7 of User core. Nov 4 12:29:51.314977 sshd[898]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:51.326409 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:53584). Nov 4 12:29:51.327196 systemd[1]: sshd@6-10.0.0.5:22-10.0.0.1:53570.service: Deactivated successfully. Nov 4 12:29:51.328479 systemd[1]: session-7.scope: Deactivated successfully. Nov 4 12:29:51.329389 systemd-logind[801]: Session 7 logged out. Waiting for processes to exit. Nov 4 12:29:51.330239 systemd-logind[801]: Removed session 7. Nov 4 12:29:51.364570 sshd[903]: Accepted publickey for core from 10.0.0.1 port 53584 ssh2: RSA SHA256:uYInMtQn/dIBXXfRKm90csOF1eVgcjPl6y1c48MZyFI Nov 4 12:29:51.365665 sshd[903]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:29:51.367668 kernel: audit: type=1006 audit(1762259391.363:62): pid=903 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Nov 4 12:29:51.368533 systemd-logind[801]: New session 8 of user core. Nov 4 12:29:51.375853 systemd[1]: Started Session 8 of User core. Nov 4 12:29:51.425444 sshd[903]: pam_unix(sshd:session): session closed for user core Nov 4 12:29:51.428290 systemd[1]: sshd@7-10.0.0.5:22-10.0.0.1:53584.service: Deactivated successfully. Nov 4 12:29:51.429048 systemd[1]: session-8.scope: Deactivated successfully. Nov 4 12:29:51.429817 systemd-logind[801]: Session 8 logged out. Waiting for processes to exit. Nov 4 12:29:51.430467 systemd-logind[801]: Removed session 8.