Nov 4 12:51:24.674115 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 4 12:51:24.674131 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:51:24.674139 kernel: efi: EFI v2.70 by EDK II Nov 4 12:51:24.674144 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Nov 4 12:51:24.674149 kernel: efi: seeding entropy pool Nov 4 12:51:24.674154 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Nov 4 12:51:24.674160 kernel: ACPI: Early table checksum verification disabled Nov 4 12:51:24.674165 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Nov 4 12:51:24.674170 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 4 12:51:24.674174 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:24.674181 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:24.674186 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:24.674191 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:24.674196 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:24.674202 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:24.674207 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:24.674213 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:24.674219 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:24.674224 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 4 12:51:24.674229 kernel: ACPI: NUMA: Failed to initialise from firmware Nov 4 12:51:24.674235 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:51:24.674240 kernel: NUMA: NODE_DATA [mem 0xdc959900-0xdc95efff] Nov 4 12:51:24.674245 kernel: Zone ranges: Nov 4 12:51:24.674250 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:51:24.674255 kernel: DMA32 empty Nov 4 12:51:24.674260 kernel: Normal empty Nov 4 12:51:24.674265 kernel: Movable zone start for each node Nov 4 12:51:24.674271 kernel: Early memory node ranges Nov 4 12:51:24.674276 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Nov 4 12:51:24.674281 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Nov 4 12:51:24.674286 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Nov 4 12:51:24.674292 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Nov 4 12:51:24.674297 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Nov 4 12:51:24.674302 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Nov 4 12:51:24.674307 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Nov 4 12:51:24.674312 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 4 12:51:24.674317 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 4 12:51:24.674322 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 4 12:51:24.674327 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 4 12:51:24.674333 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:51:24.674341 kernel: On node 0 totalpages: 643072 Nov 4 12:51:24.674347 kernel: DMA zone: 10048 pages used for memmap Nov 4 12:51:24.674352 kernel: DMA zone: 0 pages reserved Nov 4 12:51:24.674357 kernel: DMA zone: 643072 pages, LIFO batch:63 Nov 4 12:51:24.674363 kernel: psci: probing for conduit method from ACPI. Nov 4 12:51:24.674368 kernel: psci: PSCIv1.1 detected in firmware. Nov 4 12:51:24.674373 kernel: psci: Using standard PSCI v0.2 function IDs Nov 4 12:51:24.674379 kernel: psci: Trusted OS migration not required Nov 4 12:51:24.674386 kernel: psci: SMC Calling Convention v1.1 Nov 4 12:51:24.674391 kernel: ACPI: SRAT not present Nov 4 12:51:24.674397 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Nov 4 12:51:24.674402 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Nov 4 12:51:24.674407 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 4 12:51:24.674413 kernel: Detected PIPT I-cache on CPU0 Nov 4 12:51:24.674418 kernel: CPU features: detected: GIC system register CPU interface Nov 4 12:51:24.674424 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 4 12:51:24.674429 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 4 12:51:24.674435 kernel: CPU features: detected: Hardware dirty bit management Nov 4 12:51:24.674440 kernel: CPU features: detected: Spectre-v4 Nov 4 12:51:24.674446 kernel: CPU features: detected: ARM erratum 1418040 Nov 4 12:51:24.674452 kernel: CPU features: detected: Spectre-BHB Nov 4 12:51:24.674457 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 4 12:51:24.674463 kernel: Policy zone: DMA Nov 4 12:51:24.674469 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:51:24.674475 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 4 12:51:24.674481 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 4 12:51:24.674486 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 4 12:51:24.674492 kernel: Memory: 2452096K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120192K reserved, 0K cma-reserved) Nov 4 12:51:24.674498 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Nov 4 12:51:24.674503 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 4 12:51:24.674510 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 4 12:51:24.674516 kernel: rcu: RCU event tracing is enabled. Nov 4 12:51:24.674521 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 4 12:51:24.674527 kernel: Trampoline variant of Tasks RCU enabled. Nov 4 12:51:24.674532 kernel: Tracing variant of Tasks RCU enabled. Nov 4 12:51:24.674538 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 4 12:51:24.674544 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 4 12:51:24.674549 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 4 12:51:24.674554 kernel: GICv3: 256 SPIs implemented Nov 4 12:51:24.674560 kernel: GICv3: 0 Extended SPIs implemented Nov 4 12:51:24.674565 kernel: GICv3: Distributor has no Range Selector support Nov 4 12:51:24.674571 kernel: GICv3: 16 PPIs implemented Nov 4 12:51:24.674578 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 4 12:51:24.674589 kernel: ACPI: SRAT not present Nov 4 12:51:24.674595 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 4 12:51:24.674600 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Nov 4 12:51:24.674606 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Nov 4 12:51:24.674612 kernel: GICv3: using LPI property table @0x00000000400d0000 Nov 4 12:51:24.674617 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Nov 4 12:51:24.674623 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:51:24.674628 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 4 12:51:24.674634 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 4 12:51:24.674640 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 4 12:51:24.674646 kernel: arm-pv: using stolen time PV Nov 4 12:51:24.674653 kernel: Console: colour dummy device 80x25 Nov 4 12:51:24.674659 kernel: ACPI: Core revision 20200925 Nov 4 12:51:24.674665 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 4 12:51:24.674671 kernel: pid_max: default: 32768 minimum: 301 Nov 4 12:51:24.674676 kernel: LSM: Security Framework initializing Nov 4 12:51:24.674682 kernel: SELinux: Initializing. Nov 4 12:51:24.674688 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:51:24.674694 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:51:24.674699 kernel: rcu: Hierarchical SRCU implementation. Nov 4 12:51:24.674706 kernel: Platform MSI: ITS@0x8080000 domain created Nov 4 12:51:24.674712 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 4 12:51:24.674717 kernel: Remapping and enabling EFI services. Nov 4 12:51:24.674723 kernel: smp: Bringing up secondary CPUs ... Nov 4 12:51:24.674729 kernel: Detected PIPT I-cache on CPU1 Nov 4 12:51:24.674735 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 4 12:51:24.674740 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Nov 4 12:51:24.674746 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:51:24.674752 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 4 12:51:24.674758 kernel: Detected PIPT I-cache on CPU2 Nov 4 12:51:24.674765 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 4 12:51:24.674771 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Nov 4 12:51:24.674777 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:51:24.674783 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 4 12:51:24.674789 kernel: Detected PIPT I-cache on CPU3 Nov 4 12:51:24.674798 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 4 12:51:24.674804 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Nov 4 12:51:24.674811 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:51:24.674817 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 4 12:51:24.674823 kernel: smp: Brought up 1 node, 4 CPUs Nov 4 12:51:24.674829 kernel: SMP: Total of 4 processors activated. Nov 4 12:51:24.674835 kernel: CPU features: detected: Privileged Access Never Nov 4 12:51:24.674841 kernel: CPU features: detected: LSE atomic instructions Nov 4 12:51:24.674847 kernel: CPU features: detected: User Access Override Nov 4 12:51:24.674853 kernel: CPU features: detected: 32-bit EL0 Support Nov 4 12:51:24.674861 kernel: CPU features: detected: Common not Private translations Nov 4 12:51:24.674867 kernel: CPU features: detected: RAS Extension Support Nov 4 12:51:24.674874 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 4 12:51:24.674880 kernel: CPU features: detected: CRC32 instructions Nov 4 12:51:24.674886 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 4 12:51:24.674892 kernel: CPU: All CPU(s) started at EL1 Nov 4 12:51:24.674898 kernel: alternatives: patching kernel code Nov 4 12:51:24.674905 kernel: devtmpfs: initialized Nov 4 12:51:24.674911 kernel: KASLR enabled Nov 4 12:51:24.674918 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 4 12:51:24.674924 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 4 12:51:24.674965 kernel: pinctrl core: initialized pinctrl subsystem Nov 4 12:51:24.674972 kernel: SMBIOS 3.0.0 present. Nov 4 12:51:24.674978 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Nov 4 12:51:24.674983 kernel: NET: Registered protocol family 16 Nov 4 12:51:24.674990 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 4 12:51:24.674996 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 4 12:51:24.675003 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 4 12:51:24.675009 kernel: audit: initializing netlink subsys (disabled) Nov 4 12:51:24.675016 kernel: audit: type=2000 audit(0.031:1): state=initialized audit_enabled=0 res=1 Nov 4 12:51:24.675022 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 4 12:51:24.675028 kernel: cpuidle: using governor menu Nov 4 12:51:24.675034 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 4 12:51:24.675040 kernel: ASID allocator initialised with 32768 entries Nov 4 12:51:24.675046 kernel: ACPI: bus type PCI registered Nov 4 12:51:24.675052 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 4 12:51:24.675059 kernel: Serial: AMBA PL011 UART driver Nov 4 12:51:24.675064 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 4 12:51:24.675070 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 4 12:51:24.675076 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 4 12:51:24.675082 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 4 12:51:24.675088 kernel: cryptd: max_cpu_qlen set to 1000 Nov 4 12:51:24.675094 kernel: ACPI: Added _OSI(Module Device) Nov 4 12:51:24.675100 kernel: ACPI: Added _OSI(Processor Device) Nov 4 12:51:24.675106 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 4 12:51:24.675113 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 4 12:51:24.675119 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 4 12:51:24.675125 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 4 12:51:24.675131 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 4 12:51:24.675137 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 4 12:51:24.675143 kernel: ACPI: Interpreter enabled Nov 4 12:51:24.675149 kernel: ACPI: Using GIC for interrupt routing Nov 4 12:51:24.675155 kernel: ACPI: MCFG table detected, 1 entries Nov 4 12:51:24.675161 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 4 12:51:24.675167 kernel: printk: console [ttyAMA0] enabled Nov 4 12:51:24.675174 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 4 12:51:24.675274 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 4 12:51:24.675330 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 4 12:51:24.675381 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 4 12:51:24.675432 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 4 12:51:24.675482 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 4 12:51:24.675490 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 4 12:51:24.675497 kernel: PCI host bridge to bus 0000:00 Nov 4 12:51:24.675558 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 4 12:51:24.675618 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 4 12:51:24.675667 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 4 12:51:24.675714 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 4 12:51:24.675779 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 4 12:51:24.675840 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 4 12:51:24.675897 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 4 12:51:24.675962 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 4 12:51:24.676017 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:51:24.676071 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:51:24.676125 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 4 12:51:24.676178 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 4 12:51:24.676226 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 4 12:51:24.676275 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 4 12:51:24.676322 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 4 12:51:24.676330 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Nov 4 12:51:24.676336 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Nov 4 12:51:24.676342 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Nov 4 12:51:24.676348 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Nov 4 12:51:24.676354 kernel: vgaarb: loaded Nov 4 12:51:24.676360 kernel: Registered efivars operations Nov 4 12:51:24.676366 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 4 12:51:24.676373 kernel: VFS: Disk quotas dquot_6.6.0 Nov 4 12:51:24.676380 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 4 12:51:24.676385 kernel: pnp: PnP ACPI init Nov 4 12:51:24.676441 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 4 12:51:24.676490 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Nov 4 12:51:24.676499 kernel: pnp: PnP ACPI: found 1 devices Nov 4 12:51:24.676505 kernel: NET: Registered protocol family 2 Nov 4 12:51:24.676511 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 4 12:51:24.676518 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 4 12:51:24.676525 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 4 12:51:24.676531 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 4 12:51:24.676537 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 4 12:51:24.676543 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:51:24.676549 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:51:24.676555 kernel: NET: Registered protocol family 1 Nov 4 12:51:24.676561 kernel: PCI: CLS 0 bytes, default 64 Nov 4 12:51:24.676567 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 4 12:51:24.676574 kernel: kvm [1]: HYP mode not available Nov 4 12:51:24.676586 kernel: Initialise system trusted keyrings Nov 4 12:51:24.676593 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 4 12:51:24.676599 kernel: Key type asymmetric registered Nov 4 12:51:24.676605 kernel: Asymmetric key parser 'x509' registered Nov 4 12:51:24.676611 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 4 12:51:24.676617 kernel: io scheduler mq-deadline registered Nov 4 12:51:24.676623 kernel: io scheduler kyber registered Nov 4 12:51:24.676629 kernel: io scheduler bfq registered Nov 4 12:51:24.676637 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 4 12:51:24.676643 kernel: ACPI: Power Button [PWRB] Nov 4 12:51:24.676649 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Nov 4 12:51:24.676706 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 4 12:51:24.676714 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 4 12:51:24.676720 kernel: msm_serial: driver initialized Nov 4 12:51:24.676726 kernel: random: fast init done Nov 4 12:51:24.676732 kernel: random: crng init done Nov 4 12:51:24.676738 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Nov 4 12:51:24.676744 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Nov 4 12:51:24.676751 kernel: thunder_xcv, ver 1.0 Nov 4 12:51:24.676757 kernel: thunder_bgx, ver 1.0 Nov 4 12:51:24.676763 kernel: nicpf, ver 1.0 Nov 4 12:51:24.676769 kernel: nicvf, ver 1.0 Nov 4 12:51:24.676839 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 4 12:51:24.676893 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-04T12:51:24 UTC (1762260684) Nov 4 12:51:24.676901 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 4 12:51:24.676907 kernel: NET: Registered protocol family 10 Nov 4 12:51:24.676915 kernel: Segment Routing with IPv6 Nov 4 12:51:24.676921 kernel: NET: Registered protocol family 17 Nov 4 12:51:24.676927 kernel: Key type dns_resolver registered Nov 4 12:51:24.676964 kernel: registered taskstats version 1 Nov 4 12:51:24.676970 kernel: Loading compiled-in X.509 certificates Nov 4 12:51:24.676976 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Nov 4 12:51:24.676982 kernel: Key type ._fscrypt registered Nov 4 12:51:24.676988 kernel: Key type .fscrypt registered Nov 4 12:51:24.676994 kernel: Key type fscrypt-provisioning registered Nov 4 12:51:24.677001 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 4 12:51:24.677007 kernel: ima: Allocated hash algorithm: sha1 Nov 4 12:51:24.677013 kernel: ima: No architecture policies found Nov 4 12:51:24.677019 kernel: Freeing unused kernel memory: 34240K Nov 4 12:51:24.677025 kernel: Run /init as init process Nov 4 12:51:24.677031 kernel: with arguments: Nov 4 12:51:24.677037 kernel: /init Nov 4 12:51:24.677042 kernel: with environment: Nov 4 12:51:24.677048 kernel: HOME=/ Nov 4 12:51:24.677054 kernel: TERM=linux Nov 4 12:51:24.677061 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 4 12:51:24.677069 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:51:24.677077 systemd[1]: Detected virtualization kvm. Nov 4 12:51:24.677084 systemd[1]: Detected architecture arm64. Nov 4 12:51:24.677090 systemd[1]: Running in initial RAM disk. Nov 4 12:51:24.677097 systemd[1]: No hostname configured, using default hostname. Nov 4 12:51:24.677104 systemd[1]: Hostname set to . Nov 4 12:51:24.677111 systemd[1]: Initializing machine ID from VM UUID. Nov 4 12:51:24.677118 systemd[1]: Queued start job for default target Initrd Default Target. Nov 4 12:51:24.677125 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:51:24.677131 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:51:24.677138 systemd[1]: Reached target Path Units. Nov 4 12:51:24.677145 systemd[1]: Reached target Slice Units. Nov 4 12:51:24.677151 systemd[1]: Reached target Swaps. Nov 4 12:51:24.677158 systemd[1]: Reached target Timer Units. Nov 4 12:51:24.677165 systemd[1]: Listening on Open-iSCSI iscsid Socket. Nov 4 12:51:24.677172 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Nov 4 12:51:24.677179 systemd[1]: Listening on Journal Audit Socket. Nov 4 12:51:24.677185 systemd[1]: Listening on Journal Socket (/dev/log). Nov 4 12:51:24.677192 systemd[1]: Listening on Journal Socket. Nov 4 12:51:24.677199 systemd[1]: Listening on Network Service Netlink Socket. Nov 4 12:51:24.677205 systemd[1]: Listening on udev Control Socket. Nov 4 12:51:24.677212 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:51:24.677218 systemd[1]: Reached target Socket Units. Nov 4 12:51:24.677225 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:51:24.677232 systemd[1]: Finished Network Cleanup. Nov 4 12:51:24.677238 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Nov 4 12:51:24.677245 systemd[1]: Starting Journal Service... Nov 4 12:51:24.677251 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:51:24.677258 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:51:24.677265 systemd[1]: Starting Setup Virtual Console... Nov 4 12:51:24.677271 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:51:24.677278 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:51:24.677285 systemd[1]: Finished Setup Virtual Console. Nov 4 12:51:24.677292 systemd[1]: Starting dracut ask for additional cmdline parameters... Nov 4 12:51:24.677298 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:51:24.677307 systemd-journald[279]: Journal started Nov 4 12:51:24.677341 systemd-journald[279]: Runtime Journal (/run/log/journal/6b1eeb5eb2f04818b9364d71eab7e479) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:51:24.679945 systemd[1]: Started Journal Service. Nov 4 12:51:24.680325 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:51:24.687601 systemd[1]: Finished dracut ask for additional cmdline parameters. Nov 4 12:51:24.689163 systemd[1]: Starting dracut cmdline hook... Nov 4 12:51:24.697618 dracut-cmdline[295]: dracut-dracut-053 Nov 4 12:51:24.699747 dracut-cmdline[295]: 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:51:24.754954 kernel: SCSI subsystem initialized Nov 4 12:51:24.758942 kernel: Loading iSCSI transport class v2.0-870. Nov 4 12:51:24.764965 kernel: iscsi: registered transport (tcp) Nov 4 12:51:24.775950 kernel: iscsi: registered transport (qla4xxx) Nov 4 12:51:24.775964 kernel: QLogic iSCSI HBA Driver Nov 4 12:51:24.784770 systemd[1]: Finished dracut cmdline hook. Nov 4 12:51:24.786128 systemd[1]: Starting dracut pre-udev hook... Nov 4 12:51:24.797954 kernel: device-mapper: uevent: version 1.0.3 Nov 4 12:51:24.797977 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Nov 4 12:51:24.833964 kernel: raid6: neonx8 gen() 13750 MB/s Nov 4 12:51:24.849946 kernel: raid6: neonx8 xor() 10732 MB/s Nov 4 12:51:24.866950 kernel: raid6: neonx4 gen() 13573 MB/s Nov 4 12:51:24.883957 kernel: raid6: neonx4 xor() 11559 MB/s Nov 4 12:51:24.900957 kernel: raid6: neonx2 gen() 12969 MB/s Nov 4 12:51:24.917959 kernel: raid6: neonx2 xor() 9875 MB/s Nov 4 12:51:24.934956 kernel: raid6: neonx1 gen() 10819 MB/s Nov 4 12:51:24.951949 kernel: raid6: neonx1 xor() 8824 MB/s Nov 4 12:51:24.968960 kernel: raid6: int64x8 gen() 6814 MB/s Nov 4 12:51:24.985950 kernel: raid6: int64x8 xor() 3786 MB/s Nov 4 12:51:25.002956 kernel: raid6: int64x4 gen() 6908 MB/s Nov 4 12:51:25.019957 kernel: raid6: int64x4 xor() 3829 MB/s Nov 4 12:51:25.036958 kernel: raid6: int64x2 gen() 6165 MB/s Nov 4 12:51:25.053947 kernel: raid6: int64x2 xor() 3307 MB/s Nov 4 12:51:25.070950 kernel: raid6: int64x1 gen() 4999 MB/s Nov 4 12:51:25.088503 kernel: raid6: int64x1 xor() 2593 MB/s Nov 4 12:51:25.088526 kernel: raid6: using algorithm neonx8 gen() 13750 MB/s Nov 4 12:51:25.088542 kernel: raid6: .... xor() 10732 MB/s, rmw enabled Nov 4 12:51:25.088557 kernel: raid6: using neon recovery algorithm Nov 4 12:51:25.099027 kernel: xor: measuring software checksum speed Nov 4 12:51:25.099045 kernel: 8regs : 17170 MB/sec Nov 4 12:51:25.099956 kernel: 32regs : 20765 MB/sec Nov 4 12:51:25.101350 kernel: arm64_neon : 29049 MB/sec Nov 4 12:51:25.101362 kernel: xor: using function: arm64_neon (29049 MB/sec) Nov 4 12:51:25.145955 kernel: Btrfs loaded, crc32c=crc32c-generic Nov 4 12:51:25.155169 systemd[1]: Finished dracut pre-udev hook. Nov 4 12:51:25.155000 audit: BPF prog-id=6 op=LOAD Nov 4 12:51:25.156000 audit: BPF prog-id=7 op=LOAD Nov 4 12:51:25.156000 audit: BPF prog-id=8 op=LOAD Nov 4 12:51:25.158210 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:51:25.160469 kernel: audit: type=1334 audit(1762260685.155:2): prog-id=6 op=LOAD Nov 4 12:51:25.160490 kernel: audit: type=1334 audit(1762260685.156:3): prog-id=7 op=LOAD Nov 4 12:51:25.160499 kernel: audit: type=1334 audit(1762260685.156:4): prog-id=8 op=LOAD Nov 4 12:51:25.169092 systemd-udevd[416]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:51:25.170744 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:51:25.173607 systemd[1]: Starting dracut pre-trigger hook... Nov 4 12:51:25.175000 audit: BPF prog-id=9 op=LOAD Nov 4 12:51:25.176786 systemd[1]: Starting Network Configuration... Nov 4 12:51:25.178502 kernel: audit: type=1334 audit(1762260685.175:5): prog-id=9 op=LOAD Nov 4 12:51:25.183843 dracut-pre-trigger[426]: rd.md=0: removing MD RAID activation Nov 4 12:51:25.193616 systemd-networkd[429]: lo: Link UP Nov 4 12:51:25.193623 systemd-networkd[429]: lo: Gained carrier Nov 4 12:51:25.193889 systemd-networkd[429]: Enumeration completed Nov 4 12:51:25.195021 systemd[1]: Started Network Configuration. Nov 4 12:51:25.195000 audit: BPF prog-id=10 op=LOAD Nov 4 12:51:25.197138 systemd[1]: Starting Network Name Resolution... Nov 4 12:51:25.199379 kernel: audit: type=1334 audit(1762260685.195:6): prog-id=10 op=LOAD Nov 4 12:51:25.213265 systemd[1]: Finished dracut pre-trigger hook. Nov 4 12:51:25.214556 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:51:25.223263 systemd-resolved[451]: Positive Trust Anchors: Nov 4 12:51:25.223278 systemd-resolved[451]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 4 12:51:25.223306 systemd-resolved[451]: 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:51:25.223559 systemd-resolved[451]: Defaulting to hostname 'linux'. Nov 4 12:51:25.223801 systemd-udevd[416]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:51:25.224142 systemd[1]: Started Network Name Resolution. Nov 4 12:51:25.225915 systemd[1]: Reached target Network. Nov 4 12:51:25.228944 systemd[1]: Reached target Host and Network Name Lookups. Nov 4 12:51:25.237417 systemd[1]: Starting iSCSI UserSpace I/O driver... Nov 4 12:51:25.244194 systemd[1]: Started iSCSI UserSpace I/O driver. Nov 4 12:51:25.245167 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:51:25.246509 systemd[1]: Starting Open-iSCSI... Nov 4 12:51:25.249324 iscsid[482]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:51:25.249324 iscsid[482]: 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:51:25.249324 iscsid[482]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 4 12:51:25.249324 iscsid[482]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 4 12:51:25.249324 iscsid[482]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:51:25.249324 iscsid[482]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 4 12:51:25.252849 systemd[1]: Started Open-iSCSI. Nov 4 12:51:25.258257 systemd[1]: Starting dracut initqueue hook... Nov 4 12:51:25.279422 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 4 12:51:25.279541 kernel: vda: detected capacity change from 0 to 4756340736 Nov 4 12:51:25.283636 systemd-udevd[477]: Using default interface naming scheme 'v249'. Nov 4 12:51:25.288290 systemd-networkd[429]: eth0: Link UP Nov 4 12:51:25.290965 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:51:25.310368 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Nov 4 12:51:25.313809 systemd[1]: Found device /dev/disk/by-label/ROOT. Nov 4 12:51:25.315327 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (478) Nov 4 12:51:25.318976 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Nov 4 12:51:25.319759 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Nov 4 12:51:25.324680 systemd[1]: Found device /dev/disk/by-label/OEM. Nov 4 12:51:25.325716 systemd[1]: Finished dracut initqueue hook. Nov 4 12:51:25.326780 systemd[1]: Reached target Initrd Root Device. Nov 4 12:51:25.327946 systemd[1]: Reached target Preparation for Remote File Systems. Nov 4 12:51:25.329390 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:51:25.330834 systemd[1]: Reached target Remote File Systems. Nov 4 12:51:25.332814 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Nov 4 12:51:25.334638 systemd[1]: Starting dracut pre-mount hook... Nov 4 12:51:25.344773 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:51:25.346727 systemd[1]: Finished dracut pre-mount hook. Nov 4 12:51:26.341392 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Nov 4 12:51:26.341013 systemd-networkd[429]: eth0: Gained carrier Nov 4 12:51:26.352956 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:51:26.353482 disk-uuid[506]: The operation has completed successfully. Nov 4 12:51:26.355028 systemd-networkd[429]: eth0: DHCPv4 address 10.0.0.7/16 via 10.0.0.1 Nov 4 12:51:26.379895 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 4 12:51:26.380033 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Nov 4 12:51:26.381625 systemd[1]: Starting Ignition (setup)... Nov 4 12:51:26.389305 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 4 12:51:26.389341 kernel: BTRFS info (device vda6): has skinny extents Nov 4 12:51:26.395244 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 4 12:51:26.400289 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 4 12:51:26.400404 systemd[1]: Finished Ignition (setup). Nov 4 12:51:26.402431 systemd[1]: Starting Ignition (disks)... Nov 4 12:51:26.412012 ignition[539]: Ignition v0.36.1-15-gde4e6cc9 Nov 4 12:51:26.412029 ignition[539]: Stage: disks Nov 4 12:51:26.412038 ignition[539]: reading system config file "/usr/lib/ignition/base.ign" Nov 4 12:51:26.412049 ignition[539]: no config at "/usr/lib/ignition/base.ign" Nov 4 12:51:26.412091 ignition[539]: parsed url from cmdline: "" Nov 4 12:51:26.412094 ignition[539]: no config URL provided Nov 4 12:51:26.412099 ignition[539]: reading system config file "/usr/lib/ignition/user.ign" Nov 4 12:51:26.412107 ignition[539]: no config at "/usr/lib/ignition/user.ign" Nov 4 12:51:26.412126 ignition[539]: op(1): [started] loading QEMU firmware config module Nov 4 12:51:26.412130 ignition[539]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 4 12:51:26.413116 ignition[539]: op(1): [finished] loading QEMU firmware config module Nov 4 12:51:26.426138 ignition[539]: parsing config with SHA512: a12e99b4e1b4508a5018a649553a09afe6290da8d01ccc3b458cde0fcdf58169008b381f73465802b1939c6c03083e91dcaf08ac5a2768189a46da6bc3598c98 Nov 4 12:51:26.428311 ignition[539]: disks: disks passed Nov 4 12:51:26.428322 ignition[539]: Ignition finished successfully Nov 4 12:51:26.429112 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 4 12:51:26.429222 systemd[1]: Finished Ignition (disks). Nov 4 12:51:26.430306 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:51:26.432410 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Nov 4 12:51:26.433824 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Nov 4 12:51:26.442802 systemd-fsck[552]: ROOT: clean, 528/553792 files, 37752/553472 blocks Nov 4 12:51:26.446606 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 4 12:51:26.447411 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Nov 4 12:51:26.449458 systemd[1]: Mounting /sysroot... Nov 4 12:51:26.465638 systemd[1]: Found device /dev/mapper/usr. Nov 4 12:51:26.467054 systemd[1]: Starting File System Check on /dev/mapper/usr... Nov 4 12:51:26.468006 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Nov 4 12:51:26.476343 systemd-fsck[567]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Nov 4 12:51:26.476343 systemd-fsck[567]: You must have r/w access to the filesystem or be root Nov 4 12:51:26.476884 systemd-fsck[565]: fsck failed with exit status 8. Nov 4 12:51:26.476887 systemd-fsck[565]: Ignoring error. Nov 4 12:51:26.477693 systemd[1]: Finished File System Check on /dev/mapper/usr. Nov 4 12:51:26.479362 systemd[1]: Mounting /sysusr/usr... Nov 4 12:51:26.497465 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Nov 4 12:51:26.497495 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Nov 4 12:51:26.498047 systemd[1]: Mounted /sysroot. Nov 4 12:51:26.498682 systemd[1]: Reached target Initrd Root File System. Nov 4 12:51:26.506957 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Nov 4 12:51:26.507108 systemd[1]: Mounted /sysusr/usr. Nov 4 12:51:26.507753 systemd[1]: Reached target Local File Systems. Nov 4 12:51:26.508833 systemd[1]: Reached target System Initialization. Nov 4 12:51:26.510146 systemd[1]: Reached target Basic System. Nov 4 12:51:26.512351 systemd[1]: Mounting /sysroot/usr... Nov 4 12:51:26.514307 systemd[1]: Mounted /sysroot/usr. Nov 4 12:51:26.515514 systemd[1]: Starting Root filesystem setup... Nov 4 12:51:26.539200 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 4 12:51:26.539332 systemd[1]: Finished Root filesystem setup. Nov 4 12:51:26.541400 systemd[1]: Starting Ignition (files)... Nov 4 12:51:26.542548 systemd[1]: Starting /sysroot/boot... Nov 4 12:51:26.544539 ignition[584]: Ignition v0.36.1-15-gde4e6cc9 Nov 4 12:51:26.544549 ignition[584]: Stage: files Nov 4 12:51:26.544559 ignition[584]: reading system config file "/usr/lib/ignition/base.ign" Nov 4 12:51:26.544599 ignition[584]: no config at "/usr/lib/ignition/base.ign" Nov 4 12:51:26.545340 ignition[584]: files: compiled without relabeling support, skipping Nov 4 12:51:26.559552 systemd[1]: Finished /sysroot/boot. Nov 4 12:51:26.560174 ignition[584]: files: createUsers: op(1): [started] creating or modifying user "core" Nov 4 12:51:26.560184 ignition[584]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Nov 4 12:51:26.561328 ignition[584]: files: createUsers: op(1): [finished] creating or modifying user "core" Nov 4 12:51:26.561335 ignition[584]: files: createUsers: op(2): [started] adding ssh keys to user "core" Nov 4 12:51:26.562402 ignition[584]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Nov 4 12:51:26.565016 systemd[1]: ignition-files.service: Deactivated successfully. Nov 4 12:51:26.562418 ignition[584]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Nov 4 12:51:26.565115 systemd[1]: Finished Ignition (files). Nov 4 12:51:26.562971 ignition[584]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Nov 4 12:51:26.566696 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Nov 4 12:51:26.562979 ignition[584]: files: op(4): [started] processing unit "coreos-metadata.service" Nov 4 12:51:26.573000 audit: BPF prog-id=3 op=UNLOAD Nov 4 12:51:26.567317 systemd[1]: Starting Ignition (record completion)... Nov 4 12:51:26.576626 kernel: audit: type=1334 audit(1762260686.573:7): prog-id=3 op=UNLOAD Nov 4 12:51:26.563064 ignition[584]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Nov 4 12:51:26.575000 audit: BPF prog-id=6 op=UNLOAD Nov 4 12:51:26.568601 systemd[1]: Starting Reload Configuration from the Real Root... Nov 4 12:51:26.563530 ignition[584]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Nov 4 12:51:26.582219 kernel: audit: type=1334 audit(1762260686.575:8): prog-id=6 op=UNLOAD Nov 4 12:51:26.582236 kernel: audit: type=1334 audit(1762260686.579:9): prog-id=9 op=UNLOAD Nov 4 12:51:26.579000 audit: BPF prog-id=9 op=UNLOAD Nov 4 12:51:26.570312 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 4 12:51:26.563536 ignition[584]: files: op(4): [finished] processing unit "coreos-metadata.service" Nov 4 12:51:26.570417 systemd[1]: Finished Ignition (record completion). Nov 4 12:51:26.563540 ignition[584]: files: files passed Nov 4 12:51:26.584000 audit: BPF prog-id=10 op=UNLOAD Nov 4 12:51:26.572694 systemd[1]: Reloading. Nov 4 12:51:26.563544 ignition[584]: Ignition finished successfully Nov 4 12:51:26.589987 kernel: audit: type=1334 audit(1762260686.584:10): prog-id=10 op=UNLOAD Nov 4 12:51:26.661000 audit: BPF prog-id=11 op=LOAD Nov 4 12:51:26.662000 audit: BPF prog-id=12 op=LOAD Nov 4 12:51:26.662000 audit: BPF prog-id=13 op=LOAD Nov 4 12:51:26.662000 audit: BPF prog-id=4 op=UNLOAD Nov 4 12:51:26.662000 audit: BPF prog-id=5 op=UNLOAD Nov 4 12:51:26.662000 audit: BPF prog-id=14 op=LOAD Nov 4 12:51:26.662000 audit: BPF prog-id=15 op=LOAD Nov 4 12:51:26.662000 audit: BPF prog-id=16 op=LOAD Nov 4 12:51:26.662000 audit: BPF prog-id=7 op=UNLOAD Nov 4 12:51:26.662000 audit: BPF prog-id=8 op=UNLOAD Nov 4 12:51:26.663000 audit: BPF prog-id=17 op=LOAD Nov 4 12:51:26.663000 audit: BPF prog-id=18 op=LOAD Nov 4 12:51:26.677647 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 4 12:51:26.677762 systemd[1]: Finished Reload Configuration from the Real Root. Nov 4 12:51:26.679558 systemd[1]: Reached target Initrd File Systems. Nov 4 12:51:26.680887 systemd[1]: Reached target Initrd Default Target. Nov 4 12:51:26.682245 systemd[1]: Condition check resulted in dracut mount hook being skipped. Nov 4 12:51:26.682865 systemd[1]: Starting dracut pre-pivot and cleanup hook... Nov 4 12:51:26.693017 systemd[1]: Finished dracut pre-pivot and cleanup hook. Nov 4 12:51:26.694436 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Nov 4 12:51:26.700150 systemd[1]: Stopped target Host and Network Name Lookups. Nov 4 12:51:26.701049 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 4 12:51:26.702643 systemd[1]: Stopped target Timer Units. Nov 4 12:51:26.703878 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 4 12:51:26.704003 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Nov 4 12:51:26.705250 systemd[1]: Stopped target Initrd Default Target. Nov 4 12:51:26.706665 systemd[1]: Stopped target Basic System. Nov 4 12:51:26.707905 systemd[1]: Stopped target Initrd Root Device. Nov 4 12:51:26.709234 systemd[1]: Stopped target Path Units. Nov 4 12:51:26.710367 systemd[1]: Stopped target Remote File Systems. Nov 4 12:51:26.711715 systemd[1]: Stopped target Preparation for Remote File Systems. Nov 4 12:51:26.713044 systemd[1]: Stopped target Slice Units. Nov 4 12:51:26.714230 systemd[1]: Stopped target Socket Units. Nov 4 12:51:26.715642 systemd[1]: Stopped target System Initialization. Nov 4 12:51:26.716845 systemd[1]: Stopped target Local File Systems. Nov 4 12:51:26.718050 systemd[1]: Stopped target Preparation for Local File Systems. Nov 4 12:51:26.719544 systemd[1]: Stopped target Swaps. Nov 4 12:51:26.720650 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 4 12:51:26.720749 systemd[1]: Stopped dracut pre-mount hook. Nov 4 12:51:26.722074 systemd[1]: Stopped target Local Encrypted Volumes. Nov 4 12:51:26.723192 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 4 12:51:26.727639 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 4 12:51:26.728787 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 4 12:51:26.728884 systemd[1]: Stopped dracut initqueue hook. Nov 4 12:51:26.732171 iscsid[482]: iscsid shutting down. Nov 4 12:51:26.730542 systemd[1]: Stopping Open-iSCSI... Nov 4 12:51:26.732164 systemd[1]: Stopping /sysroot/boot... Nov 4 12:51:26.732714 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 4 12:51:26.732834 systemd[1]: Stopped Coldplug All udev Devices. Nov 4 12:51:26.734169 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 4 12:51:26.734252 systemd[1]: Stopped dracut pre-trigger hook. Nov 4 12:51:26.736155 systemd[1]: iscsid.service: Deactivated successfully. Nov 4 12:51:26.736311 systemd[1]: Stopped Open-iSCSI. Nov 4 12:51:26.737914 systemd[1]: iscsid.socket: Deactivated successfully. Nov 4 12:51:26.738068 systemd[1]: Closed Open-iSCSI iscsid Socket. Nov 4 12:51:26.739074 systemd[1]: Stopping iSCSI UserSpace I/O driver... Nov 4 12:51:26.741133 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 4 12:51:26.741230 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Nov 4 12:51:26.742676 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 4 12:51:26.742781 systemd[1]: Stopped iSCSI UserSpace I/O driver. Nov 4 12:51:26.744643 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 4 12:51:26.744745 systemd[1]: Stopped /sysroot/boot. Nov 4 12:51:26.745708 systemd[1]: Stopped target Network. Nov 4 12:51:26.746806 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 4 12:51:26.746839 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Nov 4 12:51:26.748343 systemd[1]: Stopping Network Name Resolution... Nov 4 12:51:26.752835 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 4 12:51:26.756000 audit: BPF prog-id=18 op=UNLOAD Nov 4 12:51:26.752959 systemd[1]: Stopped Network Name Resolution. Nov 4 12:51:26.754057 systemd[1]: Stopping Network Configuration... Nov 4 12:51:26.759026 systemd-networkd[429]: eth0: DHCP lease lost Nov 4 12:51:26.770483 systemd-networkd[429]: eth0: DHCPv6 lease lost Nov 4 12:51:26.771789 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 4 12:51:26.771918 systemd[1]: Stopped Network Configuration. Nov 4 12:51:26.773639 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 4 12:51:26.773669 systemd[1]: Closed Network Service Netlink Socket. Nov 4 12:51:26.775296 systemd[1]: Stopping Network Cleanup... Nov 4 12:51:26.776047 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 4 12:51:26.779000 audit: BPF prog-id=17 op=UNLOAD Nov 4 12:51:26.776110 systemd[1]: Stopped Apply Kernel Variables. Nov 4 12:51:26.779107 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Nov 4 12:51:26.783442 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 4 12:51:26.783577 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Nov 4 12:51:26.785360 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 4 12:51:26.785466 systemd[1]: Stopped Network Cleanup. Nov 4 12:51:26.786615 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 4 12:51:26.786652 systemd[1]: Closed udev Control Socket. Nov 4 12:51:26.787857 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 4 12:51:26.787893 systemd[1]: Closed udev Kernel Socket. Nov 4 12:51:26.788943 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 4 12:51:26.788987 systemd[1]: Stopped dracut pre-udev hook. Nov 4 12:51:26.790410 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 4 12:51:26.790448 systemd[1]: Stopped dracut cmdline hook. Nov 4 12:51:26.791552 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 4 12:51:26.791601 systemd[1]: Stopped dracut ask for additional cmdline parameters. Nov 4 12:51:26.793748 systemd[1]: Starting Cleanup udev Database... Nov 4 12:51:26.795228 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Nov 4 12:51:26.796412 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 4 12:51:26.796467 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 4 12:51:26.797880 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 4 12:51:26.797920 systemd[1]: Stopped Create List of Static Device Nodes. Nov 4 12:51:26.807000 audit: BPF prog-id=14 op=UNLOAD Nov 4 12:51:26.799194 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 4 12:51:26.799233 systemd[1]: Stopped Setup Virtual Console. Nov 4 12:51:26.800797 systemd[1]: rngd.service: Deactivated successfully. Nov 4 12:51:26.800907 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Nov 4 12:51:26.810000 audit: BPF prog-id=11 op=UNLOAD Nov 4 12:51:26.802289 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 4 12:51:26.802396 systemd[1]: Finished Cleanup udev Database. Nov 4 12:51:26.803436 systemd[1]: Reached target Switch Root. Nov 4 12:51:26.805225 systemd[1]: Starting Switch Root... Nov 4 12:51:26.810093 systemd[1]: Switching root. Nov 4 12:51:26.829781 systemd-journald[279]: Journal stopped Nov 4 12:51:28.987969 systemd-journald[279]: Received SIGTERM from PID 1 (systemd). Nov 4 12:51:28.988018 kernel: SELinux: policy capability network_peer_controls=1 Nov 4 12:51:28.988030 kernel: SELinux: policy capability open_perms=1 Nov 4 12:51:28.988041 kernel: SELinux: policy capability extended_socket_class=1 Nov 4 12:51:28.988053 kernel: SELinux: policy capability always_check_network=0 Nov 4 12:51:28.988062 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 4 12:51:28.988071 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 4 12:51:28.988080 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 4 12:51:28.988090 systemd[1]: Successfully loaded SELinux policy in 38.124ms. Nov 4 12:51:28.988108 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.421ms. Nov 4 12:51:28.988119 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:51:28.988129 systemd[1]: Detected virtualization kvm. Nov 4 12:51:28.988139 systemd[1]: Detected architecture arm64. Nov 4 12:51:28.988149 systemd[1]: Detected first boot. Nov 4 12:51:28.988159 systemd[1]: Initializing machine ID from VM UUID. Nov 4 12:51:28.988171 systemd[1]: Populated /etc with preset unit settings. Nov 4 12:51:28.988182 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:51:28.988194 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:51:28.988205 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 4 12:51:28.988215 systemd[1]: Stopped Switch Root. Nov 4 12:51:28.988225 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 4 12:51:28.988235 systemd[1]: Created slice Slice /system/addon-config. Nov 4 12:51:28.988244 systemd[1]: Created slice Slice /system/addon-run. Nov 4 12:51:28.988254 systemd[1]: Created slice Slice /system/getty. Nov 4 12:51:28.988264 systemd[1]: Created slice Slice /system/modprobe. Nov 4 12:51:28.988273 systemd[1]: Created slice Slice /system/serial-getty. Nov 4 12:51:28.988284 systemd[1]: Created slice Slice /system/system-cloudinit. Nov 4 12:51:28.988294 systemd[1]: Created slice Slice /system/systemd-fsck. Nov 4 12:51:28.988303 systemd[1]: Created slice User and Session Slice. Nov 4 12:51:28.988313 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:51:28.988322 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Nov 4 12:51:28.988332 systemd[1]: Set up automount Boot partition Automount Point. Nov 4 12:51:28.988341 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 4 12:51:28.988351 systemd[1]: Stopped target Switch Root. Nov 4 12:51:28.988361 systemd[1]: Stopped target Initrd File Systems. Nov 4 12:51:28.988371 systemd[1]: Stopped target Initrd Root File System. Nov 4 12:51:28.988381 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:51:28.988390 systemd[1]: Reached target Remote File Systems. Nov 4 12:51:28.988400 systemd[1]: Reached target Slice Units. Nov 4 12:51:28.988409 systemd[1]: Reached target Swaps. Nov 4 12:51:28.988419 systemd[1]: Reached target Verify torcx succeeded. Nov 4 12:51:28.988429 systemd[1]: Reached target Local Verity Protected Volumes. Nov 4 12:51:28.988438 systemd[1]: Listening on Process Core Dump Socket. Nov 4 12:51:28.988448 systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 4 12:51:28.988457 systemd[1]: Listening on Network Service Netlink Socket. Nov 4 12:51:28.988468 systemd[1]: Listening on udev Control Socket. Nov 4 12:51:28.988478 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:51:28.988488 systemd[1]: Mounting Huge Pages File System... Nov 4 12:51:28.988498 systemd[1]: Mounting POSIX Message Queue File System... Nov 4 12:51:28.988507 systemd[1]: Mounting External Media Directory... Nov 4 12:51:28.988517 systemd[1]: Mounting Kernel Debug File System... Nov 4 12:51:28.988526 systemd[1]: Mounting Kernel Trace File System... Nov 4 12:51:28.988535 systemd[1]: Mounting Temporary Directory /tmp... Nov 4 12:51:28.988545 systemd[1]: Starting Create missing system files... Nov 4 12:51:28.988563 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:51:28.988577 systemd[1]: Starting Load Kernel Module configfs... Nov 4 12:51:28.988586 systemd[1]: Starting Load Kernel Module drm... Nov 4 12:51:28.988596 systemd[1]: Starting Load Kernel Module fuse... Nov 4 12:51:28.988605 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Nov 4 12:51:28.988615 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 4 12:51:28.988624 systemd[1]: Stopped File System Check on Root Device. Nov 4 12:51:28.988634 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 4 12:51:28.988644 systemd[1]: Stopped systemd-fsck-usr.service. Nov 4 12:51:28.988653 systemd[1]: Stopped Journal Service. Nov 4 12:51:28.988663 kernel: fuse: init (API version 7.32) Nov 4 12:51:28.988672 kernel: kauditd_printk_skb: 42 callbacks suppressed Nov 4 12:51:28.988682 kernel: audit: type=1334 audit(1762260688.971:53): prog-id=30 op=LOAD Nov 4 12:51:28.988691 kernel: audit: type=1334 audit(1762260688.971:54): prog-id=31 op=LOAD Nov 4 12:51:28.988701 systemd[1]: Starting Journal Service... Nov 4 12:51:28.988710 kernel: audit: type=1334 audit(1762260688.972:55): prog-id=32 op=LOAD Nov 4 12:51:28.988719 kernel: audit: type=1334 audit(1762260688.972:56): prog-id=28 op=UNLOAD Nov 4 12:51:28.988728 kernel: audit: type=1334 audit(1762260688.972:57): prog-id=29 op=UNLOAD Nov 4 12:51:28.988737 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:51:28.988747 systemd[1]: Starting Remount Root and Kernel File Systems... Nov 4 12:51:28.988758 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:51:28.988767 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:51:28.988777 systemd[1]: verity-setup.service: Deactivated successfully. Nov 4 12:51:28.988787 kernel: audit: type=1305 audit(1762260688.986:58): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Nov 4 12:51:28.988796 systemd[1]: Stopped verity-setup.service. Nov 4 12:51:28.988807 systemd-journald[799]: Journal started Nov 4 12:51:28.988842 systemd-journald[799]: Runtime Journal (/run/log/journal/6b1eeb5eb2f04818b9364d71eab7e479) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:51:26.898000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 4 12:51:26.935000 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:51:26.935000 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:51:26.935000 audit: BPF prog-id=19 op=LOAD Nov 4 12:51:26.935000 audit: BPF prog-id=19 op=UNLOAD Nov 4 12:51:26.935000 audit: BPF prog-id=20 op=LOAD Nov 4 12:51:26.935000 audit: BPF prog-id=20 op=UNLOAD Nov 4 12:51:26.973000 audit[748]: AVC avc: denied { associate } for pid=748 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Nov 4 12:51:28.850000 audit: BPF prog-id=21 op=LOAD Nov 4 12:51:28.850000 audit: BPF prog-id=22 op=LOAD Nov 4 12:51:28.850000 audit: BPF prog-id=23 op=LOAD Nov 4 12:51:28.850000 audit: BPF prog-id=12 op=UNLOAD Nov 4 12:51:28.850000 audit: BPF prog-id=13 op=UNLOAD Nov 4 12:51:28.865000 audit: BPF prog-id=24 op=LOAD Nov 4 12:51:28.865000 audit: BPF prog-id=21 op=UNLOAD Nov 4 12:51:28.865000 audit: BPF prog-id=25 op=LOAD Nov 4 12:51:28.865000 audit: BPF prog-id=26 op=LOAD Nov 4 12:51:28.865000 audit: BPF prog-id=22 op=UNLOAD Nov 4 12:51:28.865000 audit: BPF prog-id=23 op=UNLOAD Nov 4 12:51:28.866000 audit: BPF prog-id=27 op=LOAD Nov 4 12:51:28.866000 audit: BPF prog-id=24 op=UNLOAD Nov 4 12:51:28.866000 audit: BPF prog-id=28 op=LOAD Nov 4 12:51:28.866000 audit: BPF prog-id=29 op=LOAD Nov 4 12:51:28.866000 audit: BPF prog-id=25 op=UNLOAD Nov 4 12:51:28.866000 audit: BPF prog-id=26 op=UNLOAD Nov 4 12:51:28.877000 audit: BPF prog-id=27 op=UNLOAD Nov 4 12:51:28.971000 audit: BPF prog-id=30 op=LOAD Nov 4 12:51:28.971000 audit: BPF prog-id=31 op=LOAD Nov 4 12:51:28.972000 audit: BPF prog-id=32 op=LOAD Nov 4 12:51:28.972000 audit: BPF prog-id=28 op=UNLOAD Nov 4 12:51:28.972000 audit: BPF prog-id=29 op=UNLOAD Nov 4 12:51:28.986000 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:51:28.850927 systemd[1]: Queued start job for default target Multi-User System. Nov 4 12:51:26.972754 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3033.2.4 /usr/share/oem/torcx/store /var/lib/torcx/store/3033.2.4 /var/lib/torcx/store]" Nov 4 12:51:28.868506 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 4 12:51:26.973094 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:51:26.973114 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:51:26.973247 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 4 12:51:26.973259 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 4 12:51:26.973290 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 4 12:51:26.973302 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 4 12:51:26.973497 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 4 12:51:26.973534 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:51:26.973553 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:51:26.973963 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Nov 4 12:51:26.973995 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Nov 4 12:51:26.974016 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3033.2.4: no such file or directory" path=/usr/share/oem/torcx/store/3033.2.4 Nov 4 12:51:26.974031 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" 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:51:26.974049 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3033.2.4: no such file or directory" path=/var/lib/torcx/store/3033.2.4 Nov 4 12:51:26.974064 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:26Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 4 12:51:28.682483 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:28Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:51:28.682771 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:28Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:51:28.682877 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:28Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:51:28.683030 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:28Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:51:28.683081 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:28Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 4 12:51:28.683139 /usr/lib/systemd/system-generators/torcx-generator[748]: time="2025-11-04T12:51:28Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Nov 4 12:51:28.993029 systemd[1]: Started Journal Service. Nov 4 12:51:28.993541 systemd[1]: Mounted Huge Pages File System. Nov 4 12:51:28.994400 systemd[1]: Mounted POSIX Message Queue File System. Nov 4 12:51:28.995337 systemd[1]: Mounted External Media Directory. Nov 4 12:51:28.996169 systemd[1]: Mounted Kernel Debug File System. Nov 4 12:51:28.997000 systemd[1]: Mounted Kernel Trace File System. Nov 4 12:51:28.997803 systemd[1]: Mounted Temporary Directory /tmp. Nov 4 12:51:28.998893 systemd[1]: Finished Create missing system files. Nov 4 12:51:29.000066 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:51:29.001103 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 4 12:51:29.001274 systemd[1]: Finished Load Kernel Module configfs. Nov 4 12:51:29.002274 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 4 12:51:29.002450 systemd[1]: Finished Load Kernel Module drm. Nov 4 12:51:29.003370 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 4 12:51:29.003535 systemd[1]: Finished Load Kernel Module fuse. Nov 4 12:51:29.021350 systemd[1]: Finished Remount Root and Kernel File Systems. Nov 4 12:51:29.022574 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:51:29.025325 systemd[1]: Mounting FUSE Control File System... Nov 4 12:51:29.027006 systemd[1]: Mounting Kernel Configuration File System... Nov 4 12:51:29.027775 systemd[1]: Condition check resulted in Remount Root File System being skipped. Nov 4 12:51:29.029094 systemd[1]: Starting Rebuild Hardware Database... Nov 4 12:51:29.030727 systemd[1]: Starting Flush Journal to Persistent Storage... Nov 4 12:51:29.031831 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Nov 4 12:51:29.033441 systemd[1]: Starting Load/Save Random Seed... Nov 4 12:51:29.034596 systemd-journald[799]: Time spent on flushing to /var/log/journal/6b1eeb5eb2f04818b9364d71eab7e479 is 8.504ms for 779 entries. Nov 4 12:51:29.034596 systemd-journald[799]: System Journal (/var/log/journal/6b1eeb5eb2f04818b9364d71eab7e479) is 8.0M, max 203.0M, 195.0M free. Nov 4 12:51:29.035223 systemd[1]: Starting Create System Users... Nov 4 12:51:29.038693 systemd[1]: Mounted FUSE Control File System. Nov 4 12:51:29.041126 systemd[1]: Mounted Kernel Configuration File System. Nov 4 12:51:29.044008 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:51:29.050720 systemd[1]: Starting Wait for udev To Complete Device Initialization... Nov 4 12:51:29.052045 systemd[1]: Finished Flush Journal to Persistent Storage. Nov 4 12:51:29.053181 systemd[1]: Finished Load/Save Random Seed. Nov 4 12:51:29.054183 systemd[1]: Reached target First Boot Complete. Nov 4 12:51:29.055698 systemd-sysusers[810]: Creating group sgx with gid 999. Nov 4 12:51:29.056690 systemd-sysusers[810]: Creating group systemd-oom with gid 998. Nov 4 12:51:29.057156 systemd-sysusers[810]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Nov 4 12:51:29.057753 systemd-sysusers[810]: Creating group systemd-timesync with gid 997. Nov 4 12:51:29.058402 systemd-sysusers[810]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Nov 4 12:51:29.058992 systemd-sysusers[810]: Creating group systemd-coredump with gid 996. Nov 4 12:51:29.059444 systemd-sysusers[810]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Nov 4 12:51:29.067820 systemd[1]: Finished Create System Users. Nov 4 12:51:29.078742 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:51:29.092094 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:51:29.266318 systemd[1]: Finished Rebuild Hardware Database. Nov 4 12:51:29.289000 audit: BPF prog-id=33 op=LOAD Nov 4 12:51:29.290000 audit: BPF prog-id=34 op=LOAD Nov 4 12:51:29.291997 kernel: audit: type=1334 audit(1762260689.289:59): prog-id=33 op=LOAD Nov 4 12:51:29.292046 kernel: audit: type=1334 audit(1762260689.290:60): prog-id=34 op=LOAD Nov 4 12:51:29.292064 kernel: audit: type=1334 audit(1762260689.291:61): prog-id=35 op=LOAD Nov 4 12:51:29.291000 audit: BPF prog-id=35 op=LOAD Nov 4 12:51:29.292609 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:51:29.291000 audit: BPF prog-id=15 op=UNLOAD Nov 4 12:51:29.291000 audit: BPF prog-id=16 op=UNLOAD Nov 4 12:51:29.293756 kernel: audit: type=1334 audit(1762260689.291:62): prog-id=15 op=UNLOAD Nov 4 12:51:29.314925 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:51:29.322000 audit: BPF prog-id=36 op=LOAD Nov 4 12:51:29.324078 systemd[1]: Starting Network Configuration... Nov 4 12:51:29.350253 systemd-networkd[834]: lo: Link UP Nov 4 12:51:29.350262 systemd-networkd[834]: lo: Gained carrier Nov 4 12:51:29.350575 systemd-networkd[834]: Enumeration completed Nov 4 12:51:29.350665 systemd[1]: Started Network Configuration. Nov 4 12:51:29.358030 systemd-udevd[824]: Using default interface naming scheme 'v249'. Nov 4 12:51:29.370023 systemd-networkd[834]: eth0: Link UP Nov 4 12:51:29.376985 systemd-networkd[834]: eth0: Gained carrier Nov 4 12:51:29.381075 systemd-networkd[834]: eth0: DHCPv4 address 10.0.0.7/16 via 10.0.0.1 Nov 4 12:51:29.387619 udevadm[813]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Nov 4 12:51:29.407060 systemd[1]: Finished Wait for udev To Complete Device Initialization. Nov 4 12:51:29.422292 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:51:29.431087 lvm[842]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:51:29.464790 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:51:29.465892 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:51:29.486798 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:51:29.490652 lvm[843]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:51:29.531458 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:51:29.532779 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:51:29.534005 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Nov 4 12:51:29.534035 systemd[1]: Reached target Containers. Nov 4 12:51:29.544286 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Nov 4 12:51:29.557031 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Nov 4 12:51:29.558997 systemd[1]: Mounting /usr/share/oem... Nov 4 12:51:29.564942 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 4 12:51:29.564990 kernel: BTRFS info (device vda6): has skinny extents Nov 4 12:51:29.566919 systemd[1]: Mounted /usr/share/oem. Nov 4 12:51:29.567653 systemd[1]: Reached target Local File Systems. Nov 4 12:51:29.580049 systemd[1]: Starting Rebuild Dynamic Linker Cache... Nov 4 12:51:29.581347 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 4 12:51:29.581393 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Nov 4 12:51:29.582403 systemd[1]: Starting Commit a transient machine-id on disk... Nov 4 12:51:29.584350 systemd[1]: Starting Create Volatile Files and Directories... Nov 4 12:51:29.590172 systemd-tmpfiles[868]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 4 12:51:29.591193 systemd-tmpfiles[868]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Nov 4 12:51:29.598596 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 4 12:51:29.599150 systemd[1]: Finished Commit a transient machine-id on disk. Nov 4 12:51:29.617501 systemd-tmpfiles[868]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:51:29.617514 systemd-tmpfiles[868]: Skipping /boot Nov 4 12:51:29.622126 systemd-tmpfiles[868]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:51:29.622142 systemd-tmpfiles[868]: Skipping /boot Nov 4 12:51:29.657402 systemd[1]: Finished Create Volatile Files and Directories. Nov 4 12:51:29.658710 systemd[1]: Finished Rebuild Dynamic Linker Cache. Nov 4 12:51:29.674608 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:51:29.676390 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Nov 4 12:51:29.678301 systemd[1]: Starting Rebuild Journal Catalog... Nov 4 12:51:29.678000 audit: BPF prog-id=37 op=LOAD Nov 4 12:51:29.680461 systemd[1]: Starting Network Name Resolution... Nov 4 12:51:29.680000 audit: BPF prog-id=38 op=LOAD Nov 4 12:51:29.683896 systemd[1]: Starting Network Time Synchronization... Nov 4 12:51:29.686097 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Nov 4 12:51:29.687682 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Nov 4 12:51:29.691980 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Nov 4 12:51:29.696376 systemd[1]: Finished Rebuild Journal Catalog. Nov 4 12:51:29.698296 systemd[1]: Starting Update is Completed... Nov 4 12:51:29.699388 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Nov 4 12:51:29.702877 systemd[1]: Finished Update is Completed. Nov 4 12:51:29.710000 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:51:29.711814 augenrules[891]: No rules Nov 4 12:51:29.712551 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:51:29.718667 systemd-resolved[873]: Positive Trust Anchors: Nov 4 12:51:29.718689 systemd-resolved[873]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 4 12:51:29.718717 systemd-resolved[873]: 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:51:29.719460 systemd-resolved[873]: Defaulting to hostname 'linux'. Nov 4 12:51:29.724042 systemd-timesyncd[878]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Nov 4 12:51:29.733510 systemd[1]: Started Network Name Resolution. Nov 4 12:51:29.734391 systemd[1]: Started Network Time Synchronization. Nov 4 12:51:29.735303 systemd[1]: Reached target Network. Nov 4 12:51:29.735948 systemd[1]: Reached target Host and Network Name Lookups. Nov 4 12:51:29.736842 systemd[1]: Reached target System Initialization. Nov 4 12:51:29.737758 systemd[1]: Started Watch for update engine configuration changes. Nov 4 12:51:29.738804 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 4 12:51:29.739878 systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 4 12:51:29.740822 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Nov 4 12:51:29.740852 systemd[1]: Reached target Path Units. Nov 4 12:51:29.741564 systemd[1]: Reached target System Time Set. Nov 4 12:51:29.742428 systemd[1]: Started Daily Log Rotation. Nov 4 12:51:29.743259 systemd[1]: Started Weekly check for MD array's redundancy information.. Nov 4 12:51:29.744275 systemd[1]: Reached target Timer Units. Nov 4 12:51:29.745282 systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 4 12:51:29.756265 systemd[1]: Starting Docker Socket for the API... Nov 4 12:51:29.759530 systemd[1]: Listening on OpenSSH Server Socket. Nov 4 12:51:29.760814 systemd[1]: Listening on Docker Socket for the API. Nov 4 12:51:29.761723 systemd[1]: Reached target Socket Units. Nov 4 12:51:29.762476 systemd[1]: Reached target Basic System. Nov 4 12:51:29.763243 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Nov 4 12:51:29.763274 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Nov 4 12:51:29.764252 systemd[1]: Started D-Bus System Message Bus. Nov 4 12:51:29.767458 systemd[1]: Starting Extend Filesystems... Nov 4 12:51:29.768242 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Nov 4 12:51:29.769317 systemd[1]: Starting Generate /run/flatcar/motd... Nov 4 12:51:29.771031 systemd[1]: Starting Install an ssh key from /proc/cmdline... Nov 4 12:51:29.773039 systemd[1]: Starting Generate sshd host keys... Nov 4 12:51:29.774278 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Nov 4 12:51:29.774346 systemd[1]: Reached target Load system-provided cloud configs. Nov 4 12:51:29.776972 extend-filesystems[901]: Found vda Nov 4 12:51:29.777352 systemd[1]: Starting User Login Management... Nov 4 12:51:29.778368 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 4 12:51:29.779279 extend-filesystems[901]: Found vda1 Nov 4 12:51:29.779279 extend-filesystems[901]: Found vda2 Nov 4 12:51:29.779279 extend-filesystems[901]: Found vda3 Nov 4 12:51:29.779279 extend-filesystems[901]: Found usr Nov 4 12:51:29.779279 extend-filesystems[901]: Found vda4 Nov 4 12:51:29.779279 extend-filesystems[901]: Found vda6 Nov 4 12:51:29.779279 extend-filesystems[901]: Found vda7 Nov 4 12:51:29.779279 extend-filesystems[901]: Found vda9 Nov 4 12:51:29.779279 extend-filesystems[901]: Checking size of /dev/vda9 Nov 4 12:51:29.780345 systemd[1]: Starting Update Engine... Nov 4 12:51:29.781150 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Nov 4 12:51:29.781176 systemd[1]: Reached target Load user-provided cloud configs. Nov 4 12:51:29.783010 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 4 12:51:29.783230 systemd[1]: Finished Install an ssh key from /proc/cmdline. Nov 4 12:51:29.784632 systemd[1]: motdgen.service: Deactivated successfully. Nov 4 12:51:29.784836 systemd[1]: Finished Generate /run/flatcar/motd. Nov 4 12:51:29.797421 extend-filesystems[901]: Old size kept for /dev/vda9 Nov 4 12:51:29.798597 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 4 12:51:29.798844 systemd[1]: Finished Extend Filesystems. Nov 4 12:51:29.813564 update_engine[916]: I1104 12:51:29.813141 916 main.cc:89] Flatcar Update Engine starting Nov 4 12:51:29.815419 systemd[1]: Started Update Engine. Nov 4 12:51:29.816781 update_engine[916]: I1104 12:51:29.815613 916 update_check_scheduler.cc:74] Next update check in 11m29s Nov 4 12:51:29.826178 systemd-logind[914]: Watching system buttons on /dev/input/event0 (Power Button) Nov 4 12:51:29.826180 systemd[1]: Started Cluster reboot manager. Nov 4 12:51:29.828041 systemd-logind[914]: New seat seat0. Nov 4 12:51:29.835458 systemd[1]: Started User Login Management. Nov 4 12:51:29.853258 locksmithd[925]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 4 12:51:30.800989 sshd_keygen[918]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Nov 4 12:51:30.819128 systemd[1]: Finished Generate sshd host keys. Nov 4 12:51:30.836817 systemd[1]: Starting Generate /run/issue... Nov 4 12:51:30.842072 systemd[1]: issuegen.service: Deactivated successfully. Nov 4 12:51:30.842284 systemd[1]: Finished Generate /run/issue. Nov 4 12:51:30.844291 systemd[1]: Starting Permit User Sessions... Nov 4 12:51:30.848682 systemd[1]: Finished Permit User Sessions. Nov 4 12:51:30.850598 systemd[1]: Started Getty on tty1. Nov 4 12:51:30.852428 systemd[1]: Started Serial Getty on ttyAMA0. Nov 4 12:51:30.853366 systemd[1]: Reached target Login Prompts. Nov 4 12:51:30.854212 systemd[1]: Reached target Multi-User System. Nov 4 12:51:30.856028 systemd[1]: Starting Record Runlevel Change in UTMP... Nov 4 12:51:30.860753 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 4 12:51:30.861028 systemd[1]: Finished Record Runlevel Change in UTMP. Nov 4 12:51:30.861955 systemd[1]: Startup finished in 685ms (kernel) + 2.298s (initrd) + 4.002s (userspace) = 6.987s. Nov 4 12:51:31.204035 systemd-networkd[834]: eth0: Gained IPv6LL Nov 4 12:51:36.410510 systemd[1]: Created slice Slice /system/sshd. Nov 4 12:51:36.411569 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39158). Nov 4 12:51:36.456042 sshd[947]: Accepted publickey for core from 10.0.0.1 port 39158 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:36.457905 sshd[947]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:36.479118 systemd[1]: Created slice User Slice of UID 500. Nov 4 12:51:36.480842 systemd[1]: Starting User Runtime Directory /run/user/500... Nov 4 12:51:36.482589 systemd-logind[914]: New session 1 of user core. Nov 4 12:51:36.487387 systemd[1]: Finished User Runtime Directory /run/user/500. Nov 4 12:51:36.488585 systemd[1]: Starting User Manager for UID 500... Nov 4 12:51:36.490701 systemd[950]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:36.540795 systemd[950]: Queued start job for default target Main User Target. Nov 4 12:51:36.540956 systemd[950]: Reached target Paths. Nov 4 12:51:36.540971 systemd[950]: Reached target Sockets. Nov 4 12:51:36.540982 systemd[950]: Reached target Timers. Nov 4 12:51:36.540993 systemd[950]: Reached target Basic System. Nov 4 12:51:36.541035 systemd[950]: Reached target Main User Target. Nov 4 12:51:36.541050 systemd[950]: Startup finished in 46ms. Nov 4 12:51:36.541408 systemd[1]: Started User Manager for UID 500. Nov 4 12:51:36.554361 systemd[1]: Started Session 1 of User core. Nov 4 12:51:36.617028 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39168). Nov 4 12:51:36.656901 sshd[959]: Accepted publickey for core from 10.0.0.1 port 39168 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:36.658190 sshd[959]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:36.660853 systemd-logind[914]: New session 2 of user core. Nov 4 12:51:36.671611 systemd[1]: Started Session 2 of User core. Nov 4 12:51:36.725738 sshd[959]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:36.744969 systemd-logind[914]: Session 2 logged out. Waiting for processes to exit. Nov 4 12:51:36.745172 systemd[1]: sshd@1-10.0.0.7:22-10.0.0.1:39168.service: Deactivated successfully. Nov 4 12:51:36.745750 systemd[1]: session-2.scope: Deactivated successfully. Nov 4 12:51:36.747172 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39184). Nov 4 12:51:36.747660 systemd-logind[914]: Removed session 2. Nov 4 12:51:36.792546 sshd[965]: Accepted publickey for core from 10.0.0.1 port 39184 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:36.793971 sshd[965]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:36.796452 systemd-logind[914]: New session 3 of user core. Nov 4 12:51:36.808940 systemd[1]: Started Session 3 of User core. Nov 4 12:51:36.856667 sshd[965]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:36.871029 systemd[1]: sshd@2-10.0.0.7:22-10.0.0.1:39184.service: Deactivated successfully. Nov 4 12:51:36.871622 systemd[1]: session-3.scope: Deactivated successfully. Nov 4 12:51:36.872241 systemd-logind[914]: Session 3 logged out. Waiting for processes to exit. Nov 4 12:51:36.873284 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39194). Nov 4 12:51:36.873879 systemd-logind[914]: Removed session 3. Nov 4 12:51:36.911289 sshd[972]: Accepted publickey for core from 10.0.0.1 port 39194 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:36.912285 sshd[972]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:36.914616 systemd-logind[914]: New session 4 of user core. Nov 4 12:51:36.928217 systemd[1]: Started Session 4 of User core. Nov 4 12:51:36.980151 sshd[972]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:37.000856 systemd[1]: sshd@3-10.0.0.7:22-10.0.0.1:39194.service: Deactivated successfully. Nov 4 12:51:37.001642 systemd[1]: session-4.scope: Deactivated successfully. Nov 4 12:51:37.002433 systemd-logind[914]: Session 4 logged out. Waiting for processes to exit. Nov 4 12:51:37.003798 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39208). Nov 4 12:51:37.004539 systemd-logind[914]: Removed session 4. Nov 4 12:51:37.046740 sshd[978]: Accepted publickey for core from 10.0.0.1 port 39208 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:37.048036 sshd[978]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:37.050701 systemd-logind[914]: New session 5 of user core. Nov 4 12:51:37.059124 systemd[1]: Started Session 5 of User core. Nov 4 12:51:37.114020 sudo[981]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Nov 4 12:51:37.114223 sudo[981]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:51:37.125639 sudo[981]: pam_unix(sudo:session): session closed for user root Nov 4 12:51:37.127565 sshd[978]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:37.136369 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39222). Nov 4 12:51:37.138767 dbus-daemon[900]: [system] Reloaded configuration Nov 4 12:51:37.141024 systemd[1]: sshd@4-10.0.0.7:22-10.0.0.1:39208.service: Deactivated successfully. Nov 4 12:51:37.141587 systemd[1]: session-5.scope: Deactivated successfully. Nov 4 12:51:37.142147 systemd-logind[914]: Session 5 logged out. Waiting for processes to exit. Nov 4 12:51:37.142837 systemd-logind[914]: Removed session 5. Nov 4 12:51:37.179291 sshd[984]: Accepted publickey for core from 10.0.0.1 port 39222 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:37.180968 sshd[984]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:37.183645 systemd-logind[914]: New session 6 of user core. Nov 4 12:51:37.197405 systemd[1]: Started Session 6 of User core. Nov 4 12:51:37.249207 sudo[989]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Nov 4 12:51:37.249420 sudo[989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:51:37.251645 sudo[989]: pam_unix(sudo:session): session closed for user root Nov 4 12:51:37.255137 sudo[988]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Nov 4 12:51:37.255333 sudo[988]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:51:37.279851 systemd[1]: Stopping Load Security Auditing Rules... Nov 4 12:51:37.280000 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:51:37.282021 kernel: kauditd_printk_skb: 5 callbacks suppressed Nov 4 12:51:37.282067 kernel: audit: type=1305 audit(1762260697.280:68): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 4 12:51:37.282095 auditctl[992]: No rules Nov 4 12:51:37.282422 systemd[1]: audit-rules.service: Deactivated successfully. Nov 4 12:51:37.282673 systemd[1]: Stopped Load Security Auditing Rules. Nov 4 12:51:37.283980 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:51:37.298641 augenrules[1009]: No rules Nov 4 12:51:37.299495 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:51:37.300507 sudo[988]: pam_unix(sudo:session): session closed for user root Nov 4 12:51:37.301678 sshd[984]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:37.314166 systemd[1]: sshd@5-10.0.0.7:22-10.0.0.1:39222.service: Deactivated successfully. Nov 4 12:51:37.314656 systemd[1]: session-6.scope: Deactivated successfully. Nov 4 12:51:37.315232 systemd-logind[914]: Session 6 logged out. Waiting for processes to exit. Nov 4 12:51:37.316155 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:39234). Nov 4 12:51:37.317115 systemd-logind[914]: Removed session 6. Nov 4 12:51:37.360306 sshd[1015]: Accepted publickey for core from 10.0.0.1 port 39234 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:37.362340 sshd[1015]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:37.363944 kernel: audit: type=1006 audit(1762260697.360:69): pid=1015 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Nov 4 12:51:37.366350 systemd-logind[914]: New session 7 of user core. Nov 4 12:51:37.376870 systemd[1]: Started Session 7 of User core. Nov 4 12:51:37.428005 sudo[1018]: 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:51:40.402410 update_engine[1265]: Nov 4 12:51:40.402410 update_engine[1265]: Nov 4 12:51:40.402410 update_engine[1265]: Nov 4 12:51:40.402410 update_engine[1265]: Nov 4 12:51:40.402410 update_engine[1265]: Nov 4 12:51:40.402410 update_engine[1265]: Nov 4 12:51:40.402410 update_engine[1265]: Nov 4 12:51:40.402410 update_engine[1265]: Nov 4 12:51:40.402410 update_engine[1265]: I1104 12:51:40.402407 1265 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Nov 4 12:51:40.404270 sshd[1278]: Accepted publickey for core from 10.0.0.1 port 41820 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:40.404980 update_engine[1265]: I1104 12:51:40.404950 1265 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Nov 4 12:51:40.405197 update_engine[1265]: I1104 12:51:40.405174 1265 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Nov 4 12:51:40.406703 update_engine[1265]: I1104 12:51:40.406661 1265 libcurl_http_fetcher.cc:248] HTTP response code: 200 Nov 4 12:51:40.406763 update_engine[1265]: I1104 12:51:40.406746 1265 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Nov 4 12:51:40.406763 update_engine[1265]: I1104 12:51:40.406754 1265 omaha_request_action.cc:619] Omaha request response: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.406763 update_engine[1265]: Nov 4 12:51:40.407458 sshd[1278]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:40.408854 update_engine[1265]: I1104 12:51:40.408819 1265 omaha_request_action.cc:447] Omaha Response manifest version = Nov 4 12:51:40.408854 update_engine[1265]: I1104 12:51:40.408850 1265 omaha_request_action.cc:470] Found 1 url(s) Nov 4 12:51:40.408964 update_engine[1265]: I1104 12:51:40.408864 1265 omaha_request_action.cc:506] Processing first of 1 package(s) Nov 4 12:51:40.408964 update_engine[1265]: I1104 12:51:40.408867 1265 omaha_request_action.cc:513] Omaha Response package name = update.gz Nov 4 12:51:40.408964 update_engine[1265]: I1104 12:51:40.408870 1265 omaha_request_action.cc:529] Url0: http://10.0.0.6:34567/packages/update.gz Nov 4 12:51:40.408964 update_engine[1265]: I1104 12:51:40.408877 1265 omaha_request_action.cc:541] Payload size = 439965385 bytes Nov 4 12:51:40.408964 update_engine[1265]: I1104 12:51:40.408887 1265 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Nov 4 12:51:40.408964 update_engine[1265]: I1104 12:51:40.408897 1265 payload_state.cc:51] Resetting all persisted state as this is a new response Nov 4 12:51:40.408964 update_engine[1265]: I1104 12:51:40.408901 1265 payload_state.cc:360] Current Response Signature = Nov 4 12:51:40.408964 update_engine[1265]: NumURLs = 1 Nov 4 12:51:40.408964 update_engine[1265]: Url0 = http://10.0.0.6:34567/packages/update.gz Nov 4 12:51:40.408964 update_engine[1265]: Payload Size = 439965385 Nov 4 12:51:40.408964 update_engine[1265]: Payload Sha256 Hash = +42QG3ah2EOUXfyDwaJG/hKpihone22jwnvEw5N2E4k= Nov 4 12:51:40.408964 update_engine[1265]: Is Delta Payload = 0 Nov 4 12:51:40.408964 update_engine[1265]: Max Failure Count Per Url = 10 Nov 4 12:51:40.408964 update_engine[1265]: Disable Payload Backoff = 1 Nov 4 12:51:40.409205 update_engine[1265]: I1104 12:51:40.408994 1265 payload_state.cc:381] Payload Attempt Number = 0 Nov 4 12:51:40.409205 update_engine[1265]: I1104 12:51:40.409031 1265 payload_state.cc:404] Current URL Index = 0 Nov 4 12:51:40.409205 update_engine[1265]: I1104 12:51:40.409060 1265 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Nov 4 12:51:40.409205 update_engine[1265]: I1104 12:51:40.409086 1265 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Nov 4 12:51:40.409205 update_engine[1265]: I1104 12:51:40.409089 1265 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Nov 4 12:51:40.409205 update_engine[1265]: I1104 12:51:40.409119 1265 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Nov 4 12:51:40.409205 update_engine[1265]: I1104 12:51:40.409135 1265 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Nov 4 12:51:40.409205 update_engine[1265]: I1104 12:51:40.409138 1265 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Nov 4 12:51:40.409205 update_engine[1265]: I1104 12:51:40.409166 1265 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Nov 4 12:51:40.409205 update_engine[1265]: E1104 12:51:40.409173 1265 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Nov 4 12:51:40.409627 update_engine[1265]: I1104 12:51:40.409601 1265 omaha_response_handler_action.cc:85] Using this install plan: Nov 4 12:51:40.409627 update_engine[1265]: I1104 12:51:40.409615 1265 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.6: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:51:40.409716 update_engine[1265]: I1104 12:51:40.409684 1265 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Nov 4 12:51:40.410860 update_engine[1265]: I1104 12:51:40.410825 1265 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Nov 4 12:51:40.423568 systemd-logind[914]: New session 25 of user core. Nov 4 12:51:40.432071 systemd[1]: Started Session 25 of User core. Nov 4 12:51:40.533334 sshd[1278]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:40.536418 systemd[1]: sshd@24-10.0.0.7:22-10.0.0.1:41820.service: Deactivated successfully. Nov 4 12:51:40.537046 systemd[1]: session-25.scope: Deactivated successfully. Nov 4 12:51:40.537880 systemd-logind[914]: Session 25 logged out. Waiting for processes to exit. Nov 4 12:51:40.538546 systemd-logind[914]: Removed session 25. Nov 4 12:51:42.011224 update_engine[1265]: I1104 12:51:42.011188 1265 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Nov 4 12:51:42.011224 update_engine[1265]: I1104 12:51:42.011227 1265 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Nov 4 12:51:42.083118 update_engine[1265]: E1104 12:51:42.083079 1265 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Nov 4 12:51:42.083301 update_engine[1265]: I1104 12:51:42.083290 1265 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Nov 4 12:51:42.083346 update_engine[1265]: I1104 12:51:42.083336 1265 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Nov 4 12:51:42.083393 update_engine[1265]: I1104 12:51:42.083384 1265 update_attempter.cc:302] Processing Done. Nov 4 12:51:42.083479 update_engine[1265]: E1104 12:51:42.083469 1265 update_attempter.cc:615] Update failed. Nov 4 12:51:42.083530 update_engine[1265]: I1104 12:51:42.083519 1265 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Nov 4 12:51:42.083585 update_engine[1265]: I1104 12:51:42.083575 1265 payload_state.cc:276] Incrementing the URL failure count Nov 4 12:51:42.083633 update_engine[1265]: I1104 12:51:42.083622 1265 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Nov 4 12:51:42.083863 update_engine[1265]: I1104 12:51:42.083847 1265 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Nov 4 12:51:42.083956 update_engine[1265]: I1104 12:51:42.083945 1265 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.6:34567/v1/update Nov 4 12:51:42.084006 update_engine[1265]: I1104 12:51:42.083997 1265 omaha_request_action.cc:269] Request: Nov 4 12:51:42.084006 update_engine[1265]: Nov 4 12:51:42.084006 update_engine[1265]: Nov 4 12:51:42.084006 update_engine[1265]: Nov 4 12:51:42.084006 update_engine[1265]: Nov 4 12:51:42.084006 update_engine[1265]: Nov 4 12:51:42.084006 update_engine[1265]: Nov 4 12:51:42.084165 update_engine[1265]: I1104 12:51:42.084156 1265 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Nov 4 12:51:42.084265 update_engine[1265]: I1104 12:51:42.084254 1265 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Nov 4 12:51:42.084423 update_engine[1265]: I1104 12:51:42.084409 1265 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Nov 4 12:51:42.225014 update_engine[1265]: I1104 12:51:42.224979 1265 libcurl_http_fetcher.cc:248] HTTP response code: 200 Nov 4 12:51:42.225213 update_engine[1265]: I1104 12:51:42.225199 1265 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Nov 4 12:51:42.225271 update_engine[1265]: I1104 12:51:42.225260 1265 omaha_request_action.cc:619] Omaha request response: Nov 4 12:51:42.225271 update_engine[1265]: Nov 4 12:51:42.225271 update_engine[1265]: Nov 4 12:51:42.225271 update_engine[1265]: Nov 4 12:51:42.225271 update_engine[1265]: Nov 4 12:51:42.225271 update_engine[1265]: Nov 4 12:51:42.225271 update_engine[1265]: Nov 4 12:51:42.225423 update_engine[1265]: E1104 12:51:42.225414 1265 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Nov 4 12:51:42.225473 update_engine[1265]: I1104 12:51:42.225463 1265 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 4 12:51:42.225520 update_engine[1265]: I1104 12:51:42.225510 1265 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 4 12:51:42.225568 update_engine[1265]: I1104 12:51:42.225558 1265 update_attempter.cc:302] Processing Done. Nov 4 12:51:42.225617 update_engine[1265]: I1104 12:51:42.225607 1265 update_attempter.cc:306] Error event sent. Nov 4 12:51:50.542123 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:47014). Nov 4 12:51:50.583449 sshd[1303]: Accepted publickey for core from 10.0.0.1 port 47014 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:50.586406 kernel: kauditd_printk_skb: 287 callbacks suppressed Nov 4 12:51:50.586458 kernel: audit: type=1006 audit(1762260710.583:365): pid=1303 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=26 res=1 Nov 4 12:51:50.586721 sshd[1303]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:50.589608 systemd-logind[914]: New session 26 of user core. Nov 4 12:51:50.601465 systemd[1]: Started Session 26 of User core. Nov 4 12:51:50.656850 sshd[1303]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:50.676292 systemd[1]: sshd@25-10.0.0.7:22-10.0.0.1:47014.service: Deactivated successfully. Nov 4 12:51:50.676889 systemd[1]: session-26.scope: Deactivated successfully. Nov 4 12:51:50.677496 systemd-logind[914]: Session 26 logged out. Waiting for processes to exit. Nov 4 12:51:50.678526 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:47022). Nov 4 12:51:50.679225 systemd-logind[914]: Removed session 26. Nov 4 12:51:50.719338 sshd[1310]: Accepted publickey for core from 10.0.0.1 port 47022 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:50.720560 sshd[1310]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:50.722954 kernel: audit: type=1006 audit(1762260710.719:366): pid=1310 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=27 res=1 Nov 4 12:51:50.724150 systemd-logind[914]: New session 27 of user core. Nov 4 12:51:50.739445 systemd[1]: Started Session 27 of User core. Nov 4 12:51:50.796357 sshd[1310]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:50.813398 systemd[1]: sshd@26-10.0.0.7:22-10.0.0.1:47022.service: Deactivated successfully. Nov 4 12:51:50.813952 systemd[1]: session-27.scope: Deactivated successfully. Nov 4 12:51:50.814469 systemd-logind[914]: Session 27 logged out. Waiting for processes to exit. Nov 4 12:51:50.815455 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:47032). Nov 4 12:51:50.816066 systemd-logind[914]: Removed session 27. Nov 4 12:51:50.853795 sshd[1318]: Accepted publickey for core from 10.0.0.1 port 47032 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:50.854902 sshd[1318]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:50.856948 kernel: audit: type=1006 audit(1762260710.853:367): pid=1318 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=28 res=1 Nov 4 12:51:50.858148 systemd-logind[914]: New session 28 of user core. Nov 4 12:51:50.864065 systemd[1]: Started Session 28 of User core. Nov 4 12:51:50.912887 sshd[1318]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:50.926766 systemd[1]: sshd@27-10.0.0.7:22-10.0.0.1:47032.service: Deactivated successfully. Nov 4 12:51:50.927534 systemd[1]: session-28.scope: Deactivated successfully. Nov 4 12:51:50.928312 systemd-logind[914]: Session 28 logged out. Waiting for processes to exit. Nov 4 12:51:50.929725 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:47046). Nov 4 12:51:50.930766 systemd-logind[914]: Removed session 28. Nov 4 12:51:50.970364 sshd[1324]: Accepted publickey for core from 10.0.0.1 port 47046 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:50.971698 sshd[1324]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:50.973945 kernel: audit: type=1006 audit(1762260710.970:368): pid=1324 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:51:50.975212 systemd-logind[914]: New session 29 of user core. Nov 4 12:51:50.994768 systemd[1]: Started Session 29 of User core. Nov 4 12:51:51.044179 sshd[1324]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:51.057832 systemd[1]: sshd@28-10.0.0.7:22-10.0.0.1:47046.service: Deactivated successfully. Nov 4 12:51:51.058613 systemd[1]: session-29.scope: Deactivated successfully. Nov 4 12:51:51.059383 systemd-logind[914]: Session 29 logged out. Waiting for processes to exit. Nov 4 12:51:51.060795 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:47058). Nov 4 12:51:51.061874 systemd-logind[914]: Removed session 29. Nov 4 12:51:51.100721 sshd[1330]: Accepted publickey for core from 10.0.0.1 port 47058 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:51:51.101610 sshd[1330]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:51:51.103961 kernel: audit: type=1006 audit(1762260711.100:369): pid=1330 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=30 res=1 Nov 4 12:51:51.104907 systemd-logind[914]: New session 30 of user core. Nov 4 12:51:51.116306 systemd[1]: Started Session 30 of User core. Nov 4 12:51:51.169045 sudo[1334]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Nov 4 12:51:51.169249 sudo[1334]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:51:51.175153 systemd[1]: sshd.socket: Deactivated successfully. Nov 4 12:51:51.175652 systemd[1]: Closed OpenSSH Server Socket. Nov 4 12:51:51.177082 sudo[1334]: pam_unix(sudo:session): session closed for user root Nov 4 12:51:51.180569 sudo[1333]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Nov 4 12:51:51.180792 sudo[1333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:51:51.209347 systemd[1]: Stopping Session 1 of User core... Nov 4 12:51:51.209645 sshd[947]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:51.211259 systemd[1]: Stopping Session 30 of User core... Nov 4 12:51:51.211535 sudo[1333]: pam_unix(sudo:session): session closed for user root Nov 4 12:51:51.211903 sshd[1330]: pam_unix(sshd:session): session closed for user core Nov 4 12:51:51.212862 systemd[1]: Removed slice Slice /system/addon-config. Nov 4 12:51:51.214358 systemd[1]: Removed slice Slice /system/addon-run. Nov 4 12:51:51.215754 systemd[1]: Removed slice Slice /system/modprobe. Nov 4 12:51:51.217175 systemd[1]: Removed slice Slice /system/system-cloudinit. Nov 4 12:51:51.218374 systemd[1]: Stopped target Multi-User System. Nov 4 12:51:51.219473 systemd[1]: Stopped target Login Prompts. Nov 4 12:51:51.220454 systemd[1]: Stopped target Containers. Nov 4 12:51:51.221401 systemd[1]: Stopped target Host and Network Name Lookups. Nov 4 12:51:51.222543 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 4 12:51:51.223737 systemd[1]: Stopped target Timer Units. Nov 4 12:51:51.224641 systemd[1]: logrotate.timer: Deactivated successfully. Nov 4 12:51:51.224849 systemd[1]: Stopped Daily Log Rotation. Nov 4 12:51:51.225824 systemd[1]: mdadm.timer: Deactivated successfully. Nov 4 12:51:51.226014 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Nov 4 12:51:51.227217 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Nov 4 12:51:51.227394 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Nov 4 12:51:51.228859 systemd[1]: Stopped target System Time Set. Nov 4 12:51:51.229924 systemd[1]: Stopped target Load user-provided cloud configs. Nov 4 12:51:51.231094 systemd[1]: Stopped target Load system-provided cloud configs. Nov 4 12:51:51.232205 systemd[1]: systemd-coredump.socket: Deactivated successfully. Nov 4 12:51:51.232458 systemd[1]: Closed Process Core Dump Socket. Nov 4 12:51:51.234330 systemd[1]: Unmounting Boot partition... Nov 4 12:51:51.235460 systemd[1]: Stopping Getty on tty1... Nov 4 12:51:51.236491 systemd[1]: Stopping Serial Getty on ttyAMA0... Nov 4 12:51:51.237520 systemd[1]: Stopping OpenSSH per-connection server daemon... Nov 4 12:51:51.238473 sshd[1330]: pam_systemd(sshd:session): Failed to release session: Interrupted system call Nov 4 12:51:51.238912 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:47058)... Nov 4 12:51:51.239780 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Nov 4 12:51:51.240121 systemd[1]: Stopped Commit a transient machine-id on disk. Nov 4 12:51:51.241414 systemd[1]: Stopped target First Boot Complete. Nov 4 12:51:51.243396 systemd[1]: Stopping Load/Save Random Seed... Nov 4 12:51:51.244284 systemd[1]: Stopping Update Engine... Nov 4 12:51:51.247806 systemd[1]: getty@tty1.service: Deactivated successfully. Nov 4 12:51:51.248032 systemd[1]: Stopped Getty on tty1. Nov 4 12:51:51.249108 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Nov 4 12:51:51.249293 systemd[1]: Stopped Serial Getty on ttyAMA0. Nov 4 12:51:51.250510 systemd[1]: sshd@0-10.0.0.7:22-10.0.0.1:39158.service: Deactivated successfully. Nov 4 12:51:51.250712 systemd[1]: Stopped OpenSSH per-connection server daemon. Nov 4 12:51:51.252105 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Nov 4 12:51:51.252180 systemd[1]: update-engine.service: Failed with result 'exit-code'. Nov 4 12:51:51.252430 systemd[1]: Stopped Update Engine. Nov 4 12:51:51.253143 systemd[1]: update-engine.service: Consumed 2.350s CPU time. Nov 4 12:51:51.253371 systemd[1]: sshd@29-10.0.0.7:22-10.0.0.1:47058.service: Deactivated successfully. Nov 4 12:51:51.253551 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:47058). Nov 4 12:51:51.255526 systemd[1]: systemd-random-seed.service: Deactivated successfully. Nov 4 12:51:51.255757 systemd[1]: Stopped Load/Save Random Seed. Nov 4 12:51:51.256880 systemd[1]: session-30.scope: Deactivated successfully. Nov 4 12:51:51.257113 systemd[1]: Stopped Session 30 of User core. Nov 4 12:51:51.258066 systemd[1]: session-1.scope: Deactivated successfully. Nov 4 12:51:51.258304 systemd[1]: Stopped Session 1 of User core. Nov 4 12:51:51.259521 systemd-logind[914]: Session 1 logged out. Waiting for processes to exit. Nov 4 12:51:51.260389 systemd-logind[914]: Session 30 logged out. Waiting for processes to exit. Nov 4 12:51:51.260635 systemd[1]: Removed slice Slice /system/getty. Nov 4 12:51:51.261769 systemd[1]: Removed slice Slice /system/serial-getty. Nov 4 12:51:51.262983 systemd[1]: Removed slice Slice /system/sshd. Nov 4 12:51:51.263761 systemd[1]: sshd-keygen.service: Deactivated successfully. Nov 4 12:51:51.263867 systemd[1]: Stopped Generate sshd host keys. Nov 4 12:51:51.264980 systemd[1]: sshd-keygen.service: Consumed 1.020s CPU time. Nov 4 12:51:51.265152 systemd[1]: Stopping User Login Management... Nov 4 12:51:51.265869 systemd[1]: Stopping User Manager for UID 500... Nov 4 12:51:51.266655 systemd[950]: Stopped target Main User Target. Nov 4 12:51:51.266677 systemd[950]: Stopped target Basic System. Nov 4 12:51:51.266686 systemd[950]: Stopped target Paths. Nov 4 12:51:51.266695 systemd[950]: Stopped target Sockets. Nov 4 12:51:51.266711 systemd[950]: Reached target Shutdown. Nov 4 12:51:51.266718 systemd[950]: Stopped target Timers. Nov 4 12:51:51.266828 systemd[950]: Finished Exit the Session. Nov 4 12:51:51.266851 systemd[950]: Reached target Exit the Session. Nov 4 12:51:51.269164 systemd[1]: user@500.service: Deactivated successfully. Nov 4 12:51:51.269333 systemd[1]: Stopped User Manager for UID 500. Nov 4 12:51:51.271025 systemd-logind[914]: Removed session 30. Nov 4 12:51:51.271362 systemd[1]: Stopping User Runtime Directory /run/user/500... Nov 4 12:51:51.272475 systemd[1]: boot.mount: Deactivated successfully. Nov 4 12:51:51.272743 systemd[1]: Unmounted Boot partition. Nov 4 12:51:51.273872 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Nov 4 12:51:51.273954 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Nov 4 12:51:51.276396 systemd[1]: run-user-500.mount: Deactivated successfully. Nov 4 12:51:51.276451 systemd[1]: Unmounted /run/user/500. Nov 4 12:51:51.277602 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Nov 4 12:51:51.277825 systemd[1]: Stopped User Runtime Directory /run/user/500. Nov 4 12:51:51.279415 systemd[1]: Removed slice User Slice of UID 500. Nov 4 12:51:51.281067 systemd[1]: Stopping D-Bus System Message Bus... Nov 4 12:51:51.282535 systemd[1]: Stopping Permit User Sessions... Nov 4 12:51:51.283744 systemd[1]: systemd-logind.service: Deactivated successfully. Nov 4 12:51:51.284018 systemd[1]: Stopped User Login Management. Nov 4 12:51:51.286728 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Nov 4 12:51:51.286000 audit: BPF prog-id=64 op=UNLOAD Nov 4 12:51:51.287031 systemd[1]: Stopped Permit User Sessions. Nov 4 12:51:51.287945 kernel: audit: type=1334 audit(1762260711.286:370): prog-id=64 op=UNLOAD Nov 4 12:51:51.288835 systemd[1]: dbus.service: Deactivated successfully. Nov 4 12:51:51.289080 systemd[1]: Stopped D-Bus System Message Bus. Nov 4 12:51:51.289889 systemd[1]: Stopped target Basic System. Nov 4 12:51:51.290751 systemd[1]: Stopped target Network. Nov 4 12:51:51.291450 systemd[1]: Stopped target Path Units. Nov 4 12:51:51.292116 systemd[1]: motdgen.path: Deactivated successfully. Nov 4 12:51:51.299025 systemd[1]: Stopped Watch for update engine configuration changes. Nov 4 12:51:51.300704 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Nov 4 12:51:51.309082 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 4 12:51:51.311110 systemd[1]: Stopped target Remote File Systems. Nov 4 12:51:51.312109 systemd[1]: Stopped target Slice Units. Nov 4 12:51:51.313156 systemd[1]: Removed slice User and Session Slice. Nov 4 12:51:51.313960 systemd[1]: Stopped target Socket Units. Nov 4 12:51:51.314684 systemd[1]: dbus.socket: Deactivated successfully. Nov 4 12:51:51.314743 systemd[1]: Closed D-Bus System Message Bus Socket. Nov 4 12:51:51.315730 systemd[1]: docker.socket: Deactivated successfully. Nov 4 12:51:51.315977 systemd[1]: Closed Docker Socket for the API. Nov 4 12:51:51.316708 systemd[1]: Stopped target System Initialization. Nov 4 12:51:51.317519 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Nov 4 12:51:51.317653 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Nov 4 12:51:51.318680 systemd[1]: Stopped target Local Verity Protected Volumes. Nov 4 12:51:51.331121 systemd[1]: Stopping Load Security Auditing Rules... Nov 4 12:51:51.332219 systemd[1]: Stopping Network Name Resolution... Nov 4 12:51:51.333159 systemd[1]: Stopping Network Time Synchronization... Nov 4 12:51:51.333437 auditctl[1348]: No rules Nov 4 12:51:51.333885 systemd[1]: systemd-update-done.service: Deactivated successfully. Nov 4 12:51:51.333967 systemd[1]: Stopped Update is Completed. Nov 4 12:51:51.334666 systemd[1]: ldconfig.service: Deactivated successfully. Nov 4 12:51:51.334724 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Nov 4 12:51:51.335566 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Nov 4 12:51:51.335638 systemd[1]: Stopped Rebuild Hardware Database. Nov 4 12:51:51.336428 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Nov 4 12:51:51.336488 systemd[1]: Stopped Rebuild Journal Catalog. Nov 4 12:51:51.338056 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Nov 4 12:51:51.340410 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 4 12:51:51.340659 systemd[1]: Stopped Network Name Resolution. Nov 4 12:51:51.341687 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Nov 4 12:51:51.341921 systemd[1]: Stopped Network Time Synchronization. Nov 4 12:51:51.343008 systemd[1]: audit-rules.service: Deactivated successfully. Nov 4 12:51:51.343208 systemd[1]: Stopped Load Security Auditing Rules. Nov 4 12:51:51.345390 systemd[1]: Stopping Network Configuration... Nov 4 12:51:51.349980 systemd-networkd[834]: eth0: DHCPv6 lease lost Nov 4 12:51:51.358000 audit: BPF prog-id=56 op=UNLOAD Nov 4 12:51:51.359491 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 4 12:51:51.359849 systemd[1]: Stopped Network Configuration. Nov 4 12:51:51.358000 audit: BPF prog-id=67 op=UNLOAD Nov 4 12:51:51.360777 kernel: audit: type=1334 audit(1762260711.358:371): prog-id=56 op=UNLOAD Nov 4 12:51:51.360828 kernel: audit: type=1334 audit(1762260711.358:372): prog-id=67 op=UNLOAD Nov 4 12:51:51.361887 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Nov 4 12:51:51.362237 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Nov 4 12:51:51.363828 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 4 12:51:51.364021 systemd[1]: Closed Network Service Netlink Socket. Nov 4 12:51:51.364866 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 4 12:51:51.364000 audit: BPF prog-id=60 op=UNLOAD Nov 4 12:51:51.365226 systemd[1]: Stopped Apply Kernel Variables. Nov 4 12:51:51.366494 kernel: audit: type=1334 audit(1762260711.364:373): prog-id=60 op=UNLOAD Nov 4 12:51:51.366664 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 4 12:51:51.366781 systemd[1]: Stopped Create Volatile Files and Directories. Nov 4 12:51:51.367779 systemd[1]: Stopped target Local File Systems. Nov 4 12:51:51.369454 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Nov 4 12:51:51.371052 systemd[1]: Unmounting External Media Directory... Nov 4 12:51:51.372572 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Nov 4 12:51:51.374383 systemd[1]: Unmounting /run/torcx/unpack... Nov 4 12:51:51.375575 systemd[1]: Unmounting Temporary Directory /tmp... Nov 4 12:51:51.376827 systemd[1]: Unmounting /usr/share/oem... Nov 4 12:51:51.378373 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Nov 4 12:51:51.380866 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Nov 4 12:51:51.381153 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Nov 4 12:51:51.382288 systemd[1]: media.mount: Deactivated successfully. Nov 4 12:51:51.382526 systemd[1]: Unmounted External Media Directory. Nov 4 12:51:51.383421 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Nov 4 12:51:51.383649 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Nov 4 12:51:51.384833 systemd[1]: tmp.mount: Deactivated successfully. Nov 4 12:51:51.385162 systemd[1]: Unmounted Temporary Directory /tmp. Nov 4 12:51:51.393125 systemd[1]: usr-share-oem.mount: Deactivated successfully. Nov 4 12:51:51.393365 systemd[1]: Unmounted /usr/share/oem. Nov 4 12:51:51.394210 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Nov 4 12:51:51.394429 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Nov 4 12:51:51.395726 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Nov 4 12:51:51.395951 systemd[1]: Unmounted /run/torcx/unpack. Nov 4 12:51:51.396892 systemd[1]: Stopped target Swaps. Nov 4 12:51:51.397611 systemd[1]: Reached target Unmount All Filesystems. Nov 4 12:51:51.398424 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Nov 4 12:51:51.398501 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Nov 4 12:51:51.399712 systemd[1]: Removed slice Slice /system/systemd-fsck. Nov 4 12:51:51.400563 systemd[1]: Stopped target Preparation for Local File Systems. Nov 4 12:51:51.401509 systemd[1]: lvm2-activation.service: Deactivated successfully. Nov 4 12:51:51.401574 systemd[1]: Stopped Activation of LVM2 logical volumes. Nov 4 12:51:51.402451 systemd[1]: Stopped target Local Encrypted Volumes. Nov 4 12:51:51.403253 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 4 12:51:51.403326 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 4 12:51:51.404584 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Nov 4 12:51:51.410986 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Nov 4 12:51:51.411996 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Nov 4 12:51:51.412062 systemd[1]: Stopped Activation of LVM2 logical volumes. Nov 4 12:51:51.412898 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 4 12:51:51.412987 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 4 12:51:51.413807 systemd[1]: systemd-sysusers.service: Deactivated successfully. Nov 4 12:51:51.413864 systemd[1]: Stopped Create System Users. Nov 4 12:51:51.414638 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Nov 4 12:51:51.414691 systemd[1]: Stopped Remount Root and Kernel File Systems. Nov 4 12:51:51.415613 systemd[1]: Reached target System Shutdown. Nov 4 12:51:51.416505 systemd[1]: Reached target Late Shutdown Services. Nov 4 12:51:51.417389 systemd[1]: systemd-reboot.service: Deactivated successfully. Nov 4 12:51:51.417423 systemd[1]: Finished System Reboot. Nov 4 12:51:51.418079 systemd[1]: Reached target System Reboot. Nov 4 12:51:51.418743 systemd[1]: Shutting down. Nov 4 12:51:51.419000 audit: BPF prog-id=66 op=UNLOAD Nov 4 12:51:51.419000 audit: BPF prog-id=65 op=UNLOAD Nov 4 12:51:51.421952 kernel: audit: type=1334 audit(1762260711.419:374): prog-id=66 op=UNLOAD Nov 4 12:51:51.421000 audit: BPF prog-id=59 op=UNLOAD Nov 4 12:51:51.421000 audit: BPF prog-id=58 op=UNLOAD Nov 4 12:51:51.421000 audit: BPF prog-id=57 op=UNLOAD Nov 4 12:51:51.421000 audit: BPF prog-id=63 op=UNLOAD Nov 4 12:51:51.421000 audit: BPF prog-id=62 op=UNLOAD Nov 4 12:51:51.422000 audit: BPF prog-id=61 op=UNLOAD Nov 4 12:51:51.469962 systemd-shutdown[1]: Syncing filesystems and block devices. Nov 4 12:51:51.477887 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Nov 4 12:51:51.477987 systemd-journald[799]: Journal stopped -- Reboot -- Nov 4 12:51:58.667708 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 4 12:51:58.667724 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:51:58.667732 kernel: efi: EFI v2.70 by EDK II Nov 4 12:51:58.667738 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Nov 4 12:51:58.667743 kernel: efi: seeding entropy pool Nov 4 12:51:58.667748 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Nov 4 12:51:58.667754 kernel: ACPI: Early table checksum verification disabled Nov 4 12:51:58.667760 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Nov 4 12:51:58.667765 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 4 12:51:58.667770 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:58.667776 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:58.667782 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:58.667788 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:58.667793 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:58.667799 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:58.667805 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:58.667811 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:58.667816 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 4 12:51:58.667822 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 4 12:51:58.667843 kernel: ACPI: NUMA: Failed to initialise from firmware Nov 4 12:51:58.667849 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:51:58.667854 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Nov 4 12:51:58.667859 kernel: Zone ranges: Nov 4 12:51:58.667865 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:51:58.667870 kernel: DMA32 empty Nov 4 12:51:58.667875 kernel: Normal empty Nov 4 12:51:58.667880 kernel: Movable zone start for each node Nov 4 12:51:58.667886 kernel: Early memory node ranges Nov 4 12:51:58.667892 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Nov 4 12:51:58.667897 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Nov 4 12:51:58.667902 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Nov 4 12:51:58.667907 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Nov 4 12:51:58.667913 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Nov 4 12:51:58.667918 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Nov 4 12:51:58.667923 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Nov 4 12:51:58.667928 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 4 12:51:58.667933 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 4 12:51:58.667938 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 4 12:51:58.667944 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 4 12:51:58.667949 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 4 12:51:58.667957 kernel: On node 0 totalpages: 643072 Nov 4 12:51:58.667963 kernel: DMA zone: 10048 pages used for memmap Nov 4 12:51:58.667968 kernel: DMA zone: 0 pages reserved Nov 4 12:51:58.667973 kernel: DMA zone: 643072 pages, LIFO batch:63 Nov 4 12:51:58.667979 kernel: psci: probing for conduit method from ACPI. Nov 4 12:51:58.667984 kernel: psci: PSCIv1.1 detected in firmware. Nov 4 12:51:58.667990 kernel: psci: Using standard PSCI v0.2 function IDs Nov 4 12:51:58.667995 kernel: psci: Trusted OS migration not required Nov 4 12:51:58.668002 kernel: psci: SMC Calling Convention v1.1 Nov 4 12:51:58.668007 kernel: ACPI: SRAT not present Nov 4 12:51:58.668013 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Nov 4 12:51:58.668018 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Nov 4 12:51:58.668024 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 4 12:51:58.668029 kernel: Detected PIPT I-cache on CPU0 Nov 4 12:51:58.668035 kernel: CPU features: detected: GIC system register CPU interface Nov 4 12:51:58.668040 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 4 12:51:58.668046 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 4 12:51:58.668051 kernel: CPU features: detected: Hardware dirty bit management Nov 4 12:51:58.668057 kernel: CPU features: detected: Spectre-v4 Nov 4 12:51:58.668063 kernel: CPU features: detected: ARM erratum 1418040 Nov 4 12:51:58.668069 kernel: CPU features: detected: Spectre-BHB Nov 4 12:51:58.668074 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 4 12:51:58.668080 kernel: Policy zone: DMA Nov 4 12:51:58.668086 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:51:58.668092 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 4 12:51:58.668098 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 4 12:51:58.668103 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 4 12:51:58.668109 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Nov 4 12:51:58.668115 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Nov 4 12:51:58.668120 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 4 12:51:58.668127 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 4 12:51:58.668133 kernel: rcu: RCU event tracing is enabled. Nov 4 12:51:58.668139 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 4 12:51:58.668144 kernel: Trampoline variant of Tasks RCU enabled. Nov 4 12:51:58.668150 kernel: Tracing variant of Tasks RCU enabled. Nov 4 12:51:58.668155 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 4 12:51:58.668161 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 4 12:51:58.668166 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 4 12:51:58.668172 kernel: GICv3: 256 SPIs implemented Nov 4 12:51:58.668177 kernel: GICv3: 0 Extended SPIs implemented Nov 4 12:51:58.668183 kernel: GICv3: Distributor has no Range Selector support Nov 4 12:51:58.668188 kernel: GICv3: 16 PPIs implemented Nov 4 12:51:58.668194 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 4 12:51:58.668200 kernel: ACPI: SRAT not present Nov 4 12:51:58.668205 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 4 12:51:58.668211 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Nov 4 12:51:58.668216 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Nov 4 12:51:58.668222 kernel: GICv3: using LPI property table @0x00000000400d0000 Nov 4 12:51:58.668227 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Nov 4 12:51:58.668233 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:51:58.668238 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 4 12:51:58.668244 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 4 12:51:58.668250 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 4 12:51:58.668256 kernel: arm-pv: using stolen time PV Nov 4 12:51:58.668263 kernel: Console: colour dummy device 80x25 Nov 4 12:51:58.668268 kernel: ACPI: Core revision 20200925 Nov 4 12:51:58.668274 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 4 12:51:58.668280 kernel: pid_max: default: 32768 minimum: 301 Nov 4 12:51:58.668286 kernel: LSM: Security Framework initializing Nov 4 12:51:58.668291 kernel: SELinux: Initializing. Nov 4 12:51:58.668297 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:51:58.668303 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 4 12:51:58.668309 kernel: rcu: Hierarchical SRCU implementation. Nov 4 12:51:58.668316 kernel: Platform MSI: ITS@0x8080000 domain created Nov 4 12:51:58.668322 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 4 12:51:58.668328 kernel: Remapping and enabling EFI services. Nov 4 12:51:58.668333 kernel: smp: Bringing up secondary CPUs ... Nov 4 12:51:58.668339 kernel: Detected PIPT I-cache on CPU1 Nov 4 12:51:58.668345 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 4 12:51:58.668351 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Nov 4 12:51:58.668357 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:51:58.668362 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 4 12:51:58.668368 kernel: Detected PIPT I-cache on CPU2 Nov 4 12:51:58.668375 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 4 12:51:58.668382 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Nov 4 12:51:58.668387 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:51:58.668393 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 4 12:51:58.668399 kernel: Detected PIPT I-cache on CPU3 Nov 4 12:51:58.668408 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 4 12:51:58.668415 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Nov 4 12:51:58.668422 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 4 12:51:58.668427 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 4 12:51:58.668434 kernel: smp: Brought up 1 node, 4 CPUs Nov 4 12:51:58.668439 kernel: SMP: Total of 4 processors activated. Nov 4 12:51:58.668445 kernel: CPU features: detected: Privileged Access Never Nov 4 12:51:58.668452 kernel: CPU features: detected: LSE atomic instructions Nov 4 12:51:58.668457 kernel: CPU features: detected: User Access Override Nov 4 12:51:58.668463 kernel: CPU features: detected: 32-bit EL0 Support Nov 4 12:51:58.668469 kernel: CPU features: detected: Common not Private translations Nov 4 12:51:58.668475 kernel: CPU features: detected: RAS Extension Support Nov 4 12:51:58.668482 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 4 12:51:58.668489 kernel: CPU features: detected: CRC32 instructions Nov 4 12:51:58.668495 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 4 12:51:58.668500 kernel: CPU: All CPU(s) started at EL1 Nov 4 12:51:58.668506 kernel: alternatives: patching kernel code Nov 4 12:51:58.668513 kernel: devtmpfs: initialized Nov 4 12:51:58.668519 kernel: KASLR enabled Nov 4 12:51:58.668526 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 4 12:51:58.668532 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 4 12:51:58.668538 kernel: pinctrl core: initialized pinctrl subsystem Nov 4 12:51:58.668544 kernel: SMBIOS 3.0.0 present. Nov 4 12:51:58.668550 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Nov 4 12:51:58.668556 kernel: NET: Registered protocol family 16 Nov 4 12:51:58.668562 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 4 12:51:58.668568 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 4 12:51:58.668576 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 4 12:51:58.668582 kernel: audit: initializing netlink subsys (disabled) Nov 4 12:51:58.668588 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Nov 4 12:51:58.668594 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 4 12:51:58.668600 kernel: cpuidle: using governor menu Nov 4 12:51:58.668606 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 4 12:51:58.668612 kernel: ASID allocator initialised with 32768 entries Nov 4 12:51:58.668618 kernel: ACPI: bus type PCI registered Nov 4 12:51:58.668624 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 4 12:51:58.668631 kernel: Serial: AMBA PL011 UART driver Nov 4 12:51:58.668637 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 4 12:51:58.668643 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 4 12:51:58.668650 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 4 12:51:58.668656 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 4 12:51:58.668661 kernel: cryptd: max_cpu_qlen set to 1000 Nov 4 12:51:58.668667 kernel: ACPI: Added _OSI(Module Device) Nov 4 12:51:58.668673 kernel: ACPI: Added _OSI(Processor Device) Nov 4 12:51:58.668685 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 4 12:51:58.668691 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 4 12:51:58.668699 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 4 12:51:58.668705 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 4 12:51:58.668711 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 4 12:51:58.668717 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 4 12:51:58.668723 kernel: ACPI: Interpreter enabled Nov 4 12:51:58.668730 kernel: ACPI: Using GIC for interrupt routing Nov 4 12:51:58.668736 kernel: ACPI: MCFG table detected, 1 entries Nov 4 12:51:58.668742 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 4 12:51:58.668757 kernel: printk: console [ttyAMA0] enabled Nov 4 12:51:58.668765 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 4 12:51:58.668890 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 4 12:51:58.668948 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 4 12:51:58.669001 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 4 12:51:58.669052 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 4 12:51:58.669103 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 4 12:51:58.669111 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 4 12:51:58.669119 kernel: PCI host bridge to bus 0000:00 Nov 4 12:51:58.669177 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 4 12:51:58.669225 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 4 12:51:58.669273 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 4 12:51:58.669319 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 4 12:51:58.669383 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 4 12:51:58.669445 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 4 12:51:58.669501 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 4 12:51:58.669556 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 4 12:51:58.669610 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:51:58.669665 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 4 12:51:58.669729 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 4 12:51:58.669787 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 4 12:51:58.669846 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 4 12:51:58.669902 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 4 12:51:58.669950 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 4 12:51:58.669958 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Nov 4 12:51:58.669964 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Nov 4 12:51:58.669970 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Nov 4 12:51:58.669977 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Nov 4 12:51:58.669983 kernel: vgaarb: loaded Nov 4 12:51:58.669988 kernel: Registered efivars operations Nov 4 12:51:58.669995 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 4 12:51:58.670002 kernel: VFS: Disk quotas dquot_6.6.0 Nov 4 12:51:58.670008 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 4 12:51:58.670014 kernel: pnp: PnP ACPI init Nov 4 12:51:58.670134 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 4 12:51:58.670189 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Nov 4 12:51:58.670197 kernel: pnp: PnP ACPI: found 1 devices Nov 4 12:51:58.670203 kernel: NET: Registered protocol family 2 Nov 4 12:51:58.670209 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 4 12:51:58.670218 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 4 12:51:58.670225 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 4 12:51:58.670231 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 4 12:51:58.670237 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 4 12:51:58.670243 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:51:58.670250 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 4 12:51:58.670256 kernel: NET: Registered protocol family 1 Nov 4 12:51:58.670262 kernel: PCI: CLS 0 bytes, default 64 Nov 4 12:51:58.670268 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 4 12:51:58.670275 kernel: kvm [1]: HYP mode not available Nov 4 12:51:58.670281 kernel: Initialise system trusted keyrings Nov 4 12:51:58.670287 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 4 12:51:58.670293 kernel: Key type asymmetric registered Nov 4 12:51:58.670299 kernel: Asymmetric key parser 'x509' registered Nov 4 12:51:58.670305 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 4 12:51:58.670311 kernel: io scheduler mq-deadline registered Nov 4 12:51:58.670317 kernel: io scheduler kyber registered Nov 4 12:51:58.670323 kernel: io scheduler bfq registered Nov 4 12:51:58.670331 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 4 12:51:58.670337 kernel: ACPI: Power Button [PWRB] Nov 4 12:51:58.670343 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Nov 4 12:51:58.670398 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 4 12:51:58.670406 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 4 12:51:58.670413 kernel: msm_serial: driver initialized Nov 4 12:51:58.670419 kernel: random: fast init done Nov 4 12:51:58.670425 kernel: random: crng init done Nov 4 12:51:58.670431 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Nov 4 12:51:58.670437 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Nov 4 12:51:58.670444 kernel: thunder_xcv, ver 1.0 Nov 4 12:51:58.670450 kernel: thunder_bgx, ver 1.0 Nov 4 12:51:58.670456 kernel: nicpf, ver 1.0 Nov 4 12:51:58.670462 kernel: nicvf, ver 1.0 Nov 4 12:51:58.670523 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 4 12:51:58.670573 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-04T12:51:58 UTC (1762260718) Nov 4 12:51:58.670581 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 4 12:51:58.670587 kernel: NET: Registered protocol family 10 Nov 4 12:51:58.670595 kernel: Segment Routing with IPv6 Nov 4 12:51:58.670601 kernel: NET: Registered protocol family 17 Nov 4 12:51:58.670607 kernel: Key type dns_resolver registered Nov 4 12:51:58.670613 kernel: registered taskstats version 1 Nov 4 12:51:58.670619 kernel: Loading compiled-in X.509 certificates Nov 4 12:51:58.670625 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Nov 4 12:51:58.670631 kernel: Key type ._fscrypt registered Nov 4 12:51:58.670637 kernel: Key type .fscrypt registered Nov 4 12:51:58.670643 kernel: Key type fscrypt-provisioning registered Nov 4 12:51:58.670650 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 4 12:51:58.670656 kernel: ima: Allocated hash algorithm: sha1 Nov 4 12:51:58.670662 kernel: ima: No architecture policies found Nov 4 12:51:58.670668 kernel: Freeing unused kernel memory: 34240K Nov 4 12:51:58.670680 kernel: Run /init as init process Nov 4 12:51:58.670687 kernel: with arguments: Nov 4 12:51:58.670693 kernel: /init Nov 4 12:51:58.670699 kernel: with environment: Nov 4 12:51:58.670705 kernel: HOME=/ Nov 4 12:51:58.670711 kernel: TERM=linux Nov 4 12:51:58.670718 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 4 12:51:58.670726 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:51:58.670734 systemd[1]: Detected virtualization kvm. Nov 4 12:51:58.670741 systemd[1]: Detected architecture arm64. Nov 4 12:51:58.670747 systemd[1]: Running in initial RAM disk. Nov 4 12:51:58.670753 systemd[1]: No hostname configured, using default hostname. Nov 4 12:51:58.670760 systemd[1]: Hostname set to . Nov 4 12:51:58.670766 systemd[1]: Initializing machine ID from VM UUID. Nov 4 12:51:58.670774 systemd[1]: Queued start job for default target Initrd Default Target. Nov 4 12:51:58.670780 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:51:58.670787 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:51:58.670793 systemd[1]: Reached target Path Units. Nov 4 12:51:58.670799 systemd[1]: Reached target Slice Units. Nov 4 12:51:58.670806 systemd[1]: Reached target Swaps. Nov 4 12:51:58.670812 systemd[1]: Reached target Timer Units. Nov 4 12:51:58.670819 systemd[1]: Listening on Open-iSCSI iscsid Socket. Nov 4 12:51:58.670834 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Nov 4 12:51:58.670841 systemd[1]: Listening on Journal Audit Socket. Nov 4 12:51:58.670847 systemd[1]: Listening on Journal Socket (/dev/log). Nov 4 12:51:58.670854 systemd[1]: Listening on Journal Socket. Nov 4 12:51:58.670860 systemd[1]: Listening on udev Control Socket. Nov 4 12:51:58.670867 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:51:58.670873 systemd[1]: Reached target Socket Units. Nov 4 12:51:58.670879 systemd[1]: Starting iSCSI UserSpace I/O driver... Nov 4 12:51:58.670887 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:51:58.670894 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Nov 4 12:51:58.670900 systemd[1]: Starting Journal Service... Nov 4 12:51:58.670907 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:51:58.670913 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:51:58.670920 systemd[1]: Starting Setup Virtual Console... Nov 4 12:51:58.670926 systemd[1]: Started iSCSI UserSpace I/O driver. Nov 4 12:51:58.670933 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:51:58.670939 systemd[1]: Finished Setup Virtual Console. Nov 4 12:51:58.670945 kernel: SCSI subsystem initialized Nov 4 12:51:58.670953 systemd[1]: Starting dracut ask for additional cmdline parameters... Nov 4 12:51:58.670961 systemd-journald[269]: Journal started Nov 4 12:51:58.670999 systemd-journald[269]: Runtime Journal (/run/log/journal/6b1eeb5eb2f04818b9364d71eab7e479) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:51:58.673848 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:51:58.673874 kernel: Loading iSCSI transport class v2.0-870. Nov 4 12:51:58.675968 systemd[1]: Started Journal Service. Nov 4 12:51:58.676342 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:51:58.677226 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:51:58.686621 systemd[1]: Finished dracut ask for additional cmdline parameters. Nov 4 12:51:58.688243 systemd[1]: Starting dracut cmdline hook... Nov 4 12:51:58.696554 dracut-cmdline[292]: dracut-dracut-053 Nov 4 12:51:58.698686 dracut-cmdline[292]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 acpi=force verity.usrhash=add5f6239860d533a5bdd88b1ecacfa095fc20febf51ab00ef758dd688c5dc20 Nov 4 12:51:58.752852 kernel: iscsi: registered transport (tcp) Nov 4 12:51:58.762846 kernel: iscsi: registered transport (qla4xxx) Nov 4 12:51:58.762865 kernel: QLogic iSCSI HBA Driver Nov 4 12:51:58.772505 systemd[1]: Finished dracut cmdline hook. Nov 4 12:51:58.773905 systemd[1]: Starting dracut pre-udev hook... Nov 4 12:51:58.775064 systemd[1]: Starting Open-iSCSI... Nov 4 12:51:58.777214 iscsid[377]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:51:58.777214 iscsid[377]: 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:51:58.777214 iscsid[377]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 4 12:51:58.777214 iscsid[377]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 4 12:51:58.777214 iscsid[377]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 4 12:51:58.777214 iscsid[377]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 4 12:51:58.780720 systemd[1]: Started Open-iSCSI. Nov 4 12:51:58.789926 kernel: device-mapper: uevent: version 1.0.3 Nov 4 12:51:58.789941 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Nov 4 12:51:58.823847 kernel: raid6: neonx8 gen() 13751 MB/s Nov 4 12:51:58.840845 kernel: raid6: neonx8 xor() 10735 MB/s Nov 4 12:51:58.857839 kernel: raid6: neonx4 gen() 13552 MB/s Nov 4 12:51:58.874839 kernel: raid6: neonx4 xor() 11540 MB/s Nov 4 12:51:58.891849 kernel: raid6: neonx2 gen() 12924 MB/s Nov 4 12:51:58.908839 kernel: raid6: neonx2 xor() 9848 MB/s Nov 4 12:51:58.925839 kernel: raid6: neonx1 gen() 10659 MB/s Nov 4 12:51:58.942846 kernel: raid6: neonx1 xor() 8828 MB/s Nov 4 12:51:58.959844 kernel: raid6: int64x8 gen() 6808 MB/s Nov 4 12:51:58.976848 kernel: raid6: int64x8 xor() 3784 MB/s Nov 4 12:51:58.993840 kernel: raid6: int64x4 gen() 6890 MB/s Nov 4 12:51:59.010845 kernel: raid6: int64x4 xor() 3818 MB/s Nov 4 12:51:59.027846 kernel: raid6: int64x2 gen() 6171 MB/s Nov 4 12:51:59.044844 kernel: raid6: int64x2 xor() 3304 MB/s Nov 4 12:51:59.061846 kernel: raid6: int64x1 gen() 4996 MB/s Nov 4 12:51:59.079406 kernel: raid6: int64x1 xor() 2592 MB/s Nov 4 12:51:59.079427 kernel: raid6: using algorithm neonx8 gen() 13751 MB/s Nov 4 12:51:59.079436 kernel: raid6: .... xor() 10735 MB/s, rmw enabled Nov 4 12:51:59.079443 kernel: raid6: using neon recovery algorithm Nov 4 12:51:59.090016 kernel: xor: measuring software checksum speed Nov 4 12:51:59.090030 kernel: 8regs : 17170 MB/sec Nov 4 12:51:59.090960 kernel: 32regs : 20755 MB/sec Nov 4 12:51:59.092376 kernel: arm64_neon : 29029 MB/sec Nov 4 12:51:59.092397 kernel: xor: using function: arm64_neon (29029 MB/sec) Nov 4 12:51:59.135850 kernel: Btrfs loaded, crc32c=crc32c-generic Nov 4 12:51:59.145640 systemd[1]: Finished dracut pre-udev hook. Nov 4 12:51:59.149191 kernel: audit: type=1334 audit(1762260719.146:2): prog-id=6 op=LOAD Nov 4 12:51:59.149209 kernel: audit: type=1334 audit(1762260719.146:3): prog-id=7 op=LOAD Nov 4 12:51:59.149219 kernel: audit: type=1334 audit(1762260719.147:4): prog-id=8 op=LOAD Nov 4 12:51:59.146000 audit: BPF prog-id=6 op=LOAD Nov 4 12:51:59.146000 audit: BPF prog-id=7 op=LOAD Nov 4 12:51:59.147000 audit: BPF prog-id=8 op=LOAD Nov 4 12:51:59.148759 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:51:59.159898 systemd-udevd[411]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:51:59.162269 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:51:59.163835 systemd[1]: Starting dracut pre-trigger hook... Nov 4 12:51:59.175271 dracut-pre-trigger[420]: rd.md=0: removing MD RAID activation Nov 4 12:51:59.197595 systemd[1]: Finished dracut pre-trigger hook. Nov 4 12:51:59.198942 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:51:59.207938 systemd-udevd[411]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 4 12:51:59.225426 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:51:59.226774 systemd[1]: Starting dracut initqueue hook... Nov 4 12:51:59.242890 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 4 12:51:59.243033 kernel: vda: detected capacity change from 0 to 4756340736 Nov 4 12:51:59.252838 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 4 12:51:59.253466 systemd-udevd[459]: Using default interface naming scheme 'v249'. Nov 4 12:51:59.269340 systemd[1]: Found device /dev/disk/by-label/ROOT. Nov 4 12:51:59.270984 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (469) Nov 4 12:51:59.274642 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Nov 4 12:51:59.275512 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Nov 4 12:51:59.280831 systemd[1]: Reached target Initrd Root Device. Nov 4 12:51:59.282181 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Nov 4 12:51:59.284885 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 4 12:51:59.284987 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Nov 4 12:51:59.286642 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:51:59.288796 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Nov 4 12:51:59.291144 systemd[1]: Finished dracut initqueue hook. Nov 4 12:51:59.292231 systemd[1]: Reached target Preparation for Remote File Systems. Nov 4 12:51:59.293661 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:51:59.295341 systemd[1]: Reached target Remote File Systems. Nov 4 12:51:59.296689 systemd[1]: Starting dracut pre-mount hook... Nov 4 12:51:59.301859 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 4 12:51:59.305064 systemd[1]: Finished dracut pre-mount hook. Nov 4 12:51:59.306477 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Nov 4 12:51:59.314942 systemd-fsck[507]: ROOT: clean, 640/553792 files, 39961/553472 blocks Nov 4 12:51:59.316583 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Nov 4 12:51:59.318371 systemd[1]: Mounting /sysroot... Nov 4 12:51:59.326426 systemd[1]: Found device /dev/mapper/usr. Nov 4 12:51:59.327849 systemd[1]: Starting File System Check on /dev/mapper/usr... Nov 4 12:51:59.332415 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Nov 4 12:51:59.338169 systemd-fsck[516]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Nov 4 12:51:59.338169 systemd-fsck[516]: You must have r/w access to the filesystem or be root Nov 4 12:51:59.341592 systemd-fsck[512]: fsck failed with exit status 8. Nov 4 12:51:59.341598 systemd-fsck[512]: Ignoring error. Nov 4 12:51:59.342467 systemd[1]: Finished File System Check on /dev/mapper/usr. Nov 4 12:51:59.344904 systemd[1]: Mounting /sysusr/usr... Nov 4 12:51:59.357055 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Nov 4 12:51:59.357084 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Nov 4 12:51:59.357472 systemd[1]: Mounted /sysroot. Nov 4 12:51:59.358158 systemd[1]: Reached target Initrd Root File System. Nov 4 12:51:59.359775 systemd[1]: Starting Reload Configuration from the Real Root... Nov 4 12:51:59.363767 systemd[1]: Reloading. Nov 4 12:51:59.365000 audit: BPF prog-id=3 op=UNLOAD Nov 4 12:51:59.369291 kernel: audit: type=1334 audit(1762260719.365:5): prog-id=3 op=UNLOAD Nov 4 12:51:59.369320 kernel: audit: type=1334 audit(1762260719.367:6): prog-id=6 op=UNLOAD Nov 4 12:51:59.367000 audit: BPF prog-id=6 op=UNLOAD Nov 4 12:51:59.373937 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Nov 4 12:51:59.446000 audit: BPF prog-id=9 op=LOAD Nov 4 12:51:59.447000 audit: BPF prog-id=10 op=LOAD Nov 4 12:51:59.448913 kernel: audit: type=1334 audit(1762260719.446:7): prog-id=9 op=LOAD Nov 4 12:51:59.448933 kernel: audit: type=1334 audit(1762260719.447:8): prog-id=10 op=LOAD Nov 4 12:51:59.448000 audit: BPF prog-id=11 op=LOAD Nov 4 12:51:59.448000 audit: BPF prog-id=4 op=UNLOAD Nov 4 12:51:59.450473 kernel: audit: type=1334 audit(1762260719.448:9): prog-id=11 op=LOAD Nov 4 12:51:59.450489 kernel: audit: type=1334 audit(1762260719.448:10): prog-id=4 op=UNLOAD Nov 4 12:51:59.448000 audit: BPF prog-id=5 op=UNLOAD Nov 4 12:51:59.448000 audit: BPF prog-id=12 op=LOAD Nov 4 12:51:59.449000 audit: BPF prog-id=13 op=LOAD Nov 4 12:51:59.449000 audit: BPF prog-id=14 op=LOAD Nov 4 12:51:59.449000 audit: BPF prog-id=7 op=UNLOAD Nov 4 12:51:59.449000 audit: BPF prog-id=8 op=UNLOAD Nov 4 12:51:59.452062 systemd[1]: Mounted /sysusr/usr. Nov 4 12:51:59.454604 systemd[1]: Reached target Local File Systems. Nov 4 12:51:59.456168 systemd[1]: Reached target System Initialization. Nov 4 12:51:59.457643 systemd[1]: Reached target Basic System. Nov 4 12:51:59.459249 systemd[1]: Mounting /sysroot/usr... Nov 4 12:51:59.461522 systemd[1]: Mounted /sysroot/usr. Nov 4 12:51:59.470295 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 4 12:51:59.470418 systemd[1]: Finished Reload Configuration from the Real Root. Nov 4 12:51:59.472156 systemd[1]: Reached target Initrd File Systems. Nov 4 12:51:59.473513 systemd[1]: Reached target Initrd Default Target. Nov 4 12:51:59.474836 systemd[1]: Condition check resulted in dracut mount hook being skipped. Nov 4 12:51:59.475438 systemd[1]: Starting dracut pre-pivot and cleanup hook... Nov 4 12:51:59.485180 systemd[1]: Finished dracut pre-pivot and cleanup hook. Nov 4 12:51:59.486628 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Nov 4 12:51:59.491873 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 4 12:51:59.492736 systemd[1]: Stopped target Timer Units. Nov 4 12:51:59.494037 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 4 12:51:59.494135 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Nov 4 12:51:59.495406 systemd[1]: Stopped target Initrd Default Target. Nov 4 12:51:59.496764 systemd[1]: Stopped target Basic System. Nov 4 12:51:59.498071 systemd[1]: Stopped target Initrd Root Device. Nov 4 12:51:59.499359 systemd[1]: Stopped target Path Units. Nov 4 12:51:59.500552 systemd[1]: Stopped target Remote File Systems. Nov 4 12:51:59.501856 systemd[1]: Stopped target Preparation for Remote File Systems. Nov 4 12:51:59.503230 systemd[1]: Stopped target Slice Units. Nov 4 12:51:59.504503 systemd[1]: Stopped target Socket Units. Nov 4 12:51:59.505919 systemd[1]: Stopped target System Initialization. Nov 4 12:51:59.507182 systemd[1]: Stopped target Local File Systems. Nov 4 12:51:59.508396 systemd[1]: Stopped target Preparation for Local File Systems. Nov 4 12:51:59.509807 systemd[1]: Stopped target Swaps. Nov 4 12:51:59.510946 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 4 12:51:59.511044 systemd[1]: Stopped dracut pre-mount hook. Nov 4 12:51:59.512386 systemd[1]: Stopped target Local Encrypted Volumes. Nov 4 12:51:59.513554 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 4 12:51:59.514871 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 4 12:51:59.520837 iscsid[377]: iscsid shutting down. Nov 4 12:51:59.515892 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 4 12:51:59.515985 systemd[1]: Stopped dracut initqueue hook. Nov 4 12:51:59.517367 systemd[1]: Stopping Open-iSCSI... Nov 4 12:51:59.520002 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 4 12:51:59.520114 systemd[1]: Stopped Apply Kernel Variables. Nov 4 12:51:59.521602 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 4 12:51:59.521695 systemd[1]: Stopped Coldplug All udev Devices. Nov 4 12:51:59.522799 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 4 12:51:59.522903 systemd[1]: Stopped dracut pre-trigger hook. Nov 4 12:51:59.524488 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Nov 4 12:51:59.530165 systemd[1]: iscsid.service: Deactivated successfully. Nov 4 12:51:59.530262 systemd[1]: Stopped Open-iSCSI. Nov 4 12:51:59.531556 systemd[1]: iscsid.socket: Deactivated successfully. Nov 4 12:51:59.531599 systemd[1]: Closed Open-iSCSI iscsid Socket. Nov 4 12:51:59.533418 systemd[1]: Stopping iSCSI UserSpace I/O driver... Nov 4 12:51:59.536643 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 4 12:51:59.536759 systemd[1]: Stopped iSCSI UserSpace I/O driver. Nov 4 12:51:59.537958 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 4 12:51:59.538072 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Nov 4 12:51:59.539919 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 4 12:51:59.540017 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Nov 4 12:51:59.541910 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 4 12:51:59.541960 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Nov 4 12:51:59.554000 audit: BPF prog-id=12 op=UNLOAD Nov 4 12:51:59.543346 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 4 12:51:59.543383 systemd[1]: Closed udev Control Socket. Nov 4 12:51:59.544493 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 4 12:51:59.544522 systemd[1]: Closed udev Kernel Socket. Nov 4 12:51:59.545688 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 4 12:51:59.545729 systemd[1]: Stopped dracut pre-udev hook. Nov 4 12:51:59.547020 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 4 12:51:59.547058 systemd[1]: Stopped dracut cmdline hook. Nov 4 12:51:59.548263 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 4 12:51:59.548300 systemd[1]: Stopped dracut ask for additional cmdline parameters. Nov 4 12:51:59.550358 systemd[1]: Starting Cleanup udev Database... Nov 4 12:51:59.551327 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Nov 4 12:51:59.567000 audit: BPF prog-id=9 op=UNLOAD Nov 4 12:51:59.552655 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 4 12:51:59.552721 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 4 12:51:59.554225 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 4 12:51:59.554268 systemd[1]: Stopped Create List of Static Device Nodes. Nov 4 12:51:59.555716 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 4 12:51:59.555757 systemd[1]: Stopped Setup Virtual Console. Nov 4 12:51:59.557168 systemd[1]: rngd.service: Deactivated successfully. Nov 4 12:51:59.557273 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Nov 4 12:51:59.558742 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 4 12:51:59.558913 systemd[1]: Finished Cleanup udev Database. Nov 4 12:51:59.559949 systemd[1]: Reached target Switch Root. Nov 4 12:51:59.561879 systemd[1]: Starting Switch Root... Nov 4 12:51:59.566981 systemd[1]: Switching root. Nov 4 12:51:59.584032 systemd-journald[269]: Journal stopped Nov 4 12:52:01.611764 systemd-journald[269]: Received SIGTERM from PID 1 (systemd). Nov 4 12:52:01.611810 kernel: SELinux: policy capability network_peer_controls=1 Nov 4 12:52:01.611857 kernel: SELinux: policy capability open_perms=1 Nov 4 12:52:01.611868 kernel: SELinux: policy capability extended_socket_class=1 Nov 4 12:52:01.611882 kernel: SELinux: policy capability always_check_network=0 Nov 4 12:52:01.611893 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 4 12:52:01.611902 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 4 12:52:01.611911 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 4 12:52:01.611923 systemd[1]: Successfully loaded SELinux policy in 30.833ms. Nov 4 12:52:01.611936 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6ms. Nov 4 12:52:01.611951 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:52:01.611962 systemd[1]: Detected virtualization kvm. Nov 4 12:52:01.611976 systemd[1]: Detected architecture arm64. Nov 4 12:52:01.611989 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:52:01.612001 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:52:01.612012 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 4 12:52:01.612028 systemd[1]: Stopped Switch Root. Nov 4 12:52:01.612042 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 4 12:52:01.612052 systemd[1]: Created slice Slice /system/addon-config. Nov 4 12:52:01.612062 systemd[1]: Created slice Slice /system/addon-run. Nov 4 12:52:01.612072 systemd[1]: Created slice Slice /system/getty. Nov 4 12:52:01.612083 systemd[1]: Created slice Slice /system/modprobe. Nov 4 12:52:01.612092 systemd[1]: Created slice Slice /system/serial-getty. Nov 4 12:52:01.612102 systemd[1]: Created slice Slice /system/system-cloudinit. Nov 4 12:52:01.612111 systemd[1]: Created slice Slice /system/systemd-fsck. Nov 4 12:52:01.612121 systemd[1]: Created slice User and Session Slice. Nov 4 12:52:01.612150 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 4 12:52:01.612161 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Nov 4 12:52:01.612172 systemd[1]: Set up automount Boot partition Automount Point. Nov 4 12:52:01.612182 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 4 12:52:01.612193 systemd[1]: Stopped target Switch Root. Nov 4 12:52:01.612203 systemd[1]: Stopped target Initrd File Systems. Nov 4 12:52:01.612213 systemd[1]: Stopped target Initrd Root File System. Nov 4 12:52:01.612224 systemd[1]: Reached target Remote Encrypted Volumes. Nov 4 12:52:01.612234 systemd[1]: Reached target Remote File Systems. Nov 4 12:52:01.612243 systemd[1]: Reached target Slice Units. Nov 4 12:52:01.612254 systemd[1]: Reached target Swaps. Nov 4 12:52:01.612264 systemd[1]: Reached target Verify torcx succeeded. Nov 4 12:52:01.612273 systemd[1]: Reached target Local Verity Protected Volumes. Nov 4 12:52:01.612283 systemd[1]: Listening on Process Core Dump Socket. Nov 4 12:52:01.612294 systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 4 12:52:01.612303 systemd[1]: Listening on Network Service Netlink Socket. Nov 4 12:52:01.612312 systemd[1]: Listening on udev Control Socket. Nov 4 12:52:01.612322 systemd[1]: Listening on udev Kernel Socket. Nov 4 12:52:01.612332 systemd[1]: Mounting Huge Pages File System... Nov 4 12:52:01.612342 systemd[1]: Mounting POSIX Message Queue File System... Nov 4 12:52:01.612351 systemd[1]: Mounting External Media Directory... Nov 4 12:52:01.612361 systemd[1]: Mounting Kernel Debug File System... Nov 4 12:52:01.612370 systemd[1]: Mounting Kernel Trace File System... Nov 4 12:52:01.612381 systemd[1]: Mounting Temporary Directory /tmp... Nov 4 12:52:01.612390 systemd[1]: Starting Create missing system files... Nov 4 12:52:01.612400 systemd[1]: Starting Create List of Static Device Nodes... Nov 4 12:52:01.612409 systemd[1]: Starting Load Kernel Module configfs... Nov 4 12:52:01.612418 systemd[1]: Starting Load Kernel Module drm... Nov 4 12:52:01.612428 systemd[1]: Starting Load Kernel Module fuse... Nov 4 12:52:01.612437 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Nov 4 12:52:01.612447 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 4 12:52:01.612456 systemd[1]: Stopped File System Check on Root Device. Nov 4 12:52:01.612466 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 4 12:52:01.612477 systemd[1]: Stopped systemd-fsck-usr.service. Nov 4 12:52:01.612486 systemd[1]: Stopped Journal Service. Nov 4 12:52:01.612496 kernel: fuse: init (API version 7.32) Nov 4 12:52:01.612505 systemd[1]: Starting Journal Service... Nov 4 12:52:01.612514 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 4 12:52:01.612524 systemd[1]: Starting Remount Root and Kernel File Systems... Nov 4 12:52:01.612536 systemd[1]: Starting Apply Kernel Variables... Nov 4 12:52:01.612546 systemd[1]: Starting Coldplug All udev Devices... Nov 4 12:52:01.612556 systemd[1]: verity-setup.service: Deactivated successfully. Nov 4 12:52:01.612565 systemd[1]: Stopped verity-setup.service. Nov 4 12:52:01.612577 systemd-journald[694]: Journal started Nov 4 12:52:01.612613 systemd-journald[694]: Runtime Journal (/run/log/journal/6b1eeb5eb2f04818b9364d71eab7e479) is 6.0M, max 48.5M, 42.4M free. Nov 4 12:51:59.653000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 4 12:51:59.677000 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:51:59.677000 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:51:59.677000 audit: BPF prog-id=15 op=LOAD Nov 4 12:51:59.677000 audit: BPF prog-id=15 op=UNLOAD Nov 4 12:51:59.677000 audit: BPF prog-id=16 op=LOAD Nov 4 12:51:59.677000 audit: BPF prog-id=16 op=UNLOAD Nov 4 12:51:59.710000 audit[646]: AVC avc: denied { associate } for pid=646 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:52:01.507000 audit: BPF prog-id=17 op=LOAD Nov 4 12:52:01.507000 audit: BPF prog-id=18 op=LOAD Nov 4 12:52:01.507000 audit: BPF prog-id=19 op=LOAD Nov 4 12:52:01.507000 audit: BPF prog-id=10 op=UNLOAD Nov 4 12:52:01.507000 audit: BPF prog-id=11 op=UNLOAD Nov 4 12:52:01.522000 audit: BPF prog-id=17 op=UNLOAD Nov 4 12:52:01.598000 audit: BPF prog-id=20 op=LOAD Nov 4 12:52:01.598000 audit: BPF prog-id=21 op=LOAD Nov 4 12:52:01.598000 audit: BPF prog-id=22 op=LOAD Nov 4 12:52:01.598000 audit: BPF prog-id=18 op=UNLOAD Nov 4 12:52:01.598000 audit: BPF prog-id=19 op=UNLOAD Nov 4 12:52:01.610000 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:52:01.493071 systemd[1]: Queued start job for default target Multi-User System. Nov 4 12:51:59.709414 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" 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:52:01.508818 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 4 12:51:59.709648 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:51:59.709686 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:51:59.709971 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 4 12:51:59.709983 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 4 12:51:59.710014 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 4 12:51:59.710027 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 4 12:51:59.710329 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 4 12:51:59.710365 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 4 12:51:59.710388 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 4 12:51:59.710746 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" 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:51:59.710776 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" 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:51:59.710796 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" 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:51:59.710811 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" 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:51:59.710936 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" 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:51:59.710953 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:51:59Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 4 12:52:01.408652 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:52:01Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 4 12:52:01.408945 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:52:01Z" 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:52:01.614256 systemd[1]: Started Journal Service. Nov 4 12:52:01.409047 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:52:01Z" 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:52:01.409168 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:52:01Z" 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:52:01.409262 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:52:01Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 4 12:52:01.409324 /usr/lib/systemd/system-generators/torcx-generator[646]: time="2025-11-04T12:52:01Z" 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:52:01.614703 systemd[1]: Mounted Huge Pages File System. Nov 4 12:52:01.615560 systemd[1]: Mounted POSIX Message Queue File System. Nov 4 12:52:01.616483 systemd[1]: Mounted External Media Directory. Nov 4 12:52:01.617347 systemd[1]: Mounted Kernel Debug File System. Nov 4 12:52:01.618212 systemd[1]: Mounted Kernel Trace File System. Nov 4 12:52:01.619031 systemd[1]: Mounted Temporary Directory /tmp. Nov 4 12:52:01.620052 systemd[1]: Finished Create missing system files. Nov 4 12:52:01.621100 systemd[1]: Finished Create List of Static Device Nodes. Nov 4 12:52:01.622137 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 4 12:52:01.622306 systemd[1]: Finished Load Kernel Module configfs. Nov 4 12:52:01.623280 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 4 12:52:01.623442 systemd[1]: Finished Load Kernel Module drm. Nov 4 12:52:01.624371 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 4 12:52:01.624536 systemd[1]: Finished Load Kernel Module fuse. Nov 4 12:52:01.625554 systemd[1]: Finished Remount Root and Kernel File Systems. Nov 4 12:52:01.626718 systemd[1]: Finished Apply Kernel Variables. Nov 4 12:52:01.637760 systemd[1]: Mounting FUSE Control File System... Nov 4 12:52:01.639441 systemd[1]: Mounting Kernel Configuration File System... Nov 4 12:52:01.640231 systemd[1]: Condition check resulted in Remount Root File System being skipped. Nov 4 12:52:01.641129 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Nov 4 12:52:01.642024 systemd[1]: Starting Flush Journal to Persistent Storage... Nov 4 12:52:01.643022 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Nov 4 12:52:01.644014 systemd[1]: Starting Load/Save Random Seed... Nov 4 12:52:01.644822 systemd[1]: Condition check resulted in Create System Users being skipped. Nov 4 12:52:01.646223 systemd-journald[694]: Time spent on flushing to /var/log/journal/6b1eeb5eb2f04818b9364d71eab7e479 is 10.626ms for 655 entries. Nov 4 12:52:01.646223 systemd-journald[694]: System Journal (/var/log/journal/6b1eeb5eb2f04818b9364d71eab7e479) is 8.0M, max 203.0M, 195.0M free. Nov 4 12:52:01.645791 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 4 12:52:01.648969 systemd[1]: Mounted FUSE Control File System. Nov 4 12:52:01.650067 systemd[1]: Mounted Kernel Configuration File System. Nov 4 12:52:01.652444 systemd[1]: Finished Load/Save Random Seed. Nov 4 12:52:01.653426 systemd[1]: Condition check resulted in First Boot Complete being skipped. Nov 4 12:52:01.669157 systemd[1]: Finished Coldplug All udev Devices. Nov 4 12:52:01.670232 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 4 12:52:01.672225 systemd[1]: Starting Wait for udev To Complete Device Initialization... Nov 4 12:52:01.673000 audit: BPF prog-id=23 op=LOAD Nov 4 12:52:01.673000 audit: BPF prog-id=24 op=LOAD Nov 4 12:52:01.673000 audit: BPF prog-id=25 op=LOAD Nov 4 12:52:01.673000 audit: BPF prog-id=13 op=UNLOAD Nov 4 12:52:01.673000 audit: BPF prog-id=14 op=UNLOAD Nov 4 12:52:01.674435 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 4 12:52:01.675953 systemd[1]: Finished Flush Journal to Persistent Storage. Nov 4 12:52:01.697226 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 4 12:52:01.698000 audit: BPF prog-id=26 op=LOAD Nov 4 12:52:01.700358 systemd[1]: Starting Network Configuration... Nov 4 12:52:01.727880 systemd-networkd[717]: lo: Link UP Nov 4 12:52:01.727891 systemd-networkd[717]: lo: Gained carrier Nov 4 12:52:01.728191 systemd-networkd[717]: Enumeration completed Nov 4 12:52:01.728265 systemd[1]: Started Network Configuration. Nov 4 12:52:01.735600 systemd-udevd[714]: Using default interface naming scheme 'v249'. Nov 4 12:52:01.752543 systemd-networkd[717]: eth0: Link UP Nov 4 12:52:01.755896 systemd-networkd[717]: eth0: Gained carrier Nov 4 12:52:01.762960 systemd-networkd[717]: eth0: DHCPv4 address 10.0.0.7/16 via 10.0.0.1 Nov 4 12:52:01.769083 udevadm[707]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Nov 4 12:52:01.798878 systemd[1]: Finished Wait for udev To Complete Device Initialization. Nov 4 12:52:01.818405 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:52:01.827440 lvm[735]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:52:01.850732 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:52:01.851726 systemd[1]: Reached target Local Encrypted Volumes. Nov 4 12:52:01.867940 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 4 12:52:01.871030 lvm[736]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 4 12:52:01.908459 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 4 12:52:01.909900 systemd[1]: Reached target Preparation for Local File Systems. Nov 4 12:52:01.911024 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Nov 4 12:52:01.911050 systemd[1]: Reached target Containers. Nov 4 12:52:01.924259 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Nov 4 12:52:01.936987 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Nov 4 12:52:01.938892 systemd[1]: Mounting /usr/share/oem... Nov 4 12:52:01.945155 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 4 12:52:01.945272 kernel: BTRFS info (device vda6): has skinny extents Nov 4 12:52:01.947283 systemd[1]: Mounted /usr/share/oem. Nov 4 12:52:01.948020 systemd[1]: Reached target Local File Systems. Nov 4 12:52:01.948823 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Nov 4 12:52:01.949160 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 4 12:52:01.949195 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Nov 4 12:52:01.949221 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Nov 4 12:52:01.950055 systemd[1]: Starting Create Volatile Files and Directories... Nov 4 12:52:01.955710 systemd-tmpfiles[759]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 4 12:52:01.956720 systemd-tmpfiles[759]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Nov 4 12:52:01.982792 systemd-tmpfiles[759]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:52:01.982805 systemd-tmpfiles[759]: Skipping /boot Nov 4 12:52:01.987937 systemd-tmpfiles[759]: Detected autofs mount point /boot during canonicalization of /boot. Nov 4 12:52:01.987952 systemd-tmpfiles[759]: Skipping /boot Nov 4 12:52:02.017454 systemd[1]: Finished Create Volatile Files and Directories. Nov 4 12:52:02.030392 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:52:02.032087 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Nov 4 12:52:02.033033 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Nov 4 12:52:02.032000 audit: BPF prog-id=27 op=LOAD Nov 4 12:52:02.034370 systemd[1]: Starting Network Name Resolution... Nov 4 12:52:02.036000 audit: BPF prog-id=28 op=LOAD Nov 4 12:52:02.038436 systemd[1]: Starting Network Time Synchronization... Nov 4 12:52:02.039269 systemd[1]: Condition check resulted in Update is Completed being skipped. Nov 4 12:52:02.040162 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Nov 4 12:52:02.041457 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Nov 4 12:52:02.042649 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Nov 4 12:52:02.048720 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Nov 4 12:52:02.055000 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:52:02.056078 augenrules[780]: No rules Nov 4 12:52:02.073779 systemd-resolved[763]: Positive Trust Anchors: Nov 4 12:52:02.073785 systemd-resolved[763]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 4 12:52:02.073813 systemd-resolved[763]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Nov 4 12:52:02.074582 systemd-timesyncd[769]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Nov 4 12:52:02.074638 systemd-resolved[763]: Defaulting to hostname 'linux'. Nov 4 12:52:02.076291 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:52:02.077192 systemd[1]: Started Network Time Synchronization. Nov 4 12:52:02.078100 systemd[1]: Started Network Name Resolution. Nov 4 12:52:02.078865 systemd[1]: Reached target Network. Nov 4 12:52:02.079482 systemd[1]: Reached target Host and Network Name Lookups. Nov 4 12:52:02.080359 systemd[1]: Reached target System Initialization. Nov 4 12:52:02.081225 systemd[1]: Started Watch for update engine configuration changes. Nov 4 12:52:02.082241 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 4 12:52:02.083250 systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 4 12:52:02.084128 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Nov 4 12:52:02.084160 systemd[1]: Reached target Path Units. Nov 4 12:52:02.084795 systemd[1]: Reached target System Time Set. Nov 4 12:52:02.085697 systemd[1]: Started Daily Log Rotation. Nov 4 12:52:02.086578 systemd[1]: Started Weekly check for MD array's redundancy information.. Nov 4 12:52:02.087616 systemd[1]: Reached target Timer Units. Nov 4 12:52:02.088591 systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 4 12:52:02.100466 systemd[1]: Starting Docker Socket for the API... Nov 4 12:52:02.103446 systemd[1]: Listening on OpenSSH Server Socket. Nov 4 12:52:02.104614 systemd[1]: Listening on Docker Socket for the API. Nov 4 12:52:02.105495 systemd[1]: Reached target Socket Units. Nov 4 12:52:02.106223 systemd[1]: Reached target Basic System. Nov 4 12:52:02.106955 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Nov 4 12:52:02.106982 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Nov 4 12:52:02.107874 systemd[1]: Started D-Bus System Message Bus. Nov 4 12:52:02.110697 systemd[1]: Starting Extend Filesystems... Nov 4 12:52:02.111519 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Nov 4 12:52:02.112403 systemd[1]: Starting Generate /run/flatcar/motd... Nov 4 12:52:02.114157 systemd[1]: Starting Install an ssh key from /proc/cmdline... Nov 4 12:52:02.116001 systemd[1]: Starting Generate sshd host keys... Nov 4 12:52:02.117260 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Nov 4 12:52:02.117316 systemd[1]: Reached target Load system-provided cloud configs. Nov 4 12:52:02.119765 extend-filesystems[790]: Found vda Nov 4 12:52:02.119765 extend-filesystems[790]: Found vda1 Nov 4 12:52:02.119765 extend-filesystems[790]: Found vda2 Nov 4 12:52:02.119765 extend-filesystems[790]: Found vda3 Nov 4 12:52:02.119765 extend-filesystems[790]: Found usr Nov 4 12:52:02.119765 extend-filesystems[790]: Found vda4 Nov 4 12:52:02.119765 extend-filesystems[790]: Found vda6 Nov 4 12:52:02.119765 extend-filesystems[790]: Found vda7 Nov 4 12:52:02.119765 extend-filesystems[790]: Found vda9 Nov 4 12:52:02.119765 extend-filesystems[790]: Checking size of /dev/vda9 Nov 4 12:52:02.120008 systemd[1]: Starting User Login Management... Nov 4 12:52:02.121791 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 4 12:52:02.122378 systemd[1]: Starting Update Engine... Nov 4 12:52:02.123523 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Nov 4 12:52:02.123546 systemd[1]: Reached target Load user-provided cloud configs. Nov 4 12:52:02.125863 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 4 12:52:02.126068 systemd[1]: Finished Install an ssh key from /proc/cmdline. Nov 4 12:52:02.140387 extend-filesystems[790]: Old size kept for /dev/vda9 Nov 4 12:52:02.140234 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 4 12:52:02.140452 systemd[1]: Finished Extend Filesystems. Nov 4 12:52:02.142272 systemd[1]: motdgen.service: Deactivated successfully. Nov 4 12:52:02.142470 systemd[1]: Finished Generate /run/flatcar/motd. Nov 4 12:52:02.168264 systemd[1]: Finished Generate sshd host keys. Nov 4 12:52:02.175673 systemd[1]: Starting Generate /run/issue... Nov 4 12:52:02.177402 systemd-logind[800]: Watching system buttons on /dev/input/event0 (Power Button) Nov 4 12:52:02.177585 systemd-logind[800]: New seat seat0. Nov 4 12:52:02.180489 systemd[1]: issuegen.service: Deactivated successfully. Nov 4 12:52:02.180694 systemd[1]: Finished Generate /run/issue. Nov 4 12:52:02.181820 systemd[1]: Started User Login Management. Nov 4 12:52:02.183278 update_engine[803]: I1104 12:52:02.183037 803 main.cc:89] Flatcar Update Engine starting Nov 4 12:52:02.183639 systemd[1]: Starting Permit User Sessions... Nov 4 12:52:02.184331 update_engine[803]: I1104 12:52:02.184314 803 payload_state.cc:360] Current Response Signature = Nov 4 12:52:02.184331 update_engine[803]: NumURLs = 1 Nov 4 12:52:02.184331 update_engine[803]: Url0 = http://10.0.0.6:34567/packages/update.gz Nov 4 12:52:02.184331 update_engine[803]: Payload Size = 439965385 Nov 4 12:52:02.184331 update_engine[803]: Payload Sha256 Hash = +42QG3ah2EOUXfyDwaJG/hKpihone22jwnvEw5N2E4k= Nov 4 12:52:02.184331 update_engine[803]: Is Delta Payload = 0 Nov 4 12:52:02.184331 update_engine[803]: Max Failure Count Per Url = 10 Nov 4 12:52:02.184331 update_engine[803]: Disable Payload Backoff = 1 Nov 4 12:52:02.184760 update_engine[803]: I1104 12:52:02.184743 803 payload_state.cc:381] Payload Attempt Number = 0 Nov 4 12:52:02.185034 update_engine[803]: I1104 12:52:02.185019 803 payload_state.cc:404] Current URL Index = 0 Nov 4 12:52:02.185261 update_engine[803]: I1104 12:52:02.185248 803 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Nov 4 12:52:02.185498 update_engine[803]: I1104 12:52:02.185469 803 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Nov 4 12:52:02.187200 systemd[1]: Started Update Engine. Nov 4 12:52:02.187522 update_engine[803]: I1104 12:52:02.187496 803 update_check_scheduler.cc:74] Next update check in 2m51s Nov 4 12:52:02.188386 systemd[1]: Finished Permit User Sessions. Nov 4 12:52:02.190191 systemd[1]: Started Getty on tty1. Nov 4 12:52:02.191855 systemd[1]: Started Serial Getty on ttyAMA0. Nov 4 12:52:02.192718 systemd[1]: Reached target Login Prompts. Nov 4 12:52:02.193665 systemd[1]: Reached target Multi-User System. Nov 4 12:52:02.195443 systemd[1]: Starting Record Runlevel Change in UTMP... Nov 4 12:52:02.200046 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 4 12:52:02.200245 systemd[1]: Finished Record Runlevel Change in UTMP. Nov 4 12:52:02.201156 systemd[1]: Startup finished in 691ms (kernel) + 1.064s (initrd) + 2.580s (userspace) = 4.336s. Nov 4 12:52:02.824396 systemd-networkd[717]: eth0: Gained IPv6LL Nov 4 12:52:12.216827 systemd[1]: Created slice Slice /system/sshd. Nov 4 12:52:12.217999 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:50954). Nov 4 12:52:12.261238 sshd[829]: Accepted publickey for core from 10.0.0.1 port 50954 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:52:12.262996 sshd[829]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:52:12.285401 systemd[1]: Created slice User Slice of UID 500. Nov 4 12:52:12.286747 systemd[1]: Starting User Runtime Directory /run/user/500... Nov 4 12:52:12.288514 systemd-logind[800]: New session 1 of user core. Nov 4 12:52:12.292584 systemd[1]: Finished User Runtime Directory /run/user/500. Nov 4 12:52:12.293638 systemd[1]: Starting User Manager for UID 500... Nov 4 12:52:12.295635 systemd[832]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:52:12.341165 systemd[832]: Queued start job for default target Main User Target. Nov 4 12:52:12.341305 systemd[832]: Reached target Paths. Nov 4 12:52:12.341319 systemd[832]: Reached target Sockets. Nov 4 12:52:12.341329 systemd[832]: Reached target Timers. Nov 4 12:52:12.341341 systemd[832]: Reached target Basic System. Nov 4 12:52:12.341382 systemd[832]: Reached target Main User Target. Nov 4 12:52:12.341396 systemd[832]: Startup finished in 42ms. Nov 4 12:52:12.341481 systemd[1]: Started User Manager for UID 500. Nov 4 12:52:12.354298 systemd[1]: Started Session 1 of User core. Nov 4 12:52:12.413076 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:50958). Nov 4 12:52:12.452037 sshd[841]: Accepted publickey for core from 10.0.0.1 port 50958 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:52:12.453954 sshd[841]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:52:12.456930 systemd-logind[800]: New session 2 of user core. Nov 4 12:52:12.479209 systemd[1]: Started Session 2 of User core. Nov 4 12:52:12.534204 sshd[841]: pam_unix(sshd:session): session closed for user core Nov 4 12:52:12.542263 systemd[1]: sshd@1-10.0.0.7:22-10.0.0.1:50958.service: Deactivated successfully. Nov 4 12:52:12.542889 systemd[1]: session-2.scope: Deactivated successfully. Nov 4 12:52:12.543473 systemd-logind[800]: Session 2 logged out. Waiting for processes to exit. Nov 4 12:52:12.544374 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:50964). Nov 4 12:52:12.545308 systemd-logind[800]: Removed session 2. Nov 4 12:52:12.584066 sshd[847]: Accepted publickey for core from 10.0.0.1 port 50964 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:52:12.584949 sshd[847]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:52:12.587223 systemd-logind[800]: New session 3 of user core. Nov 4 12:52:12.600017 systemd[1]: Started Session 3 of User core. Nov 4 12:52:12.649153 sshd[847]: pam_unix(sshd:session): session closed for user core Nov 4 12:52:12.659154 systemd[1]: sshd@2-10.0.0.7:22-10.0.0.1:50964.service: Deactivated successfully. Nov 4 12:52:12.659891 systemd-logind[800]: Session 3 logged out. Waiting for processes to exit. Nov 4 12:52:12.659928 systemd[1]: session-3.scope: Deactivated successfully. Nov 4 12:52:12.661113 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:50974). Nov 4 12:52:12.661591 systemd-logind[800]: Removed session 3. Nov 4 12:52:12.699885 sshd[854]: Accepted publickey for core from 10.0.0.1 port 50974 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:52:12.700698 sshd[854]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:52:12.702978 systemd-logind[800]: New session 4 of user core. Nov 4 12:52:12.714967 systemd[1]: Started Session 4 of User core. Nov 4 12:52:12.767470 sshd[854]: pam_unix(sshd:session): session closed for user core Nov 4 12:52:12.780204 systemd[1]: sshd@3-10.0.0.7:22-10.0.0.1:50974.service: Deactivated successfully. Nov 4 12:52:12.780768 systemd[1]: session-4.scope: Deactivated successfully. Nov 4 12:52:12.781345 systemd-logind[800]: Session 4 logged out. Waiting for processes to exit. Nov 4 12:52:12.782215 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:50982). Nov 4 12:52:12.782883 systemd-logind[800]: Removed session 4. Nov 4 12:52:12.823022 sshd[860]: Accepted publickey for core from 10.0.0.1 port 50982 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:52:12.823810 sshd[860]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:52:12.826294 systemd-logind[800]: New session 5 of user core. Nov 4 12:52:12.845865 systemd[1]: Started Session 5 of User core. Nov 4 12:52:12.904605 sudo[863]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Nov 4 12:52:12.904815 sudo[863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:52:12.918138 sudo[863]: pam_unix(sudo:session): session closed for user root Nov 4 12:52:12.919723 sshd[860]: pam_unix(sshd:session): session closed for user core Nov 4 12:52:12.931511 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:50984). Nov 4 12:52:12.933932 dbus-daemon[789]: [system] Reloaded configuration Nov 4 12:52:12.935955 systemd[1]: sshd@4-10.0.0.7:22-10.0.0.1:50982.service: Deactivated successfully. Nov 4 12:52:12.936487 systemd[1]: session-5.scope: Deactivated successfully. Nov 4 12:52:12.937039 systemd-logind[800]: Session 5 logged out. Waiting for processes to exit. Nov 4 12:52:12.937604 systemd-logind[800]: Removed session 5. Nov 4 12:52:12.970239 sshd[866]: Accepted publickey for core from 10.0.0.1 port 50984 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:52:12.971404 sshd[866]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:52:12.973881 systemd-logind[800]: New session 6 of user core. Nov 4 12:52:12.983988 systemd[1]: Started Session 6 of User core. Nov 4 12:52:13.036037 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:52:13.037002 sudo[871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:52:13.039397 sudo[871]: pam_unix(sudo:session): session closed for user root Nov 4 12:52:13.042691 sudo[870]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Nov 4 12:52:13.042901 sudo[870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 4 12:52:13.058597 systemd[1]: Stopping Load Security Auditing Rules... Nov 4 12:52:13.058000 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:52:13.059666 auditctl[874]: No rules Nov 4 12:52:13.060243 kernel: kauditd_printk_skb: 37 callbacks suppressed Nov 4 12:52:13.060276 kernel: audit: type=1305 audit(1762260733.058:48): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 4 12:52:13.060482 systemd[1]: audit-rules.service: Deactivated successfully. Nov 4 12:52:13.060706 systemd[1]: Stopped Load Security Auditing Rules. Nov 4 12:52:13.061896 systemd[1]: Starting Load Security Auditing Rules... Nov 4 12:52:13.075904 augenrules[891]: No rules Nov 4 12:52:13.076507 systemd[1]: Finished Load Security Auditing Rules. Nov 4 12:52:13.077192 sudo[870]: pam_unix(sudo:session): session closed for user root Nov 4 12:52:13.078152 sshd[866]: pam_unix(sshd:session): session closed for user core Nov 4 12:52:13.085292 systemd[1]: sshd@5-10.0.0.7:22-10.0.0.1:50984.service: Deactivated successfully. Nov 4 12:52:13.085850 systemd[1]: session-6.scope: Deactivated successfully. Nov 4 12:52:13.086403 systemd-logind[800]: Session 6 logged out. Waiting for processes to exit. Nov 4 12:52:13.087252 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:51000). Nov 4 12:52:13.087869 systemd-logind[800]: Removed session 6. Nov 4 12:52:13.130019 sshd[897]: Accepted publickey for core from 10.0.0.1 port 51000 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:52:13.132865 kernel: audit: type=1006 audit(1762260733.129:49): pid=897 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Nov 4 12:52:13.132990 sshd[897]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:52:13.135469 systemd-logind[800]: New session 7 of user core. Nov 4 12:52:13.160151 systemd[1]: Started Session 7 of User core. Nov 4 12:52:13.209046 sshd[897]: pam_unix(sshd:session): session closed for user core Nov 4 12:52:13.222323 systemd[1]: sshd@6-10.0.0.7:22-10.0.0.1:51000.service: Deactivated successfully. Nov 4 12:52:13.222904 systemd[1]: session-7.scope: Deactivated successfully. Nov 4 12:52:13.223392 systemd-logind[800]: Session 7 logged out. Waiting for processes to exit. Nov 4 12:52:13.224273 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:51004). Nov 4 12:52:13.224765 systemd-logind[800]: Removed session 7. Nov 4 12:52:13.263849 sshd[903]: Accepted publickey for core from 10.0.0.1 port 51004 ssh2: RSA SHA256:RC2UkZWBMCWE8y82Cuj7OweY0t7aRqUWUTn5BjLb7zU Nov 4 12:52:13.266858 kernel: audit: type=1006 audit(1762260733.263:50): 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:52:13.267037 sshd[903]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 4 12:52:13.269506 systemd-logind[800]: New session 8 of user core. Nov 4 12:52:13.279841 systemd[1]: Started Session 8 of User core. Nov 4 12:52:13.328087 sshd[903]: pam_unix(sshd:session): session closed for user core Nov 4 12:52:13.330520 systemd[1]: sshd@7-10.0.0.7:22-10.0.0.1:51004.service: Deactivated successfully. Nov 4 12:52:13.331045 systemd[1]: session-8.scope: Deactivated successfully. Nov 4 12:52:13.331496 systemd-logind[800]: Session 8 logged out. Waiting for processes to exit. Nov 4 12:52:13.332189 systemd-logind[800]: Removed session 8.