Nov 6 04:43:38.682691 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 6 04:43:38.682706 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 6 04:43:38.682714 kernel: efi: EFI v2.70 by EDK II Nov 6 04:43:38.682720 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Nov 6 04:43:38.682724 kernel: efi: seeding entropy pool Nov 6 04:43:38.682729 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Nov 6 04:43:38.682736 kernel: ACPI: Early table checksum verification disabled Nov 6 04:43:38.682741 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Nov 6 04:43:38.682745 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 6 04:43:38.682751 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:43:38.682757 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:43:38.682761 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:43:38.682767 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:43:38.682772 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:43:38.682778 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:43:38.682783 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:43:38.682789 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:43:38.682795 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:43:38.682800 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 6 04:43:38.682805 kernel: ACPI: NUMA: Failed to initialise from firmware Nov 6 04:43:38.682811 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 6 04:43:38.682816 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Nov 6 04:43:38.682821 kernel: Zone ranges: Nov 6 04:43:38.682826 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 6 04:43:38.682831 kernel: DMA32 empty Nov 6 04:43:38.682836 kernel: Normal empty Nov 6 04:43:38.682841 kernel: Movable zone start for each node Nov 6 04:43:38.682847 kernel: Early memory node ranges Nov 6 04:43:38.682853 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Nov 6 04:43:38.682858 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Nov 6 04:43:38.682863 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Nov 6 04:43:38.682868 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Nov 6 04:43:38.682873 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Nov 6 04:43:38.682878 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Nov 6 04:43:38.682884 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Nov 6 04:43:38.682889 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 6 04:43:38.682894 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 6 04:43:38.682899 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 6 04:43:38.682904 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 6 04:43:38.682909 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 6 04:43:38.682918 kernel: On node 0 totalpages: 643072 Nov 6 04:43:38.682923 kernel: DMA zone: 10048 pages used for memmap Nov 6 04:43:38.682929 kernel: DMA zone: 0 pages reserved Nov 6 04:43:38.682934 kernel: DMA zone: 643072 pages, LIFO batch:63 Nov 6 04:43:38.682940 kernel: psci: probing for conduit method from ACPI. Nov 6 04:43:38.682945 kernel: psci: PSCIv1.1 detected in firmware. Nov 6 04:43:38.682950 kernel: psci: Using standard PSCI v0.2 function IDs Nov 6 04:43:38.682956 kernel: psci: Trusted OS migration not required Nov 6 04:43:38.682962 kernel: psci: SMC Calling Convention v1.1 Nov 6 04:43:38.682977 kernel: ACPI: SRAT not present Nov 6 04:43:38.682983 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Nov 6 04:43:38.682988 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Nov 6 04:43:38.682994 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 6 04:43:38.682999 kernel: Detected PIPT I-cache on CPU0 Nov 6 04:43:38.683005 kernel: CPU features: detected: GIC system register CPU interface Nov 6 04:43:38.683010 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 6 04:43:38.683016 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 6 04:43:38.683022 kernel: CPU features: detected: Hardware dirty bit management Nov 6 04:43:38.683027 kernel: CPU features: detected: Spectre-v4 Nov 6 04:43:38.683034 kernel: CPU features: detected: ARM erratum 1418040 Nov 6 04:43:38.683039 kernel: CPU features: detected: Spectre-BHB Nov 6 04:43:38.683045 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 6 04:43:38.683050 kernel: Policy zone: DMA Nov 6 04:43:38.683057 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 6 04:43:38.683063 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 6 04:43:38.683068 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 6 04:43:38.683074 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 6 04:43:38.683080 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Nov 6 04:43:38.683086 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Nov 6 04:43:38.683091 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 6 04:43:38.683098 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 6 04:43:38.683104 kernel: rcu: RCU event tracing is enabled. Nov 6 04:43:38.683110 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 6 04:43:38.683115 kernel: Trampoline variant of Tasks RCU enabled. Nov 6 04:43:38.683121 kernel: Tracing variant of Tasks RCU enabled. Nov 6 04:43:38.683126 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 6 04:43:38.683132 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 6 04:43:38.683138 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 6 04:43:38.683143 kernel: GICv3: 256 SPIs implemented Nov 6 04:43:38.683149 kernel: GICv3: 0 Extended SPIs implemented Nov 6 04:43:38.683154 kernel: GICv3: Distributor has no Range Selector support Nov 6 04:43:38.683159 kernel: GICv3: 16 PPIs implemented Nov 6 04:43:38.683166 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 6 04:43:38.683172 kernel: ACPI: SRAT not present Nov 6 04:43:38.683177 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 6 04:43:38.683182 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Nov 6 04:43:38.683188 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Nov 6 04:43:38.683194 kernel: GICv3: using LPI property table @0x00000000400d0000 Nov 6 04:43:38.683199 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Nov 6 04:43:38.683205 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 6 04:43:38.683210 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 6 04:43:38.683216 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 6 04:43:38.683222 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 6 04:43:38.683228 kernel: arm-pv: using stolen time PV Nov 6 04:43:38.683235 kernel: Console: colour dummy device 80x25 Nov 6 04:43:38.683240 kernel: ACPI: Core revision 20200925 Nov 6 04:43:38.683246 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 6 04:43:38.683252 kernel: pid_max: default: 32768 minimum: 301 Nov 6 04:43:38.683258 kernel: LSM: Security Framework initializing Nov 6 04:43:38.683263 kernel: SELinux: Initializing. Nov 6 04:43:38.683269 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 6 04:43:38.683275 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 6 04:43:38.683281 kernel: rcu: Hierarchical SRCU implementation. Nov 6 04:43:38.683288 kernel: Platform MSI: ITS@0x8080000 domain created Nov 6 04:43:38.683293 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 6 04:43:38.683299 kernel: Remapping and enabling EFI services. Nov 6 04:43:38.683304 kernel: smp: Bringing up secondary CPUs ... Nov 6 04:43:38.683310 kernel: Detected PIPT I-cache on CPU1 Nov 6 04:43:38.683316 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 6 04:43:38.683322 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Nov 6 04:43:38.683328 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 6 04:43:38.683334 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 6 04:43:38.683339 kernel: Detected PIPT I-cache on CPU2 Nov 6 04:43:38.683346 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 6 04:43:38.683352 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Nov 6 04:43:38.683358 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 6 04:43:38.683364 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 6 04:43:38.683369 kernel: Detected PIPT I-cache on CPU3 Nov 6 04:43:38.683379 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 6 04:43:38.683385 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Nov 6 04:43:38.683392 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 6 04:43:38.683398 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 6 04:43:38.683404 kernel: smp: Brought up 1 node, 4 CPUs Nov 6 04:43:38.683409 kernel: SMP: Total of 4 processors activated. Nov 6 04:43:38.683416 kernel: CPU features: detected: Privileged Access Never Nov 6 04:43:38.683421 kernel: CPU features: detected: LSE atomic instructions Nov 6 04:43:38.683427 kernel: CPU features: detected: User Access Override Nov 6 04:43:38.683434 kernel: CPU features: detected: 32-bit EL0 Support Nov 6 04:43:38.683440 kernel: CPU features: detected: Common not Private translations Nov 6 04:43:38.683446 kernel: CPU features: detected: RAS Extension Support Nov 6 04:43:38.683453 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 6 04:43:38.683464 kernel: CPU features: detected: CRC32 instructions Nov 6 04:43:38.683472 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 6 04:43:38.683478 kernel: CPU: All CPU(s) started at EL1 Nov 6 04:43:38.683484 kernel: alternatives: patching kernel code Nov 6 04:43:38.683491 kernel: devtmpfs: initialized Nov 6 04:43:38.683497 kernel: KASLR enabled Nov 6 04:43:38.683503 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 6 04:43:38.683510 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 6 04:43:38.683516 kernel: pinctrl core: initialized pinctrl subsystem Nov 6 04:43:38.683522 kernel: SMBIOS 3.0.0 present. Nov 6 04:43:38.683528 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Nov 6 04:43:38.683534 kernel: NET: Registered protocol family 16 Nov 6 04:43:38.683540 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 6 04:43:38.683546 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 6 04:43:38.683553 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 6 04:43:38.683559 kernel: audit: initializing netlink subsys (disabled) Nov 6 04:43:38.683565 kernel: audit: type=2000 audit(0.030:1): state=initialized audit_enabled=0 res=1 Nov 6 04:43:38.683571 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 6 04:43:38.683580 kernel: cpuidle: using governor menu Nov 6 04:43:38.683587 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 6 04:43:38.683593 kernel: ASID allocator initialised with 32768 entries Nov 6 04:43:38.683599 kernel: ACPI: bus type PCI registered Nov 6 04:43:38.683605 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 6 04:43:38.683612 kernel: Serial: AMBA PL011 UART driver Nov 6 04:43:38.683618 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 6 04:43:38.683624 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 6 04:43:38.683630 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 6 04:43:38.683636 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 6 04:43:38.683642 kernel: cryptd: max_cpu_qlen set to 1000 Nov 6 04:43:38.683648 kernel: ACPI: Added _OSI(Module Device) Nov 6 04:43:38.683654 kernel: ACPI: Added _OSI(Processor Device) Nov 6 04:43:38.683660 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 6 04:43:38.683667 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 6 04:43:38.683673 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 6 04:43:38.683679 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 6 04:43:38.683685 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 6 04:43:38.683691 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 6 04:43:38.683697 kernel: ACPI: Interpreter enabled Nov 6 04:43:38.683703 kernel: ACPI: Using GIC for interrupt routing Nov 6 04:43:38.683709 kernel: ACPI: MCFG table detected, 1 entries Nov 6 04:43:38.683715 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 6 04:43:38.683721 kernel: printk: console [ttyAMA0] enabled Nov 6 04:43:38.683728 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 6 04:43:38.683846 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 6 04:43:38.683905 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 6 04:43:38.683958 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 6 04:43:38.684053 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 6 04:43:38.684109 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 6 04:43:38.684117 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 6 04:43:38.684126 kernel: PCI host bridge to bus 0000:00 Nov 6 04:43:38.684182 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 6 04:43:38.684230 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 6 04:43:38.684278 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 6 04:43:38.684328 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 6 04:43:38.684394 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 6 04:43:38.684455 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 6 04:43:38.684521 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 6 04:43:38.684576 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 6 04:43:38.684629 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 6 04:43:38.684688 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 6 04:43:38.684742 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 6 04:43:38.684795 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 6 04:43:38.684844 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 6 04:43:38.684894 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 6 04:43:38.684941 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 6 04:43:38.684949 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Nov 6 04:43:38.684955 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Nov 6 04:43:38.684961 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Nov 6 04:43:38.684977 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Nov 6 04:43:38.684983 kernel: vgaarb: loaded Nov 6 04:43:38.684989 kernel: Registered efivars operations Nov 6 04:43:38.684995 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 6 04:43:38.685003 kernel: VFS: Disk quotas dquot_6.6.0 Nov 6 04:43:38.685009 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 6 04:43:38.685015 kernel: pnp: PnP ACPI init Nov 6 04:43:38.685073 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 6 04:43:38.685122 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Nov 6 04:43:38.685130 kernel: pnp: PnP ACPI: found 1 devices Nov 6 04:43:38.685136 kernel: NET: Registered protocol family 2 Nov 6 04:43:38.685143 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 6 04:43:38.685155 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 6 04:43:38.685162 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 6 04:43:38.685168 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 6 04:43:38.685174 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 6 04:43:38.685180 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 6 04:43:38.685186 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 6 04:43:38.685192 kernel: NET: Registered protocol family 1 Nov 6 04:43:38.685198 kernel: PCI: CLS 0 bytes, default 64 Nov 6 04:43:38.685204 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 6 04:43:38.685211 kernel: kvm [1]: HYP mode not available Nov 6 04:43:38.685217 kernel: Initialise system trusted keyrings Nov 6 04:43:38.685223 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 6 04:43:38.685230 kernel: Key type asymmetric registered Nov 6 04:43:38.685236 kernel: Asymmetric key parser 'x509' registered Nov 6 04:43:38.685242 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 6 04:43:38.685248 kernel: io scheduler mq-deadline registered Nov 6 04:43:38.685254 kernel: io scheduler kyber registered Nov 6 04:43:38.685260 kernel: io scheduler bfq registered Nov 6 04:43:38.685268 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 6 04:43:38.685274 kernel: ACPI: Power Button [PWRB] Nov 6 04:43:38.685280 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Nov 6 04:43:38.685336 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 6 04:43:38.685344 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 6 04:43:38.685350 kernel: msm_serial: driver initialized Nov 6 04:43:38.685356 kernel: random: fast init done Nov 6 04:43:38.685362 kernel: random: crng init done Nov 6 04:43:38.685368 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Nov 6 04:43:38.685374 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Nov 6 04:43:38.685381 kernel: thunder_xcv, ver 1.0 Nov 6 04:43:38.685387 kernel: thunder_bgx, ver 1.0 Nov 6 04:43:38.685393 kernel: nicpf, ver 1.0 Nov 6 04:43:38.685399 kernel: nicvf, ver 1.0 Nov 6 04:43:38.685469 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 6 04:43:38.685526 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-06T04:43:38 UTC (1762404218) Nov 6 04:43:38.685535 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 6 04:43:38.685541 kernel: NET: Registered protocol family 10 Nov 6 04:43:38.685548 kernel: Segment Routing with IPv6 Nov 6 04:43:38.685554 kernel: NET: Registered protocol family 17 Nov 6 04:43:38.685560 kernel: Key type dns_resolver registered Nov 6 04:43:38.685566 kernel: registered taskstats version 1 Nov 6 04:43:38.685572 kernel: Loading compiled-in X.509 certificates Nov 6 04:43:38.685578 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Nov 6 04:43:38.685585 kernel: Key type ._fscrypt registered Nov 6 04:43:38.685591 kernel: Key type .fscrypt registered Nov 6 04:43:38.685597 kernel: Key type fscrypt-provisioning registered Nov 6 04:43:38.685604 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 6 04:43:38.685610 kernel: ima: Allocated hash algorithm: sha1 Nov 6 04:43:38.685616 kernel: ima: No architecture policies found Nov 6 04:43:38.685622 kernel: Freeing unused kernel memory: 34240K Nov 6 04:43:38.685628 kernel: Run /init as init process Nov 6 04:43:38.685634 kernel: with arguments: Nov 6 04:43:38.685639 kernel: /init Nov 6 04:43:38.685645 kernel: with environment: Nov 6 04:43:38.685651 kernel: HOME=/ Nov 6 04:43:38.685657 kernel: TERM=linux Nov 6 04:43:38.685663 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 6 04:43:38.685671 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 6 04:43:38.685680 systemd[1]: Detected virtualization kvm. Nov 6 04:43:38.685686 systemd[1]: Detected architecture arm64. Nov 6 04:43:38.685693 systemd[1]: Running in initial RAM disk. Nov 6 04:43:38.685699 systemd[1]: No hostname configured, using default hostname. Nov 6 04:43:38.685706 systemd[1]: Hostname set to . Nov 6 04:43:38.685713 systemd[1]: Initializing machine ID from VM UUID. Nov 6 04:43:38.685720 systemd[1]: Queued start job for default target Initrd Default Target. Nov 6 04:43:38.685727 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 6 04:43:38.685733 systemd[1]: Reached target Local Encrypted Volumes. Nov 6 04:43:38.685739 systemd[1]: Reached target Path Units. Nov 6 04:43:38.685746 systemd[1]: Reached target Slice Units. Nov 6 04:43:38.685752 systemd[1]: Reached target Swaps. Nov 6 04:43:38.685758 systemd[1]: Reached target Timer Units. Nov 6 04:43:38.685766 systemd[1]: Listening on Open-iSCSI iscsid Socket. Nov 6 04:43:38.685772 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Nov 6 04:43:38.685779 systemd[1]: Listening on Journal Audit Socket. Nov 6 04:43:38.685785 systemd[1]: Listening on Journal Socket (/dev/log). Nov 6 04:43:38.685792 systemd[1]: Listening on Journal Socket. Nov 6 04:43:38.685798 systemd[1]: Listening on Network Service Netlink Socket. Nov 6 04:43:38.685805 systemd[1]: Listening on udev Control Socket. Nov 6 04:43:38.685812 systemd[1]: Listening on udev Kernel Socket. Nov 6 04:43:38.685818 systemd[1]: Reached target Socket Units. Nov 6 04:43:38.685825 systemd[1]: Starting Create List of Static Device Nodes... Nov 6 04:43:38.685832 systemd[1]: Finished Network Cleanup. Nov 6 04:43:38.685838 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Nov 6 04:43:38.685845 systemd[1]: Starting Journal Service... Nov 6 04:43:38.685851 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 6 04:43:38.685858 systemd[1]: Starting Apply Kernel Variables... Nov 6 04:43:38.685864 systemd[1]: Starting Setup Virtual Console... Nov 6 04:43:38.685871 systemd[1]: Finished Create List of Static Device Nodes. Nov 6 04:43:38.685878 systemd[1]: Finished Apply Kernel Variables. Nov 6 04:43:38.685885 systemd[1]: Finished Setup Virtual Console. Nov 6 04:43:38.685892 systemd[1]: Starting dracut ask for additional cmdline parameters... Nov 6 04:43:38.685900 systemd-journald[279]: Journal started Nov 6 04:43:38.685933 systemd-journald[279]: Runtime Journal (/run/log/journal/c32df9d9ae204426bdc50dcd85a862e0) is 6.0M, max 48.5M, 42.4M free. Nov 6 04:43:38.688080 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 6 04:43:38.689337 systemd[1]: Started Journal Service. Nov 6 04:43:38.689751 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 6 04:43:38.701754 systemd[1]: Finished dracut ask for additional cmdline parameters. Nov 6 04:43:38.703347 systemd[1]: Starting dracut cmdline hook... Nov 6 04:43:38.711601 dracut-cmdline[295]: dracut-dracut-053 Nov 6 04:43:38.713734 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 6 04:43:38.769990 kernel: SCSI subsystem initialized Nov 6 04:43:38.773981 kernel: Loading iSCSI transport class v2.0-870. Nov 6 04:43:38.781512 kernel: iscsi: registered transport (tcp) Nov 6 04:43:38.791359 kernel: iscsi: registered transport (qla4xxx) Nov 6 04:43:38.791372 kernel: QLogic iSCSI HBA Driver Nov 6 04:43:38.801695 systemd[1]: Finished dracut cmdline hook. Nov 6 04:43:38.803156 systemd[1]: Starting dracut pre-udev hook... Nov 6 04:43:38.816416 kernel: device-mapper: uevent: version 1.0.3 Nov 6 04:43:38.816440 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Nov 6 04:43:38.850986 kernel: raid6: neonx8 gen() 13788 MB/s Nov 6 04:43:38.867986 kernel: raid6: neonx8 xor() 10751 MB/s Nov 6 04:43:38.884978 kernel: raid6: neonx4 gen() 13580 MB/s Nov 6 04:43:38.901987 kernel: raid6: neonx4 xor() 11560 MB/s Nov 6 04:43:38.918980 kernel: raid6: neonx2 gen() 13016 MB/s Nov 6 04:43:38.935981 kernel: raid6: neonx2 xor() 9878 MB/s Nov 6 04:43:38.953000 kernel: raid6: neonx1 gen() 10993 MB/s Nov 6 04:43:38.969996 kernel: raid6: neonx1 xor() 8858 MB/s Nov 6 04:43:38.986983 kernel: raid6: int64x8 gen() 6830 MB/s Nov 6 04:43:39.003989 kernel: raid6: int64x8 xor() 3777 MB/s Nov 6 04:43:39.020981 kernel: raid6: int64x4 gen() 6897 MB/s Nov 6 04:43:39.037984 kernel: raid6: int64x4 xor() 3832 MB/s Nov 6 04:43:39.055034 kernel: raid6: int64x2 gen() 6172 MB/s Nov 6 04:43:39.071998 kernel: raid6: int64x2 xor() 3310 MB/s Nov 6 04:43:39.088989 kernel: raid6: int64x1 gen() 5015 MB/s Nov 6 04:43:39.106011 kernel: raid6: int64x1 xor() 2599 MB/s Nov 6 04:43:39.106033 kernel: raid6: using algorithm neonx8 gen() 13788 MB/s Nov 6 04:43:39.106049 kernel: raid6: .... xor() 10751 MB/s, rmw enabled Nov 6 04:43:39.107019 kernel: raid6: using neon recovery algorithm Nov 6 04:43:39.116987 kernel: xor: measuring software checksum speed Nov 6 04:43:39.117988 kernel: 8regs : 17152 MB/sec Nov 6 04:43:39.119398 kernel: 32regs : 20718 MB/sec Nov 6 04:43:39.119410 kernel: arm64_neon : 29184 MB/sec Nov 6 04:43:39.119417 kernel: xor: using function: arm64_neon (29184 MB/sec) Nov 6 04:43:39.166020 kernel: Btrfs loaded, crc32c=crc32c-generic Nov 6 04:43:39.177300 systemd[1]: Finished dracut pre-udev hook. Nov 6 04:43:39.177000 audit: BPF prog-id=6 op=LOAD Nov 6 04:43:39.180329 kernel: audit: type=1334 audit(1762404219.177:2): prog-id=6 op=LOAD Nov 6 04:43:39.180353 kernel: audit: type=1334 audit(1762404219.178:3): prog-id=7 op=LOAD Nov 6 04:43:39.178000 audit: BPF prog-id=7 op=LOAD Nov 6 04:43:39.182996 kernel: audit: type=1334 audit(1762404219.180:4): prog-id=8 op=LOAD Nov 6 04:43:39.180000 audit: BPF prog-id=8 op=LOAD Nov 6 04:43:39.181479 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 6 04:43:39.195674 systemd-udevd[413]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 6 04:43:39.197439 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 6 04:43:39.199047 systemd[1]: Starting dracut pre-trigger hook... Nov 6 04:43:39.204611 kernel: audit: type=1334 audit(1762404219.199:5): prog-id=9 op=LOAD Nov 6 04:43:39.199000 audit: BPF prog-id=9 op=LOAD Nov 6 04:43:39.200773 systemd[1]: Starting Network Configuration... Nov 6 04:43:39.211566 dracut-pre-trigger[416]: rd.md=0: removing MD RAID activation Nov 6 04:43:39.216767 systemd-networkd[417]: lo: Link UP Nov 6 04:43:39.216773 systemd-networkd[417]: lo: Gained carrier Nov 6 04:43:39.217051 systemd-networkd[417]: Enumeration completed Nov 6 04:43:39.217000 audit: BPF prog-id=10 op=LOAD Nov 6 04:43:39.217108 systemd[1]: Started Network Configuration. Nov 6 04:43:39.221737 kernel: audit: type=1334 audit(1762404219.217:6): prog-id=10 op=LOAD Nov 6 04:43:39.220043 systemd[1]: Starting Network Name Resolution... Nov 6 04:43:39.238139 systemd[1]: Finished dracut pre-trigger hook. Nov 6 04:43:39.239486 systemd[1]: Starting Coldplug All udev Devices... Nov 6 04:43:39.248212 systemd-resolved[440]: Positive Trust Anchors: Nov 6 04:43:39.248231 systemd-resolved[440]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 6 04:43:39.248260 systemd-resolved[440]: 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 6 04:43:39.248547 systemd-resolved[440]: Defaulting to hostname 'linux'. Nov 6 04:43:39.248901 systemd-udevd[413]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 6 04:43:39.251318 systemd[1]: Started Network Name Resolution. Nov 6 04:43:39.263416 systemd[1]: Reached target Network. Nov 6 04:43:39.264118 systemd[1]: Reached target Host and Network Name Lookups. Nov 6 04:43:39.267443 systemd[1]: Starting iSCSI UserSpace I/O driver... Nov 6 04:43:39.273061 systemd[1]: Started iSCSI UserSpace I/O driver. Nov 6 04:43:39.274512 systemd[1]: Starting Open-iSCSI... Nov 6 04:43:39.276765 iscsid[481]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 6 04:43:39.276765 iscsid[481]: 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 6 04:43:39.276765 iscsid[481]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 6 04:43:39.276765 iscsid[481]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 6 04:43:39.276765 iscsid[481]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 6 04:43:39.276765 iscsid[481]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 6 04:43:39.280180 systemd[1]: Started Open-iSCSI. Nov 6 04:43:39.294641 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 6 04:43:39.294763 kernel: vda: detected capacity change from 0 to 4756340736 Nov 6 04:43:39.283622 systemd[1]: Finished Coldplug All udev Devices. Nov 6 04:43:39.290646 systemd[1]: Starting dracut initqueue hook... Nov 6 04:43:39.302000 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 6 04:43:39.309588 systemd-udevd[461]: Using default interface naming scheme 'v249'. Nov 6 04:43:39.317020 systemd-networkd[417]: eth0: Link UP Nov 6 04:43:39.323825 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (460) Nov 6 04:43:39.321383 systemd[1]: Found device /dev/disk/by-label/ROOT. Nov 6 04:43:39.325306 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Nov 6 04:43:39.326399 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Nov 6 04:43:39.332198 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Nov 6 04:43:39.333249 systemd[1]: Finished dracut initqueue hook. Nov 6 04:43:39.336947 systemd[1]: Found device /dev/disk/by-label/OEM. Nov 6 04:43:39.337755 systemd[1]: Reached target Initrd Root Device. Nov 6 04:43:39.339047 systemd[1]: Reached target Preparation for Remote File Systems. Nov 6 04:43:39.340549 systemd[1]: Reached target Remote Encrypted Volumes. Nov 6 04:43:39.342083 systemd[1]: Reached target Remote File Systems. Nov 6 04:43:39.344261 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Nov 6 04:43:39.345731 systemd[1]: Starting dracut pre-mount hook... Nov 6 04:43:39.354192 systemd[1]: Finished dracut pre-mount hook. Nov 6 04:43:39.425004 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 6 04:43:40.344199 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Nov 6 04:43:40.343789 systemd-networkd[417]: eth0: Gained carrier Nov 6 04:43:40.354273 systemd-networkd[417]: eth0: DHCPv4 address 10.0.0.3/16 via 10.0.0.1 Nov 6 04:43:40.451462 disk-uuid[506]: The operation has completed successfully. Nov 6 04:43:40.452742 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 6 04:43:40.470906 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 6 04:43:40.472026 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Nov 6 04:43:40.474668 systemd[1]: Starting Ignition (setup)... Nov 6 04:43:40.482376 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 6 04:43:40.482412 kernel: BTRFS info (device vda6): has skinny extents Nov 6 04:43:40.488077 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 6 04:43:40.493511 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 6 04:43:40.493618 systemd[1]: Finished Ignition (setup). Nov 6 04:43:40.495611 systemd[1]: Starting Ignition (disks)... Nov 6 04:43:40.505063 ignition[539]: Ignition v0.36.1-15-gde4e6cc9 Nov 6 04:43:40.505080 ignition[539]: Stage: disks Nov 6 04:43:40.505089 ignition[539]: reading system config file "/usr/lib/ignition/base.ign" Nov 6 04:43:40.505099 ignition[539]: no config at "/usr/lib/ignition/base.ign" Nov 6 04:43:40.505141 ignition[539]: parsed url from cmdline: "" Nov 6 04:43:40.505144 ignition[539]: no config URL provided Nov 6 04:43:40.505149 ignition[539]: reading system config file "/usr/lib/ignition/user.ign" Nov 6 04:43:40.505156 ignition[539]: no config at "/usr/lib/ignition/user.ign" Nov 6 04:43:40.505174 ignition[539]: op(1): [started] loading QEMU firmware config module Nov 6 04:43:40.505179 ignition[539]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 6 04:43:40.506142 ignition[539]: op(1): [finished] loading QEMU firmware config module Nov 6 04:43:40.519469 ignition[539]: parsing config with SHA512: 5406c1d6ee4f116cbc901937072ce96d34d21672494aecf1078d7a9f863455414296496957ec740f98f03f371aef31be95797decc411def1d18bfdf268bb0880 Nov 6 04:43:40.521456 ignition[539]: disks: disks passed Nov 6 04:43:40.521472 ignition[539]: Ignition finished successfully Nov 6 04:43:40.522065 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 6 04:43:40.522167 systemd[1]: Finished Ignition (disks). Nov 6 04:43:40.523534 systemd[1]: Reached target Preparation for Local File Systems. Nov 6 04:43:40.525645 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Nov 6 04:43:40.527813 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Nov 6 04:43:40.535575 systemd-fsck[552]: ROOT: clean, 528/553792 files, 37752/553472 blocks Nov 6 04:43:40.538993 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 6 04:43:40.540031 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Nov 6 04:43:40.542799 systemd[1]: Mounting /sysroot... Nov 6 04:43:40.557582 systemd[1]: Found device /dev/mapper/usr. Nov 6 04:43:40.559474 systemd[1]: Starting File System Check on /dev/mapper/usr... Nov 6 04:43:40.561565 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Nov 6 04:43:40.569424 systemd-fsck[566]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Nov 6 04:43:40.569424 systemd-fsck[566]: You must have r/w access to the filesystem or be root Nov 6 04:43:40.572215 systemd-fsck[563]: fsck failed with exit status 8. Nov 6 04:43:40.572224 systemd-fsck[563]: Ignoring error. Nov 6 04:43:40.574218 systemd[1]: Finished File System Check on /dev/mapper/usr. Nov 6 04:43:40.577062 systemd[1]: Mounting /sysusr/usr... Nov 6 04:43:40.582989 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Nov 6 04:43:40.583021 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Nov 6 04:43:40.583732 systemd[1]: Mounted /sysroot. Nov 6 04:43:40.584556 systemd[1]: Reached target Initrd Root File System. Nov 6 04:43:40.590985 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Nov 6 04:43:40.591091 systemd[1]: Mounted /sysusr/usr. Nov 6 04:43:40.591726 systemd[1]: Reached target Local File Systems. Nov 6 04:43:40.592838 systemd[1]: Reached target System Initialization. Nov 6 04:43:40.594170 systemd[1]: Reached target Basic System. Nov 6 04:43:40.596674 systemd[1]: Mounting /sysroot/usr... Nov 6 04:43:40.598694 systemd[1]: Mounted /sysroot/usr. Nov 6 04:43:40.600008 systemd[1]: Starting Root filesystem setup... Nov 6 04:43:40.623162 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 6 04:43:40.623277 systemd[1]: Finished Root filesystem setup. Nov 6 04:43:40.625334 systemd[1]: Starting Ignition (files)... Nov 6 04:43:40.626501 systemd[1]: Starting /sysroot/boot... Nov 6 04:43:40.628578 ignition[582]: Ignition v0.36.1-15-gde4e6cc9 Nov 6 04:43:40.628594 ignition[582]: Stage: files Nov 6 04:43:40.628604 ignition[582]: reading system config file "/usr/lib/ignition/base.ign" Nov 6 04:43:40.628614 ignition[582]: no config at "/usr/lib/ignition/base.ign" Nov 6 04:43:40.629109 ignition[582]: files: compiled without relabeling support, skipping Nov 6 04:43:40.644415 systemd[1]: Finished /sysroot/boot. Nov 6 04:43:40.647746 ignition[582]: files: createUsers: op(1): [started] creating or modifying user "core" Nov 6 04:43:40.647757 ignition[582]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Nov 6 04:43:40.649588 ignition[582]: files: createUsers: op(1): [finished] creating or modifying user "core" Nov 6 04:43:40.649598 ignition[582]: files: createUsers: op(2): [started] adding ssh keys to user "core" Nov 6 04:43:40.652353 ignition[582]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Nov 6 04:43:40.652376 ignition[582]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Nov 6 04:43:40.653618 ignition[582]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Nov 6 04:43:40.653630 ignition[582]: files: op(4): [started] processing unit "coreos-metadata.service" Nov 6 04:43:40.653733 ignition[582]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Nov 6 04:43:40.657160 systemd[1]: ignition-files.service: Deactivated successfully. Nov 6 04:43:40.656533 ignition[582]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Nov 6 04:43:40.657255 systemd[1]: Finished Ignition (files). Nov 6 04:43:40.656539 ignition[582]: files: op(4): [finished] processing unit "coreos-metadata.service" Nov 6 04:43:40.658268 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Nov 6 04:43:40.656545 ignition[582]: files: files passed Nov 6 04:43:40.658855 systemd[1]: Starting Ignition (record completion)... Nov 6 04:43:40.656548 ignition[582]: Ignition finished successfully Nov 6 04:43:40.660912 systemd[1]: Starting Reload Configuration from the Real Root... Nov 6 04:43:40.662292 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 6 04:43:40.672592 kernel: audit: type=1334 audit(1762404220.670:7): prog-id=6 op=UNLOAD Nov 6 04:43:40.672617 kernel: audit: type=1334 audit(1762404220.670:8): prog-id=10 op=UNLOAD Nov 6 04:43:40.672626 kernel: audit: type=1334 audit(1762404220.671:9): prog-id=3 op=UNLOAD Nov 6 04:43:40.670000 audit: BPF prog-id=6 op=UNLOAD Nov 6 04:43:40.670000 audit: BPF prog-id=10 op=UNLOAD Nov 6 04:43:40.671000 audit: BPF prog-id=3 op=UNLOAD Nov 6 04:43:40.662396 systemd[1]: Finished Ignition (record completion). Nov 6 04:43:40.674818 kernel: audit: type=1334 audit(1762404220.672:10): prog-id=9 op=UNLOAD Nov 6 04:43:40.672000 audit: BPF prog-id=9 op=UNLOAD Nov 6 04:43:40.665462 systemd[1]: Reloading. Nov 6 04:43:40.751000 audit: BPF prog-id=11 op=LOAD Nov 6 04:43:40.751000 audit: BPF prog-id=12 op=LOAD Nov 6 04:43:40.751000 audit: BPF prog-id=13 op=LOAD Nov 6 04:43:40.751000 audit: BPF prog-id=7 op=UNLOAD Nov 6 04:43:40.751000 audit: BPF prog-id=8 op=UNLOAD Nov 6 04:43:40.751000 audit: BPF prog-id=14 op=LOAD Nov 6 04:43:40.752000 audit: BPF prog-id=15 op=LOAD Nov 6 04:43:40.752000 audit: BPF prog-id=16 op=LOAD Nov 6 04:43:40.752000 audit: BPF prog-id=17 op=LOAD Nov 6 04:43:40.752000 audit: BPF prog-id=4 op=UNLOAD Nov 6 04:43:40.752000 audit: BPF prog-id=5 op=UNLOAD Nov 6 04:43:40.752000 audit: BPF prog-id=18 op=LOAD Nov 6 04:43:40.766615 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 6 04:43:40.766727 systemd[1]: Finished Reload Configuration from the Real Root. Nov 6 04:43:40.768496 systemd[1]: Reached target Initrd File Systems. Nov 6 04:43:40.769833 systemd[1]: Reached target Initrd Default Target. Nov 6 04:43:40.771218 systemd[1]: Condition check resulted in dracut mount hook being skipped. Nov 6 04:43:40.771868 systemd[1]: Starting dracut pre-pivot and cleanup hook... Nov 6 04:43:40.782231 systemd[1]: Finished dracut pre-pivot and cleanup hook. Nov 6 04:43:40.783848 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Nov 6 04:43:40.790095 systemd[1]: Stopped target Host and Network Name Lookups. Nov 6 04:43:40.791082 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 6 04:43:40.792592 systemd[1]: Stopped target Timer Units. Nov 6 04:43:40.793815 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 6 04:43:40.793924 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Nov 6 04:43:40.795268 systemd[1]: Stopped target Initrd Default Target. Nov 6 04:43:40.796724 systemd[1]: Stopped target Basic System. Nov 6 04:43:40.798056 systemd[1]: Stopped target Initrd Root Device. Nov 6 04:43:40.799438 systemd[1]: Stopped target Path Units. Nov 6 04:43:40.800597 systemd[1]: Stopped target Remote File Systems. Nov 6 04:43:40.801869 systemd[1]: Stopped target Preparation for Remote File Systems. Nov 6 04:43:40.803290 systemd[1]: Stopped target Slice Units. Nov 6 04:43:40.804565 systemd[1]: Stopped target Socket Units. Nov 6 04:43:40.805952 systemd[1]: Stopped target System Initialization. Nov 6 04:43:40.807230 systemd[1]: Stopped target Local File Systems. Nov 6 04:43:40.808439 systemd[1]: Stopped target Preparation for Local File Systems. Nov 6 04:43:40.809949 systemd[1]: Stopped target Swaps. Nov 6 04:43:40.811142 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 6 04:43:40.811245 systemd[1]: Stopped dracut pre-mount hook. Nov 6 04:43:40.812591 systemd[1]: Stopped target Local Encrypted Volumes. Nov 6 04:43:40.813781 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 6 04:43:40.816996 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 6 04:43:40.818037 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 6 04:43:40.818134 systemd[1]: Stopped dracut initqueue hook. Nov 6 04:43:40.821584 iscsid[481]: iscsid shutting down. Nov 6 04:43:40.819747 systemd[1]: Stopping Open-iSCSI... Nov 6 04:43:40.821580 systemd[1]: Stopping /sysroot/boot... Nov 6 04:43:40.822166 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 6 04:43:40.822285 systemd[1]: Stopped Coldplug All udev Devices. Nov 6 04:43:40.823440 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 6 04:43:40.823534 systemd[1]: Stopped dracut pre-trigger hook. Nov 6 04:43:40.825526 systemd[1]: iscsid.service: Deactivated successfully. Nov 6 04:43:40.825646 systemd[1]: Stopped Open-iSCSI. Nov 6 04:43:40.827130 systemd[1]: iscsid.socket: Deactivated successfully. Nov 6 04:43:40.827192 systemd[1]: Closed Open-iSCSI iscsid Socket. Nov 6 04:43:40.829027 systemd[1]: Stopping iSCSI UserSpace I/O driver... Nov 6 04:43:40.830069 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 6 04:43:40.830184 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Nov 6 04:43:40.831729 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 6 04:43:40.831844 systemd[1]: Stopped iSCSI UserSpace I/O driver. Nov 6 04:43:40.833862 systemd[1]: Stopped target Network. Nov 6 04:43:40.835054 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 6 04:43:40.835117 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Nov 6 04:43:40.836414 systemd[1]: Stopping Network Name Resolution... Nov 6 04:43:40.837934 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 6 04:43:40.838058 systemd[1]: Stopped /sysroot/boot. Nov 6 04:43:40.842558 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 6 04:43:40.842668 systemd[1]: Stopped Network Name Resolution. Nov 6 04:43:40.848000 audit: BPF prog-id=14 op=UNLOAD Nov 6 04:43:40.843926 systemd[1]: Stopping Network Configuration... Nov 6 04:43:40.847068 systemd-networkd[417]: eth0: DHCP lease lost Nov 6 04:43:40.855317 systemd-networkd[417]: eth0: DHCPv6 lease lost Nov 6 04:43:40.856705 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 6 04:43:40.856851 systemd[1]: Stopped Network Configuration. Nov 6 04:43:40.858680 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 6 04:43:40.858710 systemd[1]: Closed Network Service Netlink Socket. Nov 6 04:43:40.860495 systemd[1]: Stopping Network Cleanup... Nov 6 04:43:40.861365 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 6 04:43:40.866000 audit: BPF prog-id=18 op=UNLOAD Nov 6 04:43:40.861427 systemd[1]: Stopped Apply Kernel Variables. Nov 6 04:43:40.862725 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Nov 6 04:43:40.868344 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 6 04:43:40.868450 systemd[1]: Stopped Network Cleanup. Nov 6 04:43:40.872400 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 6 04:43:40.872529 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Nov 6 04:43:40.874280 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 6 04:43:40.874319 systemd[1]: Closed udev Control Socket. Nov 6 04:43:40.875624 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 6 04:43:40.875657 systemd[1]: Closed udev Kernel Socket. Nov 6 04:43:40.877031 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 6 04:43:40.877073 systemd[1]: Stopped dracut pre-udev hook. Nov 6 04:43:40.878212 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 6 04:43:40.878249 systemd[1]: Stopped dracut cmdline hook. Nov 6 04:43:40.884000 audit: BPF prog-id=11 op=UNLOAD Nov 6 04:43:40.879727 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 6 04:43:40.879766 systemd[1]: Stopped dracut ask for additional cmdline parameters. Nov 6 04:43:40.881691 systemd[1]: Starting Cleanup udev Database... Nov 6 04:43:40.882532 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Nov 6 04:43:40.883825 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 6 04:43:40.883879 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 6 04:43:40.885592 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 6 04:43:40.885637 systemd[1]: Stopped Create List of Static Device Nodes. Nov 6 04:43:40.886890 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 6 04:43:40.886932 systemd[1]: Stopped Setup Virtual Console. Nov 6 04:43:40.888600 systemd[1]: rngd.service: Deactivated successfully. Nov 6 04:43:40.888706 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Nov 6 04:43:40.890102 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 6 04:43:40.890205 systemd[1]: Finished Cleanup udev Database. Nov 6 04:43:40.900000 audit: BPF prog-id=15 op=UNLOAD Nov 6 04:43:40.891416 systemd[1]: Reached target Switch Root. Nov 6 04:43:40.893311 systemd[1]: Starting Switch Root... Nov 6 04:43:40.898190 systemd[1]: Switching root. Nov 6 04:43:40.918536 systemd-journald[279]: Journal stopped Nov 6 04:43:43.074650 systemd-journald[279]: Received SIGTERM from PID 1 (systemd). Nov 6 04:43:43.074710 kernel: SELinux: policy capability network_peer_controls=1 Nov 6 04:43:43.074723 kernel: SELinux: policy capability open_perms=1 Nov 6 04:43:43.074732 kernel: SELinux: policy capability extended_socket_class=1 Nov 6 04:43:43.074742 kernel: SELinux: policy capability always_check_network=0 Nov 6 04:43:43.074757 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 6 04:43:43.074768 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 6 04:43:43.074778 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 6 04:43:43.074792 systemd[1]: Successfully loaded SELinux policy in 42.251ms. Nov 6 04:43:43.074812 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.396ms. Nov 6 04:43:43.074828 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 6 04:43:43.074840 systemd[1]: Detected virtualization kvm. Nov 6 04:43:43.074850 systemd[1]: Detected architecture arm64. Nov 6 04:43:43.074860 systemd[1]: Detected first boot. Nov 6 04:43:43.074870 systemd[1]: Initializing machine ID from VM UUID. Nov 6 04:43:43.074880 systemd[1]: Populated /etc with preset unit settings. Nov 6 04:43:43.074892 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 6 04:43:43.074904 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 6 04:43:43.074914 kernel: kauditd_printk_skb: 24 callbacks suppressed Nov 6 04:43:43.074925 kernel: audit: type=1334 audit(1762404222.933:35): prog-id=21 op=LOAD Nov 6 04:43:43.074934 kernel: audit: type=1334 audit(1762404222.935:36): prog-id=22 op=LOAD Nov 6 04:43:43.074943 kernel: audit: type=1334 audit(1762404222.936:37): prog-id=23 op=LOAD Nov 6 04:43:43.074953 kernel: audit: type=1334 audit(1762404222.936:38): prog-id=16 op=UNLOAD Nov 6 04:43:43.074962 kernel: audit: type=1334 audit(1762404222.936:39): prog-id=17 op=UNLOAD Nov 6 04:43:43.074985 kernel: audit: type=1334 audit(1762404222.942:40): prog-id=24 op=LOAD Nov 6 04:43:43.074996 kernel: audit: type=1334 audit(1762404222.942:41): prog-id=21 op=UNLOAD Nov 6 04:43:43.075006 kernel: audit: type=1334 audit(1762404222.943:42): prog-id=25 op=LOAD Nov 6 04:43:43.075016 kernel: audit: type=1334 audit(1762404222.944:43): prog-id=26 op=LOAD Nov 6 04:43:43.075025 kernel: audit: type=1334 audit(1762404222.944:44): prog-id=22 op=UNLOAD Nov 6 04:43:43.075036 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 6 04:43:43.075045 systemd[1]: Stopped Switch Root. Nov 6 04:43:43.075055 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 6 04:43:43.075066 systemd[1]: Created slice Slice /system/addon-config. Nov 6 04:43:43.075077 systemd[1]: Created slice Slice /system/addon-run. Nov 6 04:43:43.075087 systemd[1]: Created slice Slice /system/getty. Nov 6 04:43:43.075097 systemd[1]: Created slice Slice /system/modprobe. Nov 6 04:43:43.075107 systemd[1]: Created slice Slice /system/serial-getty. Nov 6 04:43:43.075117 systemd[1]: Created slice Slice /system/system-cloudinit. Nov 6 04:43:43.075127 systemd[1]: Created slice Slice /system/systemd-fsck. Nov 6 04:43:43.075137 systemd[1]: Created slice User and Session Slice. Nov 6 04:43:43.075147 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 6 04:43:43.075157 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Nov 6 04:43:43.075169 systemd[1]: Set up automount Boot partition Automount Point. Nov 6 04:43:43.075179 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 6 04:43:43.075190 systemd[1]: Stopped target Switch Root. Nov 6 04:43:43.075199 systemd[1]: Stopped target Initrd File Systems. Nov 6 04:43:43.075209 systemd[1]: Stopped target Initrd Root File System. Nov 6 04:43:43.075219 systemd[1]: Reached target Remote Encrypted Volumes. Nov 6 04:43:43.075229 systemd[1]: Reached target Remote File Systems. Nov 6 04:43:43.075239 systemd[1]: Reached target Slice Units. Nov 6 04:43:43.075249 systemd[1]: Reached target Swaps. Nov 6 04:43:43.075260 systemd[1]: Reached target Verify torcx succeeded. Nov 6 04:43:43.075271 systemd[1]: Reached target Local Verity Protected Volumes. Nov 6 04:43:43.075280 systemd[1]: Listening on Process Core Dump Socket. Nov 6 04:43:43.075291 systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 6 04:43:43.075301 systemd[1]: Listening on Network Service Netlink Socket. Nov 6 04:43:43.075311 systemd[1]: Listening on udev Control Socket. Nov 6 04:43:43.075321 systemd[1]: Listening on udev Kernel Socket. Nov 6 04:43:43.075330 systemd[1]: Mounting Huge Pages File System... Nov 6 04:43:43.075340 systemd[1]: Mounting POSIX Message Queue File System... Nov 6 04:43:43.075351 systemd[1]: Mounting External Media Directory... Nov 6 04:43:43.075362 systemd[1]: Mounting Kernel Debug File System... Nov 6 04:43:43.075372 systemd[1]: Mounting Kernel Trace File System... Nov 6 04:43:43.075382 systemd[1]: Mounting Temporary Directory /tmp... Nov 6 04:43:43.075392 systemd[1]: Starting Create missing system files... Nov 6 04:43:43.075402 systemd[1]: Starting Create List of Static Device Nodes... Nov 6 04:43:43.075411 systemd[1]: Starting Load Kernel Module configfs... Nov 6 04:43:43.075422 systemd[1]: Starting Load Kernel Module drm... Nov 6 04:43:43.075431 systemd[1]: Starting Load Kernel Module fuse... Nov 6 04:43:43.075442 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Nov 6 04:43:43.075454 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 6 04:43:43.075463 systemd[1]: Stopped File System Check on Root Device. Nov 6 04:43:43.075487 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 6 04:43:43.075500 systemd[1]: Stopped systemd-fsck-usr.service. Nov 6 04:43:43.075510 kernel: fuse: init (API version 7.32) Nov 6 04:43:43.075520 systemd[1]: Stopped Journal Service. Nov 6 04:43:43.075530 systemd[1]: Starting Journal Service... Nov 6 04:43:43.075540 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 6 04:43:43.075550 systemd[1]: Starting Remount Root and Kernel File Systems... Nov 6 04:43:43.075560 systemd[1]: Starting Apply Kernel Variables... Nov 6 04:43:43.075572 systemd[1]: Starting Coldplug All udev Devices... Nov 6 04:43:43.075582 systemd[1]: verity-setup.service: Deactivated successfully. Nov 6 04:43:43.075592 systemd[1]: Stopped verity-setup.service. Nov 6 04:43:43.075601 systemd[1]: Mounted Huge Pages File System. Nov 6 04:43:43.075611 systemd[1]: Mounted POSIX Message Queue File System. Nov 6 04:43:43.075621 systemd[1]: Mounted External Media Directory. Nov 6 04:43:43.075630 systemd[1]: Mounted Kernel Debug File System. Nov 6 04:43:43.075640 systemd[1]: Mounted Kernel Trace File System. Nov 6 04:43:43.075650 systemd[1]: Mounted Temporary Directory /tmp. Nov 6 04:43:43.075661 systemd[1]: Finished Create missing system files. Nov 6 04:43:43.075672 systemd-journald[798]: Journal started Nov 6 04:43:43.075710 systemd-journald[798]: Runtime Journal (/run/log/journal/c32df9d9ae204426bdc50dcd85a862e0) is 6.0M, max 48.5M, 42.4M free. Nov 6 04:43:40.991000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 6 04:43:41.021000 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 6 04:43:41.021000 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 6 04:43:41.021000 audit: BPF prog-id=19 op=LOAD Nov 6 04:43:41.021000 audit: BPF prog-id=19 op=UNLOAD Nov 6 04:43:41.021000 audit: BPF prog-id=20 op=LOAD Nov 6 04:43:41.021000 audit: BPF prog-id=20 op=UNLOAD Nov 6 04:43:41.053000 audit[747]: AVC avc: denied { associate } for pid=747 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 6 04:43:42.933000 audit: BPF prog-id=21 op=LOAD Nov 6 04:43:42.935000 audit: BPF prog-id=22 op=LOAD Nov 6 04:43:42.936000 audit: BPF prog-id=23 op=LOAD Nov 6 04:43:42.936000 audit: BPF prog-id=16 op=UNLOAD Nov 6 04:43:42.936000 audit: BPF prog-id=17 op=UNLOAD Nov 6 04:43:42.942000 audit: BPF prog-id=24 op=LOAD Nov 6 04:43:42.942000 audit: BPF prog-id=21 op=UNLOAD Nov 6 04:43:42.943000 audit: BPF prog-id=25 op=LOAD Nov 6 04:43:42.944000 audit: BPF prog-id=26 op=LOAD Nov 6 04:43:42.944000 audit: BPF prog-id=22 op=UNLOAD Nov 6 04:43:42.944000 audit: BPF prog-id=23 op=UNLOAD Nov 6 04:43:42.945000 audit: BPF prog-id=27 op=LOAD Nov 6 04:43:42.945000 audit: BPF prog-id=24 op=UNLOAD Nov 6 04:43:42.946000 audit: BPF prog-id=28 op=LOAD Nov 6 04:43:42.947000 audit: BPF prog-id=29 op=LOAD Nov 6 04:43:42.947000 audit: BPF prog-id=25 op=UNLOAD Nov 6 04:43:42.947000 audit: BPF prog-id=26 op=UNLOAD Nov 6 04:43:42.956000 audit: BPF prog-id=27 op=UNLOAD Nov 6 04:43:43.046000 audit: BPF prog-id=30 op=LOAD Nov 6 04:43:43.046000 audit: BPF prog-id=31 op=LOAD Nov 6 04:43:43.046000 audit: BPF prog-id=32 op=LOAD Nov 6 04:43:43.046000 audit: BPF prog-id=28 op=UNLOAD Nov 6 04:43:43.046000 audit: BPF prog-id=29 op=UNLOAD Nov 6 04:43:41.052883 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" 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 6 04:43:42.934144 systemd[1]: Queued start job for default target Multi-User System. Nov 6 04:43:41.053150 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 6 04:43:42.948457 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 6 04:43:41.053168 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 6 04:43:41.053276 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 6 04:43:41.053286 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 6 04:43:41.053314 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 6 04:43:41.053326 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 6 04:43:41.053524 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 6 04:43:41.053557 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 6 04:43:41.053571 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 6 04:43:41.053976 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" 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 6 04:43:41.054008 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" 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 6 04:43:41.054029 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" 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 6 04:43:41.054044 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Nov 6 04:43:41.054062 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" 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 6 04:43:41.054076 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:41Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 6 04:43:42.758357 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:42Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 6 04:43:43.078841 systemd[1]: Started Journal Service. Nov 6 04:43:43.073000 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 6 04:43:43.078825 systemd[1]: Finished Create List of Static Device Nodes. Nov 6 04:43:42.758640 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:42Z" 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 6 04:43:42.758745 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:42Z" 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 6 04:43:42.758870 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:42Z" 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 6 04:43:42.758924 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:42Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 6 04:43:42.759002 /usr/lib/systemd/system-generators/torcx-generator[747]: time="2025-11-06T04:43:42Z" 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 6 04:43:43.080076 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 6 04:43:43.080272 systemd[1]: Finished Load Kernel Module configfs. Nov 6 04:43:43.087372 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 6 04:43:43.087564 systemd[1]: Finished Load Kernel Module drm. Nov 6 04:43:43.088561 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 6 04:43:43.088737 systemd[1]: Finished Load Kernel Module fuse. Nov 6 04:43:43.089850 systemd[1]: Finished Remount Root and Kernel File Systems. Nov 6 04:43:43.091147 systemd[1]: Finished Apply Kernel Variables. Nov 6 04:43:43.094024 systemd[1]: Mounting FUSE Control File System... Nov 6 04:43:43.095823 systemd[1]: Mounting Kernel Configuration File System... Nov 6 04:43:43.096671 systemd[1]: Condition check resulted in Remount Root File System being skipped. Nov 6 04:43:43.100044 systemd[1]: Starting Rebuild Hardware Database... Nov 6 04:43:43.104075 systemd[1]: Starting Flush Journal to Persistent Storage... Nov 6 04:43:43.105363 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Nov 6 04:43:43.107669 systemd-journald[798]: Time spent on flushing to /var/log/journal/c32df9d9ae204426bdc50dcd85a862e0 is 8.891ms for 782 entries. Nov 6 04:43:43.107669 systemd-journald[798]: System Journal (/var/log/journal/c32df9d9ae204426bdc50dcd85a862e0) is 8.0M, max 203.0M, 195.0M free. Nov 6 04:43:43.107613 systemd[1]: Starting Load/Save Random Seed... Nov 6 04:43:43.110697 systemd[1]: Starting Create System Users... Nov 6 04:43:43.113088 systemd[1]: Mounted FUSE Control File System. Nov 6 04:43:43.114472 systemd[1]: Mounted Kernel Configuration File System. Nov 6 04:43:43.116176 systemd[1]: Finished Coldplug All udev Devices. Nov 6 04:43:43.117384 systemd[1]: Finished Load/Save Random Seed. Nov 6 04:43:43.118334 systemd[1]: Reached target First Boot Complete. Nov 6 04:43:43.120257 systemd[1]: Starting Wait for udev To Complete Device Initialization... Nov 6 04:43:43.122831 systemd-sysusers[811]: Creating group sgx with gid 999. Nov 6 04:43:43.123859 systemd-sysusers[811]: Creating group systemd-oom with gid 998. Nov 6 04:43:43.124527 systemd-sysusers[811]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Nov 6 04:43:43.125547 systemd-sysusers[811]: Creating group systemd-timesync with gid 997. Nov 6 04:43:43.126238 systemd-sysusers[811]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Nov 6 04:43:43.127425 systemd-sysusers[811]: Creating group systemd-coredump with gid 996. Nov 6 04:43:43.128095 systemd-sysusers[811]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Nov 6 04:43:43.130422 systemd[1]: Finished Flush Journal to Persistent Storage. Nov 6 04:43:43.144337 systemd[1]: Finished Create System Users. Nov 6 04:43:43.146293 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 6 04:43:43.159703 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 6 04:43:43.357307 systemd[1]: Finished Rebuild Hardware Database. Nov 6 04:43:43.366000 audit: BPF prog-id=33 op=LOAD Nov 6 04:43:43.366000 audit: BPF prog-id=34 op=LOAD Nov 6 04:43:43.366000 audit: BPF prog-id=35 op=LOAD Nov 6 04:43:43.366000 audit: BPF prog-id=12 op=UNLOAD Nov 6 04:43:43.366000 audit: BPF prog-id=13 op=UNLOAD Nov 6 04:43:43.368401 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 6 04:43:43.390640 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 6 04:43:43.399000 audit: BPF prog-id=36 op=LOAD Nov 6 04:43:43.401162 systemd[1]: Starting Network Configuration... Nov 6 04:43:43.420769 systemd-udevd[818]: Using default interface naming scheme 'v249'. Nov 6 04:43:43.429668 systemd-networkd[835]: lo: Link UP Nov 6 04:43:43.429677 systemd-networkd[835]: lo: Gained carrier Nov 6 04:43:43.429980 systemd-networkd[835]: Enumeration completed Nov 6 04:43:43.430071 systemd[1]: Started Network Configuration. Nov 6 04:43:43.431349 systemd-networkd[835]: eth0: Link UP Nov 6 04:43:43.446101 systemd-networkd[835]: eth0: Gained carrier Nov 6 04:43:43.451170 systemd-networkd[835]: eth0: DHCPv4 address 10.0.0.3/16 via 10.0.0.1 Nov 6 04:43:43.452646 udevadm[813]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Nov 6 04:43:43.477161 systemd[1]: Finished Wait for udev To Complete Device Initialization. Nov 6 04:43:43.487909 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 6 04:43:43.496135 lvm[843]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 6 04:43:43.520908 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 6 04:43:43.521933 systemd[1]: Reached target Local Encrypted Volumes. Nov 6 04:43:43.538869 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 6 04:43:43.541974 lvm[844]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 6 04:43:43.570841 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 6 04:43:43.571878 systemd[1]: Reached target Preparation for Local File Systems. Nov 6 04:43:43.572902 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Nov 6 04:43:43.572927 systemd[1]: Reached target Containers. Nov 6 04:43:43.586192 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Nov 6 04:43:43.597905 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Nov 6 04:43:43.600098 systemd[1]: Mounting /usr/share/oem... Nov 6 04:43:43.606000 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 6 04:43:43.606075 kernel: BTRFS info (device vda6): has skinny extents Nov 6 04:43:43.608370 systemd[1]: Mounted /usr/share/oem. Nov 6 04:43:43.609152 systemd[1]: Reached target Local File Systems. Nov 6 04:43:43.619799 systemd[1]: Starting Rebuild Dynamic Linker Cache... Nov 6 04:43:43.623630 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 6 04:43:43.623676 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Nov 6 04:43:43.624648 systemd[1]: Starting Commit a transient machine-id on disk... Nov 6 04:43:43.626571 systemd[1]: Starting Create Volatile Files and Directories... Nov 6 04:43:43.636917 systemd-tmpfiles[869]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 6 04:43:43.638598 systemd-tmpfiles[869]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Nov 6 04:43:43.643055 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 6 04:43:43.643642 systemd[1]: Finished Commit a transient machine-id on disk. Nov 6 04:43:43.677617 systemd-tmpfiles[869]: Detected autofs mount point /boot during canonicalization of /boot. Nov 6 04:43:43.677627 systemd-tmpfiles[869]: Skipping /boot Nov 6 04:43:43.682348 systemd-tmpfiles[869]: Detected autofs mount point /boot during canonicalization of /boot. Nov 6 04:43:43.682366 systemd-tmpfiles[869]: Skipping /boot Nov 6 04:43:43.706576 systemd[1]: Finished Rebuild Dynamic Linker Cache. Nov 6 04:43:43.726317 systemd[1]: Finished Create Volatile Files and Directories. Nov 6 04:43:43.728429 systemd[1]: Starting Load Security Auditing Rules... Nov 6 04:43:43.730251 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Nov 6 04:43:43.732306 systemd[1]: Starting Rebuild Journal Catalog... Nov 6 04:43:43.732000 audit: BPF prog-id=37 op=LOAD Nov 6 04:43:43.734421 systemd[1]: Starting Network Name Resolution... Nov 6 04:43:43.736000 audit: BPF prog-id=38 op=LOAD Nov 6 04:43:43.738031 systemd[1]: Starting Network Time Synchronization... Nov 6 04:43:43.739945 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Nov 6 04:43:43.741552 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Nov 6 04:43:43.742897 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Nov 6 04:43:43.746322 systemd[1]: Finished Rebuild Journal Catalog. Nov 6 04:43:43.753861 systemd[1]: Starting Update is Completed... Nov 6 04:43:43.756437 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Nov 6 04:43:43.759921 systemd[1]: Finished Update is Completed. Nov 6 04:43:43.760000 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 6 04:43:43.761185 augenrules[890]: No rules Nov 6 04:43:43.762120 systemd[1]: Finished Load Security Auditing Rules. Nov 6 04:43:43.775871 systemd-resolved[876]: Positive Trust Anchors: Nov 6 04:43:43.775881 systemd-resolved[876]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 6 04:43:43.775909 systemd-resolved[876]: 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 6 04:43:43.776557 systemd[1]: Started Network Time Synchronization. Nov 6 04:43:43.776681 systemd-resolved[876]: Defaulting to hostname 'linux'. Nov 6 04:43:43.777222 systemd-timesyncd[880]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Nov 6 04:43:43.777693 systemd[1]: Reached target System Initialization. Nov 6 04:43:43.778688 systemd[1]: Started Watch for update engine configuration changes. Nov 6 04:43:43.779791 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 6 04:43:43.780918 systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 6 04:43:43.781928 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Nov 6 04:43:43.781961 systemd[1]: Reached target Path Units. Nov 6 04:43:43.782653 systemd[1]: Reached target System Time Set. Nov 6 04:43:43.783618 systemd[1]: Started Daily Log Rotation. Nov 6 04:43:43.784496 systemd[1]: Started Weekly check for MD array's redundancy information.. Nov 6 04:43:43.785581 systemd[1]: Reached target Timer Units. Nov 6 04:43:43.786705 systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 6 04:43:43.797621 systemd[1]: Starting Docker Socket for the API... Nov 6 04:43:43.800699 systemd[1]: Listening on OpenSSH Server Socket. Nov 6 04:43:43.801981 systemd[1]: Started Network Name Resolution. Nov 6 04:43:43.802843 systemd[1]: Listening on Docker Socket for the API. Nov 6 04:43:43.803757 systemd[1]: Reached target Network. Nov 6 04:43:43.804455 systemd[1]: Reached target Host and Network Name Lookups. Nov 6 04:43:43.805416 systemd[1]: Reached target Socket Units. Nov 6 04:43:43.806121 systemd[1]: Reached target Basic System. Nov 6 04:43:43.806881 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Nov 6 04:43:43.806912 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Nov 6 04:43:43.808004 systemd[1]: Started D-Bus System Message Bus. Nov 6 04:43:43.811075 systemd[1]: Starting Extend Filesystems... Nov 6 04:43:43.811833 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Nov 6 04:43:43.812781 systemd[1]: Starting Generate /run/flatcar/motd... Nov 6 04:43:43.814871 systemd[1]: Starting Install an ssh key from /proc/cmdline... Nov 6 04:43:43.816830 systemd[1]: Starting Generate sshd host keys... Nov 6 04:43:43.817850 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Nov 6 04:43:43.817899 systemd[1]: Reached target Load system-provided cloud configs. Nov 6 04:43:43.821067 systemd[1]: Starting User Login Management... Nov 6 04:43:43.822401 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 6 04:43:43.823295 systemd[1]: Starting Update Engine... Nov 6 04:43:43.824470 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Nov 6 04:43:43.824518 systemd[1]: Reached target Load user-provided cloud configs. Nov 6 04:43:43.824602 extend-filesystems[900]: Found vda Nov 6 04:43:43.824602 extend-filesystems[900]: Found vda1 Nov 6 04:43:43.826925 extend-filesystems[900]: Found vda2 Nov 6 04:43:43.826925 extend-filesystems[900]: Found vda3 Nov 6 04:43:43.826925 extend-filesystems[900]: Found usr Nov 6 04:43:43.826925 extend-filesystems[900]: Found vda4 Nov 6 04:43:43.826925 extend-filesystems[900]: Found vda6 Nov 6 04:43:43.826925 extend-filesystems[900]: Found vda7 Nov 6 04:43:43.826925 extend-filesystems[900]: Found vda9 Nov 6 04:43:43.826925 extend-filesystems[900]: Checking size of /dev/vda9 Nov 6 04:43:43.826507 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 6 04:43:43.826747 systemd[1]: Finished Install an ssh key from /proc/cmdline. Nov 6 04:43:43.831387 systemd[1]: motdgen.service: Deactivated successfully. Nov 6 04:43:43.831610 systemd[1]: Finished Generate /run/flatcar/motd. Nov 6 04:43:43.848312 extend-filesystems[900]: Old size kept for /dev/vda9 Nov 6 04:43:43.848827 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 6 04:43:43.849074 systemd[1]: Finished Extend Filesystems. Nov 6 04:43:43.856740 systemd-logind[911]: Watching system buttons on /dev/input/event0 (Power Button) Nov 6 04:43:43.859227 systemd-logind[911]: New seat seat0. Nov 6 04:43:43.861758 systemd[1]: Started User Login Management. Nov 6 04:43:43.861847 update_engine[915]: I1106 04:43:43.861521 915 main.cc:89] Flatcar Update Engine starting Nov 6 04:43:43.864875 systemd[1]: Started Update Engine. Nov 6 04:43:43.865133 update_engine[915]: I1106 04:43:43.865085 915 update_check_scheduler.cc:74] Next update check in 2m59s Nov 6 04:43:43.871269 systemd[1]: Started Cluster reboot manager. Nov 6 04:43:43.900088 locksmithd[923]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 6 04:43:44.345182 sshd_keygen[916]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Nov 6 04:43:44.363594 systemd[1]: Finished Generate sshd host keys. Nov 6 04:43:44.374120 systemd[1]: Starting Generate /run/issue... Nov 6 04:43:44.378377 systemd[1]: issuegen.service: Deactivated successfully. Nov 6 04:43:44.378616 systemd[1]: Finished Generate /run/issue. Nov 6 04:43:44.380829 systemd[1]: Starting Permit User Sessions... Nov 6 04:43:44.385314 systemd[1]: Finished Permit User Sessions. Nov 6 04:43:44.387366 systemd[1]: Started Getty on tty1. Nov 6 04:43:44.389220 systemd[1]: Started Serial Getty on ttyAMA0. Nov 6 04:43:44.390140 systemd[1]: Reached target Login Prompts. Nov 6 04:43:44.391062 systemd[1]: Reached target Multi-User System. Nov 6 04:43:44.393009 systemd[1]: Starting Record Runlevel Change in UTMP... Nov 6 04:43:44.398090 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 6 04:43:44.398317 systemd[1]: Finished Record Runlevel Change in UTMP. Nov 6 04:43:44.399327 systemd[1]: Startup finished in 689ms (kernel) + 2.381s (initrd) + 3.451s (userspace) = 6.522s. Nov 6 04:43:44.440944 systemd[1]: Created slice Slice /system/sshd. Nov 6 04:43:44.442049 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52538). Nov 6 04:43:44.479085 sshd[944]: Accepted publickey for core from 10.0.0.1 port 52538 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:44.480866 sshd[944]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:44.495455 systemd[1]: Created slice User Slice of UID 500. Nov 6 04:43:44.496572 systemd[1]: Starting User Runtime Directory /run/user/500... Nov 6 04:43:44.498151 systemd-logind[911]: New session 1 of user core. Nov 6 04:43:44.503024 systemd[1]: Finished User Runtime Directory /run/user/500. Nov 6 04:43:44.504262 systemd[1]: Starting User Manager for UID 500... Nov 6 04:43:44.506482 systemd[947]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:44.553204 systemd[947]: Queued start job for default target Main User Target. Nov 6 04:43:44.553369 systemd[947]: Reached target Paths. Nov 6 04:43:44.553383 systemd[947]: Reached target Sockets. Nov 6 04:43:44.553394 systemd[947]: Reached target Timers. Nov 6 04:43:44.553404 systemd[947]: Reached target Basic System. Nov 6 04:43:44.553445 systemd[947]: Reached target Main User Target. Nov 6 04:43:44.553458 systemd[947]: Startup finished in 43ms. Nov 6 04:43:44.553735 systemd[1]: Started User Manager for UID 500. Nov 6 04:43:44.560121 systemd[1]: Started Session 1 of User core. Nov 6 04:43:44.621689 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52558). Nov 6 04:43:44.658633 sshd[956]: Accepted publickey for core from 10.0.0.1 port 52558 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:44.659613 sshd[956]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:44.663716 systemd-logind[911]: New session 2 of user core. Nov 6 04:43:44.673126 systemd[1]: Started Session 2 of User core. Nov 6 04:43:44.728374 sshd[956]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:44.740709 systemd[1]: sshd@1-10.0.0.3:22-10.0.0.1:52558.service: Deactivated successfully. Nov 6 04:43:44.741398 systemd[1]: session-2.scope: Deactivated successfully. Nov 6 04:43:44.742038 systemd-logind[911]: Session 2 logged out. Waiting for processes to exit. Nov 6 04:43:44.743042 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52566). Nov 6 04:43:44.743685 systemd-logind[911]: Removed session 2. Nov 6 04:43:44.778841 sshd[962]: Accepted publickey for core from 10.0.0.1 port 52566 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:44.781020 sshd[962]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:44.784497 systemd-logind[911]: New session 3 of user core. Nov 6 04:43:44.793131 systemd[1]: Started Session 3 of User core. Nov 6 04:43:44.840803 sshd[962]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:44.853560 systemd[1]: sshd@2-10.0.0.3:22-10.0.0.1:52566.service: Deactivated successfully. Nov 6 04:43:44.854189 systemd[1]: session-3.scope: Deactivated successfully. Nov 6 04:43:44.854817 systemd-logind[911]: Session 3 logged out. Waiting for processes to exit. Nov 6 04:43:44.855744 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52574). Nov 6 04:43:44.856553 systemd-logind[911]: Removed session 3. Nov 6 04:43:44.885182 systemd-networkd[835]: eth0: Gained IPv6LL Nov 6 04:43:44.889655 sshd[969]: Accepted publickey for core from 10.0.0.1 port 52574 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:44.890897 sshd[969]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:44.893751 systemd-logind[911]: New session 4 of user core. Nov 6 04:43:44.905140 systemd[1]: Started Session 4 of User core. Nov 6 04:43:44.956426 sshd[969]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:44.965972 systemd[1]: sshd@3-10.0.0.3:22-10.0.0.1:52574.service: Deactivated successfully. Nov 6 04:43:44.966623 systemd[1]: session-4.scope: Deactivated successfully. Nov 6 04:43:44.967303 systemd-logind[911]: Session 4 logged out. Waiting for processes to exit. Nov 6 04:43:44.968287 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52576). Nov 6 04:43:44.969494 systemd-logind[911]: Removed session 4. Nov 6 04:43:45.002880 sshd[975]: Accepted publickey for core from 10.0.0.1 port 52576 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:45.004294 sshd[975]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:45.007254 systemd-logind[911]: New session 5 of user core. Nov 6 04:43:45.015140 systemd[1]: Started Session 5 of User core. Nov 6 04:43:45.070685 sudo[978]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Nov 6 04:43:45.072151 sudo[978]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 6 04:43:45.084919 sudo[978]: pam_unix(sudo:session): session closed for user root Nov 6 04:43:45.087548 sshd[975]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:45.099766 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52578). Nov 6 04:43:45.101277 dbus-daemon[899]: [system] Reloaded configuration Nov 6 04:43:45.103900 systemd[1]: sshd@4-10.0.0.3:22-10.0.0.1:52576.service: Deactivated successfully. Nov 6 04:43:45.104562 systemd[1]: session-5.scope: Deactivated successfully. Nov 6 04:43:45.106674 systemd-logind[911]: Session 5 logged out. Waiting for processes to exit. Nov 6 04:43:45.107469 systemd-logind[911]: Removed session 5. Nov 6 04:43:45.133949 sshd[981]: Accepted publickey for core from 10.0.0.1 port 52578 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:45.135305 sshd[981]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:45.138735 systemd-logind[911]: New session 6 of user core. Nov 6 04:43:45.145107 systemd[1]: Started Session 6 of User core. Nov 6 04:43:45.195568 sudo[987]: 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 6 04:43:45.195808 sudo[987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 6 04:43:45.198519 sudo[987]: pam_unix(sudo:session): session closed for user root Nov 6 04:43:45.202325 sudo[986]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Nov 6 04:43:45.202533 sudo[986]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 6 04:43:45.219915 systemd[1]: Stopping Load Security Auditing Rules... Nov 6 04:43:45.220000 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 6 04:43:45.222190 auditctl[990]: No rules Nov 6 04:43:45.222466 systemd[1]: audit-rules.service: Deactivated successfully. Nov 6 04:43:45.222718 systemd[1]: Stopped Load Security Auditing Rules. Nov 6 04:43:45.224017 systemd[1]: Starting Load Security Auditing Rules... Nov 6 04:43:45.242863 augenrules[1007]: No rules Nov 6 04:43:45.243617 systemd[1]: Finished Load Security Auditing Rules. Nov 6 04:43:45.244474 sudo[986]: pam_unix(sudo:session): session closed for user root Nov 6 04:43:45.245726 sshd[981]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:45.256632 systemd[1]: sshd@5-10.0.0.3:22-10.0.0.1:52578.service: Deactivated successfully. Nov 6 04:43:45.257164 systemd[1]: session-6.scope: Deactivated successfully. Nov 6 04:43:45.257810 systemd-logind[911]: Session 6 logged out. Waiting for processes to exit. Nov 6 04:43:45.258770 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:52594). Nov 6 04:43:45.259776 systemd-logind[911]: Removed session 6. Nov 6 04:43:45.293608 sshd[1013]: Accepted publickey for core from 10.0.0.1 port 52594 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:45.294900 sshd[1013]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:45.297705 systemd-logind[911]: New session 7 of user core. Nov 6 04:43:45.307139 systemd[1]: Started Session 7 of User core. Nov 6 04:43:45.357920 sudo[1016]: 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 6 04:43:48.022604 update_engine[1264]: Nov 6 04:43:48.022604 update_engine[1264]: Nov 6 04:43:48.022604 update_engine[1264]: Nov 6 04:43:48.022604 update_engine[1264]: Nov 6 04:43:48.022604 update_engine[1264]: Nov 6 04:43:48.022604 update_engine[1264]: Nov 6 04:43:48.022604 update_engine[1264]: Nov 6 04:43:48.022604 update_engine[1264]: Nov 6 04:43:48.022604 update_engine[1264]: I1106 04:43:48.022385 1264 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Nov 6 04:43:48.022403 systemd-logind[911]: Removed session 24. Nov 6 04:43:48.025381 update_engine[1264]: I1106 04:43:48.025353 1264 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Nov 6 04:43:48.025655 update_engine[1264]: I1106 04:43:48.025625 1264 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Nov 6 04:43:48.027308 update_engine[1264]: I1106 04:43:48.027272 1264 libcurl_http_fetcher.cc:248] HTTP response code: 200 Nov 6 04:43:48.028612 update_engine[1264]: I1106 04:43:48.027390 1264 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Nov 6 04:43:48.028612 update_engine[1264]: I1106 04:43:48.028606 1264 omaha_request_action.cc:619] Omaha request response: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.028612 update_engine[1264]: Nov 6 04:43:48.032814 update_engine[1264]: I1106 04:43:48.032770 1264 omaha_request_action.cc:447] Omaha Response manifest version = Nov 6 04:43:48.032814 update_engine[1264]: I1106 04:43:48.032805 1264 omaha_request_action.cc:470] Found 1 url(s) Nov 6 04:43:48.032814 update_engine[1264]: I1106 04:43:48.032819 1264 omaha_request_action.cc:506] Processing first of 1 package(s) Nov 6 04:43:48.032930 update_engine[1264]: I1106 04:43:48.032823 1264 omaha_request_action.cc:513] Omaha Response package name = update.gz Nov 6 04:43:48.032930 update_engine[1264]: I1106 04:43:48.032826 1264 omaha_request_action.cc:529] Url0: http://10.0.0.2:34567/packages/update.gz Nov 6 04:43:48.032930 update_engine[1264]: I1106 04:43:48.032836 1264 omaha_request_action.cc:541] Payload size = 434038479 bytes Nov 6 04:43:48.032930 update_engine[1264]: I1106 04:43:48.032846 1264 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Nov 6 04:43:48.032930 update_engine[1264]: I1106 04:43:48.032858 1264 payload_state.cc:51] Resetting all persisted state as this is a new response Nov 6 04:43:48.032930 update_engine[1264]: I1106 04:43:48.032862 1264 payload_state.cc:360] Current Response Signature = Nov 6 04:43:48.032930 update_engine[1264]: NumURLs = 1 Nov 6 04:43:48.032930 update_engine[1264]: Url0 = http://10.0.0.2:34567/packages/update.gz Nov 6 04:43:48.032930 update_engine[1264]: Payload Size = 434038479 Nov 6 04:43:48.032930 update_engine[1264]: Payload Sha256 Hash = khqRMHuZIPKN4kcwxShqRXyUc6wqJFavlp0HB0NXSnY= Nov 6 04:43:48.032930 update_engine[1264]: Is Delta Payload = 0 Nov 6 04:43:48.032930 update_engine[1264]: Max Failure Count Per Url = 10 Nov 6 04:43:48.032930 update_engine[1264]: Disable Payload Backoff = 1 Nov 6 04:43:48.033160 update_engine[1264]: I1106 04:43:48.032984 1264 payload_state.cc:381] Payload Attempt Number = 0 Nov 6 04:43:48.033160 update_engine[1264]: I1106 04:43:48.033025 1264 payload_state.cc:404] Current URL Index = 0 Nov 6 04:43:48.033160 update_engine[1264]: I1106 04:43:48.033054 1264 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Nov 6 04:43:48.033160 update_engine[1264]: I1106 04:43:48.033083 1264 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Nov 6 04:43:48.033160 update_engine[1264]: I1106 04:43:48.033087 1264 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Nov 6 04:43:48.033160 update_engine[1264]: I1106 04:43:48.033118 1264 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Nov 6 04:43:48.033160 update_engine[1264]: I1106 04:43:48.033140 1264 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Nov 6 04:43:48.033160 update_engine[1264]: I1106 04:43:48.033144 1264 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Nov 6 04:43:48.033160 update_engine[1264]: I1106 04:43:48.033159 1264 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Nov 6 04:43:48.033160 update_engine[1264]: E1106 04:43:48.033164 1264 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Nov 6 04:43:48.033750 update_engine[1264]: I1106 04:43:48.033716 1264 omaha_response_handler_action.cc:85] Using this install plan: Nov 6 04:43:48.033750 update_engine[1264]: I1106 04:43:48.033731 1264 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.2:34567/packages/update.gz, payload size: 434038479, payload hash: khqRMHuZIPKN4kcwxShqRXyUc6wqJFavlp0HB0NXSnY=, 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 6 04:43:48.033903 update_engine[1264]: I1106 04:43:48.033879 1264 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Nov 6 04:43:48.035943 update_engine[1264]: I1106 04:43:48.035913 1264 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Nov 6 04:43:48.058895 sshd[1285]: Accepted publickey for core from 10.0.0.1 port 52756 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:48.063371 kernel: kauditd_printk_skb: 319 callbacks suppressed Nov 6 04:43:48.063453 kernel: audit: type=1006 audit(1762404228.058:364): pid=1285 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=25 res=1 Nov 6 04:43:48.063793 sshd[1285]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:48.070286 systemd-logind[911]: New session 25 of user core. Nov 6 04:43:48.075145 systemd[1]: Started Session 25 of User core. Nov 6 04:43:48.134017 sshd[1285]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:48.136101 systemd[1]: sshd@24-10.0.0.3:22-10.0.0.1:52756.service: Deactivated successfully. Nov 6 04:43:48.136825 systemd[1]: session-25.scope: Deactivated successfully. Nov 6 04:43:48.137439 systemd-logind[911]: Session 25 logged out. Waiting for processes to exit. Nov 6 04:43:48.138131 systemd-logind[911]: Removed session 25. Nov 6 04:43:49.920753 update_engine[1264]: I1106 04:43:49.920713 1264 filesystem_copier_action.cc:274] Hash: MqVcpLuSy9a3pkT1U79KicfT+9MRnGj6QbL170vealU= Nov 6 04:43:49.920753 update_engine[1264]: I1106 04:43:49.920755 1264 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Nov 6 04:43:49.980184 update_engine[1264]: E1106 04:43:49.980139 1264 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Nov 6 04:43:49.980184 update_engine[1264]: I1106 04:43:49.980181 1264 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Nov 6 04:43:49.980184 update_engine[1264]: I1106 04:43:49.980185 1264 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Nov 6 04:43:49.980184 update_engine[1264]: I1106 04:43:49.980190 1264 update_attempter.cc:302] Processing Done. Nov 6 04:43:49.980363 update_engine[1264]: E1106 04:43:49.980232 1264 update_attempter.cc:615] Update failed. Nov 6 04:43:49.980363 update_engine[1264]: I1106 04:43:49.980237 1264 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Nov 6 04:43:49.980363 update_engine[1264]: I1106 04:43:49.980240 1264 payload_state.cc:276] Incrementing the URL failure count Nov 6 04:43:49.980363 update_engine[1264]: I1106 04:43:49.980243 1264 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Nov 6 04:43:49.980444 update_engine[1264]: I1106 04:43:49.980428 1264 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Nov 6 04:43:49.980467 update_engine[1264]: I1106 04:43:49.980448 1264 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.2:34567/v1/update Nov 6 04:43:49.980467 update_engine[1264]: I1106 04:43:49.980453 1264 omaha_request_action.cc:269] Request: Nov 6 04:43:49.980467 update_engine[1264]: Nov 6 04:43:49.980467 update_engine[1264]: Nov 6 04:43:49.980467 update_engine[1264]: Nov 6 04:43:49.980467 update_engine[1264]: Nov 6 04:43:49.980467 update_engine[1264]: Nov 6 04:43:49.980467 update_engine[1264]: Nov 6 04:43:49.980467 update_engine[1264]: I1106 04:43:49.980456 1264 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Nov 6 04:43:49.980630 update_engine[1264]: I1106 04:43:49.980515 1264 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Nov 6 04:43:49.980653 update_engine[1264]: I1106 04:43:49.980634 1264 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Nov 6 04:43:50.109638 update_engine[1264]: I1106 04:43:50.109587 1264 libcurl_http_fetcher.cc:248] HTTP response code: 200 Nov 6 04:43:50.109762 update_engine[1264]: I1106 04:43:50.109675 1264 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Nov 6 04:43:50.109762 update_engine[1264]: I1106 04:43:50.109683 1264 omaha_request_action.cc:619] Omaha request response: Nov 6 04:43:50.109762 update_engine[1264]: Nov 6 04:43:50.109762 update_engine[1264]: Nov 6 04:43:50.109762 update_engine[1264]: Nov 6 04:43:50.109762 update_engine[1264]: Nov 6 04:43:50.109762 update_engine[1264]: Nov 6 04:43:50.109762 update_engine[1264]: Nov 6 04:43:50.109762 update_engine[1264]: E1106 04:43:50.109696 1264 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Nov 6 04:43:50.109762 update_engine[1264]: I1106 04:43:50.109700 1264 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 6 04:43:50.109762 update_engine[1264]: I1106 04:43:50.109704 1264 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 6 04:43:50.109762 update_engine[1264]: I1106 04:43:50.109706 1264 update_attempter.cc:302] Processing Done. Nov 6 04:43:50.109762 update_engine[1264]: I1106 04:43:50.109710 1264 update_attempter.cc:306] Error event sent. Nov 6 04:43:58.115583 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38584). Nov 6 04:43:58.150039 sshd[1298]: Accepted publickey for core from 10.0.0.1 port 38584 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:58.151162 sshd[1298]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:58.153096 kernel: audit: type=1006 audit(1762404238.149:365): pid=1298 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 6 04:43:58.154978 systemd-logind[911]: New session 26 of user core. Nov 6 04:43:58.168123 systemd[1]: Started Session 26 of User core. Nov 6 04:43:58.224653 sshd[1298]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:58.238463 systemd[1]: sshd@25-10.0.0.3:22-10.0.0.1:38584.service: Deactivated successfully. Nov 6 04:43:58.239129 systemd[1]: session-26.scope: Deactivated successfully. Nov 6 04:43:58.239705 systemd-logind[911]: Session 26 logged out. Waiting for processes to exit. Nov 6 04:43:58.240803 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38600). Nov 6 04:43:58.241486 systemd-logind[911]: Removed session 26. Nov 6 04:43:58.273442 sshd[1305]: Accepted publickey for core from 10.0.0.1 port 38600 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:58.276495 sshd[1305]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:58.278990 kernel: audit: type=1006 audit(1762404238.275:366): pid=1305 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 6 04:43:58.280362 systemd-logind[911]: New session 27 of user core. Nov 6 04:43:58.297172 systemd[1]: Started Session 27 of User core. Nov 6 04:43:58.354395 sshd[1305]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:58.365691 systemd[1]: sshd@26-10.0.0.3:22-10.0.0.1:38600.service: Deactivated successfully. Nov 6 04:43:58.366619 systemd[1]: session-27.scope: Deactivated successfully. Nov 6 04:43:58.368021 systemd-logind[911]: Session 27 logged out. Waiting for processes to exit. Nov 6 04:43:58.368338 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38622). Nov 6 04:43:58.369155 systemd-logind[911]: Removed session 27. Nov 6 04:43:58.400060 sshd[1313]: Accepted publickey for core from 10.0.0.1 port 38622 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:58.401406 sshd[1313]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:58.403999 kernel: audit: type=1006 audit(1762404238.400:367): pid=1313 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 6 04:43:58.404572 systemd-logind[911]: New session 28 of user core. Nov 6 04:43:58.413139 systemd[1]: Started Session 28 of User core. Nov 6 04:43:58.461881 sshd[1313]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:58.474027 systemd[1]: sshd@27-10.0.0.3:22-10.0.0.1:38622.service: Deactivated successfully. Nov 6 04:43:58.474850 systemd[1]: session-28.scope: Deactivated successfully. Nov 6 04:43:58.475614 systemd-logind[911]: Session 28 logged out. Waiting for processes to exit. Nov 6 04:43:58.477044 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38634). Nov 6 04:43:58.477874 systemd-logind[911]: Removed session 28. Nov 6 04:43:58.508452 sshd[1319]: Accepted publickey for core from 10.0.0.1 port 38634 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:58.509354 sshd[1319]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:58.510980 kernel: audit: type=1006 audit(1762404238.508:368): pid=1319 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 6 04:43:58.512325 systemd-logind[911]: New session 29 of user core. Nov 6 04:43:58.520144 systemd[1]: Started Session 29 of User core. Nov 6 04:43:58.568811 sshd[1319]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:58.586783 systemd[1]: sshd@28-10.0.0.3:22-10.0.0.1:38634.service: Deactivated successfully. Nov 6 04:43:58.587376 systemd[1]: session-29.scope: Deactivated successfully. Nov 6 04:43:58.587959 systemd-logind[911]: Session 29 logged out. Waiting for processes to exit. Nov 6 04:43:58.589035 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38650). Nov 6 04:43:58.589679 systemd-logind[911]: Removed session 29. Nov 6 04:43:58.620921 sshd[1325]: Accepted publickey for core from 10.0.0.1 port 38650 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:43:58.622518 sshd[1325]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:43:58.624994 kernel: audit: type=1006 audit(1762404238.621:369): pid=1325 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 6 04:43:58.627686 systemd-logind[911]: New session 30 of user core. Nov 6 04:43:58.638142 systemd[1]: Started Session 30 of User core. Nov 6 04:43:58.692661 sudo[1329]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl stop sshd.socket Nov 6 04:43:58.692884 sudo[1329]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 6 04:43:58.699998 systemd[1]: sshd.socket: Deactivated successfully. Nov 6 04:43:58.700379 systemd[1]: Closed OpenSSH Server Socket. Nov 6 04:43:58.701795 sudo[1329]: pam_unix(sudo:session): session closed for user root Nov 6 04:43:58.705614 sudo[1328]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/reboot Nov 6 04:43:58.705810 sudo[1328]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 6 04:43:58.737210 systemd[1]: Stopping Session 1 of User core... Nov 6 04:43:58.738195 systemd[1]: Stopping Session 30 of User core... Nov 6 04:43:58.738506 sshd[1325]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:58.738817 sudo[1328]: pam_unix(sudo:session): session closed for user root Nov 6 04:43:58.739779 sshd[944]: pam_unix(sshd:session): session closed for user core Nov 6 04:43:58.742299 systemd[1]: Removed slice Slice /system/addon-config. Nov 6 04:43:58.743449 systemd[1]: Removed slice Slice /system/addon-run. Nov 6 04:43:58.744568 systemd[1]: Removed slice Slice /system/modprobe. Nov 6 04:43:58.748606 systemd[1]: Removed slice Slice /system/system-cloudinit. Nov 6 04:43:58.749634 systemd[1]: Stopped target Multi-User System. Nov 6 04:43:58.752300 systemd[1]: Stopped target Login Prompts. Nov 6 04:43:58.753034 systemd[1]: Stopped target Containers. Nov 6 04:43:58.753726 systemd[1]: Stopped target Host and Network Name Lookups. Nov 6 04:43:58.754674 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 6 04:43:58.755795 systemd[1]: Stopped target Timer Units. Nov 6 04:43:58.756551 systemd[1]: logrotate.timer: Deactivated successfully. Nov 6 04:43:58.756596 systemd[1]: Stopped Daily Log Rotation. Nov 6 04:43:58.757317 systemd[1]: mdadm.timer: Deactivated successfully. Nov 6 04:43:58.757356 systemd[1]: Stopped Weekly check for MD array's redundancy information.. Nov 6 04:43:58.758366 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Nov 6 04:43:58.758407 systemd[1]: Stopped Daily Cleanup of Temporary Directories. Nov 6 04:43:58.759343 systemd[1]: Stopped target System Time Set. Nov 6 04:43:58.760103 systemd[1]: Stopped target Load user-provided cloud configs. Nov 6 04:43:58.761022 systemd[1]: Stopped target Load system-provided cloud configs. Nov 6 04:43:58.762124 systemd[1]: systemd-coredump.socket: Deactivated successfully. Nov 6 04:43:58.762299 systemd[1]: Closed Process Core Dump Socket. Nov 6 04:43:58.763831 systemd[1]: Unmounting Boot partition... Nov 6 04:43:58.764837 systemd[1]: Stopping Getty on tty1... Nov 6 04:43:58.765620 systemd[1]: Stopping Serial Getty on ttyAMA0... Nov 6 04:43:58.766575 systemd[1]: Stopping OpenSSH per-connection server daemon... Nov 6 04:43:58.767511 systemd[1]: Stopping OpenSSH per-connection server daemon (10.0.0.1:38650)... Nov 6 04:43:58.768410 systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. Nov 6 04:43:58.768558 systemd[1]: Stopped Commit a transient machine-id on disk. Nov 6 04:43:58.769561 systemd[1]: Stopped target First Boot Complete. Nov 6 04:43:58.771441 systemd[1]: Stopping Load/Save Random Seed... Nov 6 04:43:58.772360 systemd[1]: Stopping Update Engine... Nov 6 04:43:58.775501 systemd[1]: getty@tty1.service: Deactivated successfully. Nov 6 04:43:58.775705 systemd[1]: Stopped Getty on tty1. Nov 6 04:43:58.776941 systemd[1]: serial-getty@ttyAMA0.service: Deactivated successfully. Nov 6 04:43:58.777169 systemd[1]: Stopped Serial Getty on ttyAMA0. Nov 6 04:43:58.778447 systemd[1]: sshd@0-10.0.0.3:22-10.0.0.1:52538.service: Deactivated successfully. Nov 6 04:43:58.778642 systemd[1]: Stopped OpenSSH per-connection server daemon. Nov 6 04:43:58.780205 systemd[1]: update-engine.service: Main process exited, code=exited, status=1/FAILURE Nov 6 04:43:58.780279 systemd[1]: update-engine.service: Failed with result 'exit-code'. Nov 6 04:43:58.780528 systemd[1]: Stopped Update Engine. Nov 6 04:43:58.781389 systemd[1]: update-engine.service: Consumed 2.375s CPU time. Nov 6 04:43:58.781634 systemd[1]: sshd@29-10.0.0.3:22-10.0.0.1:38650.service: Deactivated successfully. Nov 6 04:43:58.781821 systemd[1]: Stopped OpenSSH per-connection server daemon (10.0.0.1:38650). Nov 6 04:43:58.790847 systemd[1]: systemd-random-seed.service: Deactivated successfully. Nov 6 04:43:58.791109 systemd[1]: Stopped Load/Save Random Seed. Nov 6 04:43:58.792168 systemd[1]: session-1.scope: Deactivated successfully. Nov 6 04:43:58.792421 systemd[1]: Stopped Session 1 of User core. Nov 6 04:43:58.793380 systemd[1]: session-30.scope: Deactivated successfully. Nov 6 04:43:58.793619 systemd[1]: Stopped Session 30 of User core. Nov 6 04:43:58.794940 systemd-logind[911]: Session 30 logged out. Waiting for processes to exit. Nov 6 04:43:58.795902 systemd-logind[911]: Session 1 logged out. Waiting for processes to exit. Nov 6 04:43:58.796202 systemd[1]: Removed slice Slice /system/getty. Nov 6 04:43:58.797345 systemd[1]: Removed slice Slice /system/serial-getty. Nov 6 04:43:58.798836 systemd[1]: Removed slice Slice /system/sshd. Nov 6 04:43:58.799816 systemd[1]: sshd-keygen.service: Deactivated successfully. Nov 6 04:43:58.799929 systemd[1]: Stopped Generate sshd host keys. Nov 6 04:43:58.800992 systemd[1]: Stopping User Login Management... Nov 6 04:43:58.801747 systemd[1]: Stopping User Manager for UID 500... Nov 6 04:43:58.802620 systemd[947]: Stopped target Main User Target. Nov 6 04:43:58.802640 systemd[947]: Stopped target Basic System. Nov 6 04:43:58.802658 systemd[947]: Stopped target Paths. Nov 6 04:43:58.802666 systemd[947]: Stopped target Sockets. Nov 6 04:43:58.802683 systemd[947]: Reached target Shutdown. Nov 6 04:43:58.802690 systemd[947]: Stopped target Timers. Nov 6 04:43:58.802803 systemd[947]: Finished Exit the Session. Nov 6 04:43:58.802829 systemd[947]: Reached target Exit the Session. Nov 6 04:43:58.803156 systemd[1]: boot.mount: Deactivated successfully. Nov 6 04:43:58.803422 systemd[1]: Unmounted Boot partition. Nov 6 04:43:58.804609 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service: Deactivated successfully. Nov 6 04:43:58.804742 systemd[1]: Stopped File System Check on /dev/disk/by-label/EFI-SYSTEM. Nov 6 04:43:58.807414 systemd[1]: user@500.service: Deactivated successfully. Nov 6 04:43:58.807608 systemd[1]: Stopped User Manager for UID 500. Nov 6 04:43:58.809840 systemd-logind[911]: Removed session 30. Nov 6 04:43:58.811308 systemd[1]: Stopping User Runtime Directory /run/user/500... Nov 6 04:43:58.819556 systemd[1]: run-user-500.mount: Deactivated successfully. Nov 6 04:43:58.819630 systemd[1]: Unmounted /run/user/500. Nov 6 04:43:58.820805 systemd[1]: user-runtime-dir@500.service: Deactivated successfully. Nov 6 04:43:58.821066 systemd[1]: Stopped User Runtime Directory /run/user/500. Nov 6 04:43:58.822691 systemd[1]: Removed slice User Slice of UID 500. Nov 6 04:43:58.825486 systemd[1]: Stopping D-Bus System Message Bus... Nov 6 04:43:58.847955 systemd[1]: Stopping Permit User Sessions... Nov 6 04:43:58.849274 systemd[1]: dbus.service: Deactivated successfully. Nov 6 04:43:58.849531 systemd[1]: Stopped D-Bus System Message Bus. Nov 6 04:43:58.850535 systemd[1]: systemd-logind.service: Deactivated successfully. Nov 6 04:43:58.850782 systemd[1]: Stopped User Login Management. Nov 6 04:43:58.852773 systemd[1]: systemd-user-sessions.service: Deactivated successfully. Nov 6 04:43:58.853023 systemd[1]: Stopped Permit User Sessions. Nov 6 04:43:58.853785 systemd[1]: Stopped target Basic System. Nov 6 04:43:58.854535 systemd[1]: Stopped target Network. Nov 6 04:43:58.855191 systemd[1]: Stopped target Path Units. Nov 6 04:43:58.855832 systemd[1]: motdgen.path: Deactivated successfully. Nov 6 04:43:58.855894 systemd[1]: Stopped Watch for update engine configuration changes. Nov 6 04:43:58.856925 systemd[1]: user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path: Deactivated successfully. Nov 6 04:43:58.856987 systemd[1]: Stopped Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 6 04:43:58.857944 systemd[1]: Stopped target Remote File Systems. Nov 6 04:43:58.857000 audit: BPF prog-id=65 op=UNLOAD Nov 6 04:43:58.859723 systemd[1]: Stopped target Slice Units. Nov 6 04:43:58.859991 kernel: audit: type=1334 audit(1762404238.857:370): prog-id=65 op=UNLOAD Nov 6 04:43:58.860736 systemd[1]: Removed slice User and Session Slice. Nov 6 04:43:58.861559 systemd[1]: Stopped target Socket Units. Nov 6 04:43:58.862315 systemd[1]: dbus.socket: Deactivated successfully. Nov 6 04:43:58.862372 systemd[1]: Closed D-Bus System Message Bus Socket. Nov 6 04:43:58.863323 systemd[1]: docker.socket: Deactivated successfully. Nov 6 04:43:58.863560 systemd[1]: Closed Docker Socket for the API. Nov 6 04:43:58.864366 systemd[1]: Stopped target System Initialization. Nov 6 04:43:58.865168 systemd[1]: proc-sys-fs-binfmt_misc.automount: Deactivated successfully. Nov 6 04:43:58.865308 systemd[1]: Unset automount Arbitrary Executable File Formats File System Automount Point. Nov 6 04:43:58.866334 systemd[1]: Stopped target Local Verity Protected Volumes. Nov 6 04:43:58.868186 systemd[1]: Stopping Load Security Auditing Rules... Nov 6 04:43:58.869067 systemd[1]: Stopping Network Name Resolution... Nov 6 04:43:58.869999 systemd[1]: Stopping Network Time Synchronization... Nov 6 04:43:58.870220 auditctl[1343]: No rules Nov 6 04:43:58.870705 systemd[1]: systemd-update-done.service: Deactivated successfully. Nov 6 04:43:58.870775 systemd[1]: Stopped Update is Completed. Nov 6 04:43:58.871752 systemd[1]: ldconfig.service: Deactivated successfully. Nov 6 04:43:58.871807 systemd[1]: Stopped Rebuild Dynamic Linker Cache. Nov 6 04:43:58.872760 systemd[1]: systemd-hwdb-update.service: Deactivated successfully. Nov 6 04:43:58.872821 systemd[1]: Stopped Rebuild Hardware Database. Nov 6 04:43:58.873629 systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. Nov 6 04:43:58.873718 systemd[1]: Stopped Rebuild Journal Catalog. Nov 6 04:43:58.875365 systemd[1]: Stopping Record System Boot/Shutdown in UTMP... Nov 6 04:43:58.877829 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 6 04:43:58.878103 systemd[1]: Stopped Network Name Resolution. Nov 6 04:43:58.879188 systemd[1]: systemd-timesyncd.service: Deactivated successfully. Nov 6 04:43:58.879423 systemd[1]: Stopped Network Time Synchronization. Nov 6 04:43:58.880542 systemd[1]: audit-rules.service: Deactivated successfully. Nov 6 04:43:58.880759 systemd[1]: Stopped Load Security Auditing Rules. Nov 6 04:43:58.883042 systemd[1]: Stopping Network Configuration... Nov 6 04:43:58.883000 audit: BPF prog-id=59 op=UNLOAD Nov 6 04:43:58.884181 systemd[1]: systemd-update-utmp.service: Deactivated successfully. Nov 6 04:43:58.884399 systemd[1]: Stopped Record System Boot/Shutdown in UTMP. Nov 6 04:43:58.885028 kernel: audit: type=1334 audit(1762404238.883:371): prog-id=59 op=UNLOAD Nov 6 04:43:58.885000 audit: BPF prog-id=61 op=UNLOAD Nov 6 04:43:58.888009 kernel: audit: type=1334 audit(1762404238.885:372): prog-id=61 op=UNLOAD Nov 6 04:43:58.887078 systemd-networkd[835]: eth0: DHCPv6 lease lost Nov 6 04:43:58.887458 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 6 04:43:58.887556 systemd[1]: Stopped Create Volatile Files and Directories. Nov 6 04:43:58.888556 systemd[1]: Stopped target Local File Systems. Nov 6 04:43:58.890329 systemd[1]: Unmounting /etc/flatcar/update-payload-key.pub.pem... Nov 6 04:43:58.891929 systemd[1]: Unmounting External Media Directory... Nov 6 04:43:58.893668 systemd[1]: Unmounting /run/credentials/systemd-sysusers.service... Nov 6 04:43:58.895575 systemd[1]: Unmounting /run/torcx/unpack... Nov 6 04:43:58.896934 systemd[1]: Unmounting Temporary Directory /tmp... Nov 6 04:43:58.898304 systemd[1]: Unmounting /usr/share/oem... Nov 6 04:43:58.899878 systemd[1]: Unmounting /usr/share/update_engine/update-payload-key.pub.pem... Nov 6 04:43:58.902522 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 6 04:43:58.902778 systemd[1]: Stopped Network Configuration. Nov 6 04:43:58.903766 systemd[1]: etc-flatcar-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Nov 6 04:43:58.904081 systemd[1]: Unmounted /etc/flatcar/update-payload-key.pub.pem. Nov 6 04:43:58.920164 systemd[1]: media.mount: Deactivated successfully. Nov 6 04:43:58.920442 systemd[1]: Unmounted External Media Directory. Nov 6 04:43:58.921432 systemd[1]: run-credentials-systemd\x2dsysusers.service.mount: Deactivated successfully. Nov 6 04:43:58.921677 systemd[1]: Unmounted /run/credentials/systemd-sysusers.service. Nov 6 04:43:58.922927 systemd[1]: run-torcx-unpack.mount: Deactivated successfully. Nov 6 04:43:58.923180 systemd[1]: Unmounted /run/torcx/unpack. Nov 6 04:43:58.924105 systemd[1]: tmp.mount: Deactivated successfully. Nov 6 04:43:58.924359 systemd[1]: Unmounted Temporary Directory /tmp. Nov 6 04:43:58.925256 systemd[1]: usr-share-oem.mount: Deactivated successfully. Nov 6 04:43:58.925513 systemd[1]: Unmounted /usr/share/oem. Nov 6 04:43:58.926351 systemd[1]: usr-share-update_engine-update\x2dpayload\x2dkey.pub.pem.mount: Deactivated successfully. Nov 6 04:43:58.926594 systemd[1]: Unmounted /usr/share/update_engine/update-payload-key.pub.pem. Nov 6 04:43:58.927000 audit: BPF prog-id=60 op=UNLOAD Nov 6 04:43:58.928007 systemd[1]: Stopped target Swaps. Nov 6 04:43:58.929405 kernel: audit: type=1334 audit(1762404238.927:373): prog-id=60 op=UNLOAD Nov 6 04:43:58.929592 systemd[1]: Reached target Unmount All Filesystems. Nov 6 04:43:58.930517 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 6 04:43:58.930667 systemd[1]: Closed Network Service Netlink Socket. Nov 6 04:43:58.931562 systemd[1]: systemd-fsck@dev-disk-by\x2dlabel-OEM.service: Deactivated successfully. Nov 6 04:43:58.931714 systemd[1]: Stopped File System Check on /dev/disk/by-label/OEM. Nov 6 04:43:58.933365 systemd[1]: Removed slice Slice /system/systemd-fsck. Nov 6 04:43:58.934316 systemd[1]: Stopped target Preparation for Local File Systems. Nov 6 04:43:58.935399 systemd[1]: lvm2-activation.service: Deactivated successfully. Nov 6 04:43:58.935544 systemd[1]: Stopped Activation of LVM2 logical volumes. Nov 6 04:43:58.936489 systemd[1]: Stopped target Local Encrypted Volumes. Nov 6 04:43:58.937398 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 6 04:43:58.937568 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 6 04:43:58.938870 systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. Nov 6 04:43:58.945041 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. Nov 6 04:43:58.946119 systemd[1]: lvm2-activation-early.service: Deactivated successfully. Nov 6 04:43:58.946275 systemd[1]: Stopped Activation of LVM2 logical volumes. Nov 6 04:43:58.948008 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 6 04:43:58.948163 systemd[1]: Stopped Apply Kernel Variables. Nov 6 04:43:58.949098 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 6 04:43:58.949232 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 6 04:43:58.950135 systemd[1]: systemd-sysusers.service: Deactivated successfully. Nov 6 04:43:58.950278 systemd[1]: Stopped Create System Users. Nov 6 04:43:58.951081 systemd[1]: systemd-remount-fs.service: Deactivated successfully. Nov 6 04:43:58.951208 systemd[1]: Stopped Remount Root and Kernel File Systems. Nov 6 04:43:58.952228 systemd[1]: Reached target System Shutdown. Nov 6 04:43:58.953062 systemd[1]: Reached target Late Shutdown Services. Nov 6 04:43:58.954009 systemd[1]: systemd-reboot.service: Deactivated successfully. Nov 6 04:43:58.954135 systemd[1]: Finished System Reboot. Nov 6 04:43:58.954844 systemd[1]: Reached target System Reboot. Nov 6 04:43:58.955642 systemd[1]: Shutting down. Nov 6 04:43:58.956000 audit: BPF prog-id=58 op=UNLOAD Nov 6 04:43:58.957992 kernel: audit: type=1334 audit(1762404238.956:374): prog-id=58 op=UNLOAD Nov 6 04:43:58.956000 audit: BPF prog-id=57 op=UNLOAD Nov 6 04:43:58.956000 audit: BPF prog-id=56 op=UNLOAD Nov 6 04:43:58.959000 audit: BPF prog-id=64 op=UNLOAD Nov 6 04:43:58.959000 audit: BPF prog-id=63 op=UNLOAD Nov 6 04:43:58.959000 audit: BPF prog-id=62 op=UNLOAD Nov 6 04:43:58.959000 audit: BPF prog-id=67 op=UNLOAD Nov 6 04:43:58.959000 audit: BPF prog-id=66 op=UNLOAD Nov 6 04:43:58.994997 systemd-shutdown[1]: Syncing filesystems and block devices. Nov 6 04:43:59.002272 systemd-shutdown[1]: Sending SIGTERM to remaining processes... Nov 6 04:43:59.002372 systemd-journald[798]: Journal stopped -- Reboot -- Nov 6 04:44:07.676953 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 6 04:44:07.676970 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 6 04:44:07.676978 kernel: efi: EFI v2.70 by EDK II Nov 6 04:44:07.676983 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb82c018 ACPI 2.0=0xdbfd0018 RNG=0xdcfdd318 MEMRESERVE=0xdb834c18 Nov 6 04:44:07.676988 kernel: efi: seeding entropy pool Nov 6 04:44:07.676993 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Nov 6 04:44:07.676999 kernel: ACPI: Early table checksum verification disabled Nov 6 04:44:07.677004 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Nov 6 04:44:07.677014 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 6 04:44:07.677019 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:44:07.677026 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:44:07.677031 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:44:07.677036 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:44:07.677041 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:44:07.677047 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:44:07.677053 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:44:07.677065 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:44:07.677073 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 04:44:07.677078 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 6 04:44:07.677083 kernel: ACPI: NUMA: Failed to initialise from firmware Nov 6 04:44:07.677089 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 6 04:44:07.677094 kernel: NUMA: NODE_DATA [mem 0xdc95a900-0xdc95ffff] Nov 6 04:44:07.677099 kernel: Zone ranges: Nov 6 04:44:07.677104 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 6 04:44:07.677109 kernel: DMA32 empty Nov 6 04:44:07.677114 kernel: Normal empty Nov 6 04:44:07.677120 kernel: Movable zone start for each node Nov 6 04:44:07.677126 kernel: Early memory node ranges Nov 6 04:44:07.677132 kernel: node 0: [mem 0x0000000040000000-0x00000000dc09ffff] Nov 6 04:44:07.677137 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Nov 6 04:44:07.677142 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Nov 6 04:44:07.677148 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Nov 6 04:44:07.677153 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Nov 6 04:44:07.677158 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Nov 6 04:44:07.677163 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Nov 6 04:44:07.677168 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 6 04:44:07.677173 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 6 04:44:07.677179 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 6 04:44:07.677184 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 6 04:44:07.677189 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 6 04:44:07.677197 kernel: On node 0 totalpages: 643072 Nov 6 04:44:07.677203 kernel: DMA zone: 10048 pages used for memmap Nov 6 04:44:07.677208 kernel: DMA zone: 0 pages reserved Nov 6 04:44:07.677214 kernel: DMA zone: 643072 pages, LIFO batch:63 Nov 6 04:44:07.677219 kernel: psci: probing for conduit method from ACPI. Nov 6 04:44:07.677225 kernel: psci: PSCIv1.1 detected in firmware. Nov 6 04:44:07.677230 kernel: psci: Using standard PSCI v0.2 function IDs Nov 6 04:44:07.677236 kernel: psci: Trusted OS migration not required Nov 6 04:44:07.677242 kernel: psci: SMC Calling Convention v1.1 Nov 6 04:44:07.677248 kernel: ACPI: SRAT not present Nov 6 04:44:07.677253 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Nov 6 04:44:07.677259 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Nov 6 04:44:07.677264 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 6 04:44:07.677270 kernel: Detected PIPT I-cache on CPU0 Nov 6 04:44:07.677275 kernel: CPU features: detected: GIC system register CPU interface Nov 6 04:44:07.677281 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 6 04:44:07.677286 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 6 04:44:07.677292 kernel: CPU features: detected: Hardware dirty bit management Nov 6 04:44:07.677297 kernel: CPU features: detected: Spectre-v4 Nov 6 04:44:07.677304 kernel: CPU features: detected: ARM erratum 1418040 Nov 6 04:44:07.677309 kernel: CPU features: detected: Spectre-BHB Nov 6 04:44:07.677315 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 6 04:44:07.677320 kernel: Policy zone: DMA Nov 6 04:44:07.677326 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 6 04:44:07.677332 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 6 04:44:07.677338 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 6 04:44:07.677344 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 6 04:44:07.677349 kernel: Memory: 2452100K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120188K reserved, 0K cma-reserved) Nov 6 04:44:07.677355 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Nov 6 04:44:07.677361 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 6 04:44:07.677367 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 6 04:44:07.677373 kernel: rcu: RCU event tracing is enabled. Nov 6 04:44:07.677379 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 6 04:44:07.677385 kernel: Trampoline variant of Tasks RCU enabled. Nov 6 04:44:07.677391 kernel: Tracing variant of Tasks RCU enabled. Nov 6 04:44:07.677396 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 6 04:44:07.677402 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 6 04:44:07.677407 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 6 04:44:07.677413 kernel: GICv3: 256 SPIs implemented Nov 6 04:44:07.677418 kernel: GICv3: 0 Extended SPIs implemented Nov 6 04:44:07.677424 kernel: GICv3: Distributor has no Range Selector support Nov 6 04:44:07.677429 kernel: GICv3: 16 PPIs implemented Nov 6 04:44:07.677435 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 6 04:44:07.677441 kernel: ACPI: SRAT not present Nov 6 04:44:07.677446 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 6 04:44:07.677452 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Nov 6 04:44:07.677457 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Nov 6 04:44:07.677463 kernel: GICv3: using LPI property table @0x00000000400d0000 Nov 6 04:44:07.677469 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Nov 6 04:44:07.677474 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 6 04:44:07.677480 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 6 04:44:07.677486 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 6 04:44:07.677491 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 6 04:44:07.677497 kernel: arm-pv: using stolen time PV Nov 6 04:44:07.677504 kernel: Console: colour dummy device 80x25 Nov 6 04:44:07.677509 kernel: ACPI: Core revision 20200925 Nov 6 04:44:07.677515 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 6 04:44:07.677521 kernel: pid_max: default: 32768 minimum: 301 Nov 6 04:44:07.677527 kernel: LSM: Security Framework initializing Nov 6 04:44:07.677532 kernel: SELinux: Initializing. Nov 6 04:44:07.677538 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 6 04:44:07.677544 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 6 04:44:07.677550 kernel: rcu: Hierarchical SRCU implementation. Nov 6 04:44:07.677557 kernel: Platform MSI: ITS@0x8080000 domain created Nov 6 04:44:07.677562 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 6 04:44:07.677568 kernel: Remapping and enabling EFI services. Nov 6 04:44:07.677574 kernel: smp: Bringing up secondary CPUs ... Nov 6 04:44:07.677580 kernel: Detected PIPT I-cache on CPU1 Nov 6 04:44:07.677586 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 6 04:44:07.677592 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Nov 6 04:44:07.677598 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 6 04:44:07.677604 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 6 04:44:07.677610 kernel: Detected PIPT I-cache on CPU2 Nov 6 04:44:07.677617 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 6 04:44:07.677623 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Nov 6 04:44:07.677628 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 6 04:44:07.677634 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 6 04:44:07.677643 kernel: Detected PIPT I-cache on CPU3 Nov 6 04:44:07.677654 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 6 04:44:07.677660 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Nov 6 04:44:07.677667 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 6 04:44:07.677673 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 6 04:44:07.677679 kernel: smp: Brought up 1 node, 4 CPUs Nov 6 04:44:07.677685 kernel: SMP: Total of 4 processors activated. Nov 6 04:44:07.677691 kernel: CPU features: detected: Privileged Access Never Nov 6 04:44:07.677697 kernel: CPU features: detected: LSE atomic instructions Nov 6 04:44:07.677703 kernel: CPU features: detected: User Access Override Nov 6 04:44:07.677709 kernel: CPU features: detected: 32-bit EL0 Support Nov 6 04:44:07.677715 kernel: CPU features: detected: Common not Private translations Nov 6 04:44:07.677720 kernel: CPU features: detected: RAS Extension Support Nov 6 04:44:07.677728 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 6 04:44:07.677734 kernel: CPU features: detected: CRC32 instructions Nov 6 04:44:07.677740 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 6 04:44:07.677746 kernel: CPU: All CPU(s) started at EL1 Nov 6 04:44:07.677752 kernel: alternatives: patching kernel code Nov 6 04:44:07.677759 kernel: devtmpfs: initialized Nov 6 04:44:07.677765 kernel: KASLR enabled Nov 6 04:44:07.677771 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 6 04:44:07.677777 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 6 04:44:07.677783 kernel: pinctrl core: initialized pinctrl subsystem Nov 6 04:44:07.677789 kernel: SMBIOS 3.0.0 present. Nov 6 04:44:07.677795 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Nov 6 04:44:07.677801 kernel: NET: Registered protocol family 16 Nov 6 04:44:07.677807 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 6 04:44:07.677813 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 6 04:44:07.677820 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 6 04:44:07.677826 kernel: audit: initializing netlink subsys (disabled) Nov 6 04:44:07.677874 kernel: audit: type=2000 audit(0.031:1): state=initialized audit_enabled=0 res=1 Nov 6 04:44:07.677881 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 6 04:44:07.677887 kernel: cpuidle: using governor menu Nov 6 04:44:07.677893 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 6 04:44:07.677899 kernel: ASID allocator initialised with 32768 entries Nov 6 04:44:07.677905 kernel: ACPI: bus type PCI registered Nov 6 04:44:07.677911 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 6 04:44:07.677919 kernel: Serial: AMBA PL011 UART driver Nov 6 04:44:07.677925 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 6 04:44:07.677931 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 6 04:44:07.677937 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 6 04:44:07.677943 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 6 04:44:07.677949 kernel: cryptd: max_cpu_qlen set to 1000 Nov 6 04:44:07.677955 kernel: ACPI: Added _OSI(Module Device) Nov 6 04:44:07.677961 kernel: ACPI: Added _OSI(Processor Device) Nov 6 04:44:07.677967 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 6 04:44:07.677974 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 6 04:44:07.677980 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 6 04:44:07.677986 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 6 04:44:07.677992 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 6 04:44:07.677998 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 6 04:44:07.678004 kernel: ACPI: Interpreter enabled Nov 6 04:44:07.678010 kernel: ACPI: Using GIC for interrupt routing Nov 6 04:44:07.678016 kernel: ACPI: MCFG table detected, 1 entries Nov 6 04:44:07.678022 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 6 04:44:07.678028 kernel: printk: console [ttyAMA0] enabled Nov 6 04:44:07.678035 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 6 04:44:07.678152 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 6 04:44:07.678210 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 6 04:44:07.678268 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 6 04:44:07.678325 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 6 04:44:07.678376 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 6 04:44:07.678384 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 6 04:44:07.678392 kernel: PCI host bridge to bus 0000:00 Nov 6 04:44:07.678470 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 6 04:44:07.678522 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 6 04:44:07.678569 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 6 04:44:07.678616 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 6 04:44:07.678682 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 6 04:44:07.678743 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 6 04:44:07.678799 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 6 04:44:07.678864 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 6 04:44:07.678920 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 6 04:44:07.678974 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 6 04:44:07.679029 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 6 04:44:07.679091 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 6 04:44:07.679143 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 6 04:44:07.679199 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 6 04:44:07.679256 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 6 04:44:07.679264 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Nov 6 04:44:07.679270 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Nov 6 04:44:07.679277 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Nov 6 04:44:07.679288 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Nov 6 04:44:07.679294 kernel: vgaarb: loaded Nov 6 04:44:07.679303 kernel: Registered efivars operations Nov 6 04:44:07.679309 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 6 04:44:07.679316 kernel: VFS: Disk quotas dquot_6.6.0 Nov 6 04:44:07.679323 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 6 04:44:07.679329 kernel: pnp: PnP ACPI init Nov 6 04:44:07.679391 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 6 04:44:07.679441 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Nov 6 04:44:07.679449 kernel: pnp: PnP ACPI: found 1 devices Nov 6 04:44:07.679455 kernel: NET: Registered protocol family 2 Nov 6 04:44:07.679461 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 6 04:44:07.679469 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 6 04:44:07.679475 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 6 04:44:07.679481 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 6 04:44:07.679487 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 6 04:44:07.679493 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 6 04:44:07.679500 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 6 04:44:07.679506 kernel: NET: Registered protocol family 1 Nov 6 04:44:07.679512 kernel: PCI: CLS 0 bytes, default 64 Nov 6 04:44:07.679518 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 6 04:44:07.679525 kernel: kvm [1]: HYP mode not available Nov 6 04:44:07.679531 kernel: Initialise system trusted keyrings Nov 6 04:44:07.679537 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 6 04:44:07.679543 kernel: Key type asymmetric registered Nov 6 04:44:07.679549 kernel: Asymmetric key parser 'x509' registered Nov 6 04:44:07.679555 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 6 04:44:07.679561 kernel: io scheduler mq-deadline registered Nov 6 04:44:07.679567 kernel: io scheduler kyber registered Nov 6 04:44:07.679573 kernel: io scheduler bfq registered Nov 6 04:44:07.679580 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 6 04:44:07.679586 kernel: ACPI: Power Button [PWRB] Nov 6 04:44:07.679593 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Nov 6 04:44:07.679645 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 6 04:44:07.679653 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 6 04:44:07.679660 kernel: msm_serial: driver initialized Nov 6 04:44:07.679666 kernel: random: fast init done Nov 6 04:44:07.679671 kernel: random: crng init done Nov 6 04:44:07.679677 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Nov 6 04:44:07.679684 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Nov 6 04:44:07.679691 kernel: thunder_xcv, ver 1.0 Nov 6 04:44:07.679697 kernel: thunder_bgx, ver 1.0 Nov 6 04:44:07.679703 kernel: nicpf, ver 1.0 Nov 6 04:44:07.679709 kernel: nicvf, ver 1.0 Nov 6 04:44:07.679767 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 6 04:44:07.679817 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-06T04:44:07 UTC (1762404247) Nov 6 04:44:07.679825 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 6 04:44:07.679837 kernel: NET: Registered protocol family 10 Nov 6 04:44:07.679846 kernel: Segment Routing with IPv6 Nov 6 04:44:07.679852 kernel: NET: Registered protocol family 17 Nov 6 04:44:07.679858 kernel: Key type dns_resolver registered Nov 6 04:44:07.679864 kernel: registered taskstats version 1 Nov 6 04:44:07.679870 kernel: Loading compiled-in X.509 certificates Nov 6 04:44:07.679876 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Nov 6 04:44:07.679882 kernel: Key type ._fscrypt registered Nov 6 04:44:07.679888 kernel: Key type .fscrypt registered Nov 6 04:44:07.679894 kernel: Key type fscrypt-provisioning registered Nov 6 04:44:07.679902 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 6 04:44:07.679908 kernel: ima: Allocated hash algorithm: sha1 Nov 6 04:44:07.679914 kernel: ima: No architecture policies found Nov 6 04:44:07.679920 kernel: Freeing unused kernel memory: 34240K Nov 6 04:44:07.679926 kernel: Run /init as init process Nov 6 04:44:07.679932 kernel: with arguments: Nov 6 04:44:07.679938 kernel: /init Nov 6 04:44:07.679943 kernel: with environment: Nov 6 04:44:07.679949 kernel: HOME=/ Nov 6 04:44:07.679955 kernel: TERM=linux Nov 6 04:44:07.679962 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 6 04:44:07.679970 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 6 04:44:07.679978 systemd[1]: Detected virtualization kvm. Nov 6 04:44:07.679985 systemd[1]: Detected architecture arm64. Nov 6 04:44:07.679991 systemd[1]: Running in initial RAM disk. Nov 6 04:44:07.679997 systemd[1]: No hostname configured, using default hostname. Nov 6 04:44:07.680004 systemd[1]: Hostname set to . Nov 6 04:44:07.680011 systemd[1]: Initializing machine ID from VM UUID. Nov 6 04:44:07.680018 systemd[1]: Queued start job for default target Initrd Default Target. Nov 6 04:44:07.680024 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 6 04:44:07.680031 systemd[1]: Reached target Local Encrypted Volumes. Nov 6 04:44:07.680037 systemd[1]: Reached target Path Units. Nov 6 04:44:07.680043 systemd[1]: Reached target Slice Units. Nov 6 04:44:07.680050 systemd[1]: Reached target Swaps. Nov 6 04:44:07.680056 systemd[1]: Reached target Timer Units. Nov 6 04:44:07.680069 systemd[1]: Listening on Open-iSCSI iscsid Socket. Nov 6 04:44:07.680075 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Nov 6 04:44:07.680082 systemd[1]: Listening on Journal Audit Socket. Nov 6 04:44:07.680088 systemd[1]: Listening on Journal Socket (/dev/log). Nov 6 04:44:07.680095 systemd[1]: Listening on Journal Socket. Nov 6 04:44:07.680101 systemd[1]: Listening on udev Control Socket. Nov 6 04:44:07.680107 systemd[1]: Listening on udev Kernel Socket. Nov 6 04:44:07.680114 systemd[1]: Reached target Socket Units. Nov 6 04:44:07.680120 systemd[1]: Starting iSCSI UserSpace I/O driver... Nov 6 04:44:07.680128 systemd[1]: Starting Create List of Static Device Nodes... Nov 6 04:44:07.680134 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Nov 6 04:44:07.680141 systemd[1]: Starting Journal Service... Nov 6 04:44:07.680147 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 6 04:44:07.680153 systemd[1]: Starting Apply Kernel Variables... Nov 6 04:44:07.680160 systemd[1]: Starting Setup Virtual Console... Nov 6 04:44:07.680166 systemd[1]: Started iSCSI UserSpace I/O driver. Nov 6 04:44:07.680172 kernel: SCSI subsystem initialized Nov 6 04:44:07.680179 systemd[1]: Finished Create List of Static Device Nodes. Nov 6 04:44:07.680185 systemd[1]: Finished Setup Virtual Console. Nov 6 04:44:07.680192 kernel: Loading iSCSI transport class v2.0-870. Nov 6 04:44:07.680199 systemd[1]: Finished Apply Kernel Variables. Nov 6 04:44:07.680208 systemd-journald[269]: Journal started Nov 6 04:44:07.680248 systemd-journald[269]: Runtime Journal (/run/log/journal/c32df9d9ae204426bdc50dcd85a862e0) is 6.0M, max 48.5M, 42.4M free. Nov 6 04:44:07.681856 systemd[1]: Started Journal Service. Nov 6 04:44:07.682512 systemd[1]: Starting dracut ask for additional cmdline parameters... Nov 6 04:44:07.683990 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 6 04:44:07.687521 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 6 04:44:07.699797 systemd[1]: Finished dracut ask for additional cmdline parameters. Nov 6 04:44:07.701510 systemd[1]: Starting dracut cmdline hook... Nov 6 04:44:07.710478 dracut-cmdline[288]: dracut-dracut-053 Nov 6 04:44:07.714568 dracut-cmdline[288]: 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 6 04:44:07.779872 kernel: iscsi: registered transport (tcp) Nov 6 04:44:07.791055 kernel: iscsi: registered transport (qla4xxx) Nov 6 04:44:07.791083 kernel: QLogic iSCSI HBA Driver Nov 6 04:44:07.801136 systemd[1]: Finished dracut cmdline hook. Nov 6 04:44:07.802602 systemd[1]: Starting dracut pre-udev hook... Nov 6 04:44:07.803813 systemd[1]: Starting Open-iSCSI... Nov 6 04:44:07.806237 iscsid[373]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 6 04:44:07.806237 iscsid[373]: 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 6 04:44:07.806237 iscsid[373]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 6 04:44:07.806237 iscsid[373]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 6 04:44:07.806237 iscsid[373]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 6 04:44:07.806237 iscsid[373]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 6 04:44:07.818679 kernel: device-mapper: uevent: version 1.0.3 Nov 6 04:44:07.818702 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Nov 6 04:44:07.809693 systemd[1]: Started Open-iSCSI. Nov 6 04:44:07.853859 kernel: raid6: neonx8 gen() 13728 MB/s Nov 6 04:44:07.870861 kernel: raid6: neonx8 xor() 10373 MB/s Nov 6 04:44:07.887863 kernel: raid6: neonx4 gen() 13533 MB/s Nov 6 04:44:07.904862 kernel: raid6: neonx4 xor() 11522 MB/s Nov 6 04:44:07.921859 kernel: raid6: neonx2 gen() 12925 MB/s Nov 6 04:44:07.938857 kernel: raid6: neonx2 xor() 9829 MB/s Nov 6 04:44:07.955857 kernel: raid6: neonx1 gen() 10652 MB/s Nov 6 04:44:07.972856 kernel: raid6: neonx1 xor() 8855 MB/s Nov 6 04:44:07.989863 kernel: raid6: int64x8 gen() 6829 MB/s Nov 6 04:44:08.006854 kernel: raid6: int64x8 xor() 3796 MB/s Nov 6 04:44:08.023856 kernel: raid6: int64x4 gen() 6909 MB/s Nov 6 04:44:08.040856 kernel: raid6: int64x4 xor() 3835 MB/s Nov 6 04:44:08.057855 kernel: raid6: int64x2 gen() 6184 MB/s Nov 6 04:44:08.074854 kernel: raid6: int64x2 xor() 3315 MB/s Nov 6 04:44:08.091853 kernel: raid6: int64x1 gen() 5009 MB/s Nov 6 04:44:08.108874 kernel: raid6: int64x1 xor() 2600 MB/s Nov 6 04:44:08.108884 kernel: raid6: using algorithm neonx8 gen() 13728 MB/s Nov 6 04:44:08.108892 kernel: raid6: .... xor() 10373 MB/s, rmw enabled Nov 6 04:44:08.109888 kernel: raid6: using neon recovery algorithm Nov 6 04:44:08.119858 kernel: xor: measuring software checksum speed Nov 6 04:44:08.119886 kernel: 8regs : 17109 MB/sec Nov 6 04:44:08.121311 kernel: 32regs : 20770 MB/sec Nov 6 04:44:08.122144 kernel: arm64_neon : 29008 MB/sec Nov 6 04:44:08.122156 kernel: xor: using function: arm64_neon (29008 MB/sec) Nov 6 04:44:08.166863 kernel: Btrfs loaded, crc32c=crc32c-generic Nov 6 04:44:08.176820 systemd[1]: Finished dracut pre-udev hook. Nov 6 04:44:08.177000 audit: BPF prog-id=6 op=LOAD Nov 6 04:44:08.177000 audit: BPF prog-id=7 op=LOAD Nov 6 04:44:08.177000 audit: BPF prog-id=8 op=LOAD Nov 6 04:44:08.178555 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 6 04:44:08.181506 kernel: audit: type=1334 audit(1762404248.177:2): prog-id=6 op=LOAD Nov 6 04:44:08.181525 kernel: audit: type=1334 audit(1762404248.177:3): prog-id=7 op=LOAD Nov 6 04:44:08.181539 kernel: audit: type=1334 audit(1762404248.177:4): prog-id=8 op=LOAD Nov 6 04:44:08.191326 systemd-udevd[406]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 6 04:44:08.193052 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 6 04:44:08.196845 systemd[1]: Starting dracut pre-trigger hook... Nov 6 04:44:08.207218 dracut-pre-trigger[417]: rd.md=0: removing MD RAID activation Nov 6 04:44:08.229571 systemd[1]: Finished dracut pre-trigger hook. Nov 6 04:44:08.231099 systemd[1]: Starting Coldplug All udev Devices... Nov 6 04:44:08.240652 systemd-udevd[406]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Nov 6 04:44:08.261696 systemd[1]: Finished Coldplug All udev Devices. Nov 6 04:44:08.263437 systemd[1]: Starting dracut initqueue hook... Nov 6 04:44:08.279599 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 6 04:44:08.279741 kernel: vda: detected capacity change from 0 to 4756340736 Nov 6 04:44:08.297859 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 6 04:44:08.299557 systemd-udevd[452]: Using default interface naming scheme 'v249'. Nov 6 04:44:08.315394 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Nov 6 04:44:08.317967 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by systemd-udevd (465) Nov 6 04:44:08.316867 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Nov 6 04:44:08.325046 systemd[1]: Found device /dev/disk/by-label/ROOT. Nov 6 04:44:08.328296 systemd[1]: Finished dracut initqueue hook. Nov 6 04:44:08.333099 systemd[1]: Reached target Initrd Root Device. Nov 6 04:44:08.333859 systemd[1]: Reached target Preparation for Remote File Systems. Nov 6 04:44:08.335530 systemd[1]: Reached target Remote Encrypted Volumes. Nov 6 04:44:08.337084 systemd[1]: Reached target Remote File Systems. Nov 6 04:44:08.339212 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Nov 6 04:44:08.340751 systemd[1]: Starting dracut pre-mount hook... Nov 6 04:44:08.341998 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 6 04:44:08.342124 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Nov 6 04:44:08.343153 systemd[1]: Reached target Preparation for Local File Systems. Nov 6 04:44:08.345273 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Nov 6 04:44:08.349897 systemd[1]: Finished dracut pre-mount hook. Nov 6 04:44:08.351402 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Nov 6 04:44:08.358878 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 6 04:44:08.360650 systemd-fsck[500]: ROOT: clean, 640/553792 files, 39961/553472 blocks Nov 6 04:44:08.363499 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Nov 6 04:44:08.365212 systemd[1]: Mounting /sysroot... Nov 6 04:44:08.380937 systemd[1]: Found device /dev/mapper/usr. Nov 6 04:44:08.382975 systemd[1]: Starting File System Check on /dev/mapper/usr... Nov 6 04:44:08.384866 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Nov 6 04:44:08.392988 systemd-fsck[511]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Nov 6 04:44:08.392988 systemd-fsck[511]: You must have r/w access to the filesystem or be root Nov 6 04:44:08.393551 systemd-fsck[508]: fsck failed with exit status 8. Nov 6 04:44:08.393554 systemd-fsck[508]: Ignoring error. Nov 6 04:44:08.394210 systemd[1]: Finished File System Check on /dev/mapper/usr. Nov 6 04:44:08.396165 systemd[1]: Mounting /sysusr/usr... Nov 6 04:44:08.407671 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Nov 6 04:44:08.407705 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Nov 6 04:44:08.408180 systemd[1]: Mounted /sysroot. Nov 6 04:44:08.408829 systemd[1]: Reached target Initrd Root File System. Nov 6 04:44:08.410571 systemd[1]: Starting Reload Configuration from the Real Root... Nov 6 04:44:08.414926 systemd[1]: Reloading. Nov 6 04:44:08.421000 audit: BPF prog-id=6 op=UNLOAD Nov 6 04:44:08.421000 audit: BPF prog-id=3 op=UNLOAD Nov 6 04:44:08.423865 kernel: audit: type=1334 audit(1762404248.421:5): prog-id=6 op=UNLOAD Nov 6 04:44:08.423888 kernel: audit: type=1334 audit(1762404248.421:6): prog-id=3 op=UNLOAD Nov 6 04:44:08.432859 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Nov 6 04:44:08.506000 audit: BPF prog-id=9 op=LOAD Nov 6 04:44:08.507000 audit: BPF prog-id=10 op=LOAD Nov 6 04:44:08.507000 audit: BPF prog-id=11 op=LOAD Nov 6 04:44:08.509512 kernel: audit: type=1334 audit(1762404248.506:7): prog-id=9 op=LOAD Nov 6 04:44:08.509538 kernel: audit: type=1334 audit(1762404248.507:8): prog-id=10 op=LOAD Nov 6 04:44:08.509547 kernel: audit: type=1334 audit(1762404248.507:9): prog-id=11 op=LOAD Nov 6 04:44:08.509556 kernel: audit: type=1334 audit(1762404248.507:10): prog-id=7 op=UNLOAD Nov 6 04:44:08.507000 audit: BPF prog-id=7 op=UNLOAD Nov 6 04:44:08.507000 audit: BPF prog-id=8 op=UNLOAD Nov 6 04:44:08.508000 audit: BPF prog-id=12 op=LOAD Nov 6 04:44:08.509000 audit: BPF prog-id=13 op=LOAD Nov 6 04:44:08.509000 audit: BPF prog-id=14 op=LOAD Nov 6 04:44:08.509000 audit: BPF prog-id=4 op=UNLOAD Nov 6 04:44:08.509000 audit: BPF prog-id=5 op=UNLOAD Nov 6 04:44:08.511496 systemd[1]: Mounted /sysusr/usr. Nov 6 04:44:08.513562 systemd[1]: Reached target Local File Systems. Nov 6 04:44:08.514390 systemd[1]: Reached target System Initialization. Nov 6 04:44:08.515787 systemd[1]: Reached target Basic System. Nov 6 04:44:08.518018 systemd[1]: Mounting /sysroot/usr... Nov 6 04:44:08.520498 systemd[1]: Mounted /sysroot/usr. Nov 6 04:44:08.529363 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 6 04:44:08.529486 systemd[1]: Finished Reload Configuration from the Real Root. Nov 6 04:44:08.531309 systemd[1]: Reached target Initrd File Systems. Nov 6 04:44:08.532634 systemd[1]: Reached target Initrd Default Target. Nov 6 04:44:08.534048 systemd[1]: Condition check resulted in dracut mount hook being skipped. Nov 6 04:44:08.534743 systemd[1]: Starting dracut pre-pivot and cleanup hook... Nov 6 04:44:08.545173 systemd[1]: Finished dracut pre-pivot and cleanup hook. Nov 6 04:44:08.546746 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Nov 6 04:44:08.552677 systemd[1]: Stopped target Remote Encrypted Volumes. Nov 6 04:44:08.553706 systemd[1]: Stopped target Timer Units. Nov 6 04:44:08.555155 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 6 04:44:08.555277 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Nov 6 04:44:08.556627 systemd[1]: Stopped target Initrd Default Target. Nov 6 04:44:08.558168 systemd[1]: Stopped target Basic System. Nov 6 04:44:08.559575 systemd[1]: Stopped target Initrd Root Device. Nov 6 04:44:08.560995 systemd[1]: Stopped target Path Units. Nov 6 04:44:08.562251 systemd[1]: Stopped target Remote File Systems. Nov 6 04:44:08.563645 systemd[1]: Stopped target Preparation for Remote File Systems. Nov 6 04:44:08.565109 systemd[1]: Stopped target Slice Units. Nov 6 04:44:08.566433 systemd[1]: Stopped target Socket Units. Nov 6 04:44:08.567891 systemd[1]: Stopped target System Initialization. Nov 6 04:44:08.569260 systemd[1]: Stopped target Local File Systems. Nov 6 04:44:08.570598 systemd[1]: Stopped target Preparation for Local File Systems. Nov 6 04:44:08.572190 systemd[1]: Stopped target Swaps. Nov 6 04:44:08.573418 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 6 04:44:08.573534 systemd[1]: Stopped dracut pre-mount hook. Nov 6 04:44:08.574963 systemd[1]: Stopped target Local Encrypted Volumes. Nov 6 04:44:08.576168 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 6 04:44:08.580884 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Nov 6 04:44:08.581976 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 6 04:44:08.582097 systemd[1]: Stopped dracut initqueue hook. Nov 6 04:44:08.585502 iscsid[373]: iscsid shutting down. Nov 6 04:44:08.583744 systemd[1]: Stopping Open-iSCSI... Nov 6 04:44:08.584916 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 6 04:44:08.585029 systemd[1]: Stopped Apply Kernel Variables. Nov 6 04:44:08.586296 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 6 04:44:08.586385 systemd[1]: Stopped Coldplug All udev Devices. Nov 6 04:44:08.587567 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 6 04:44:08.587659 systemd[1]: Stopped dracut pre-trigger hook. Nov 6 04:44:08.590642 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Nov 6 04:44:08.594572 systemd[1]: iscsid.service: Deactivated successfully. Nov 6 04:44:08.594685 systemd[1]: Stopped Open-iSCSI. Nov 6 04:44:08.596245 systemd[1]: iscsid.socket: Deactivated successfully. Nov 6 04:44:08.596292 systemd[1]: Closed Open-iSCSI iscsid Socket. Nov 6 04:44:08.598690 systemd[1]: Stopping iSCSI UserSpace I/O driver... Nov 6 04:44:08.601352 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 6 04:44:08.601466 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Nov 6 04:44:08.608000 audit: BPF prog-id=9 op=UNLOAD Nov 6 04:44:08.602896 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 6 04:44:08.602992 systemd[1]: Stopped iSCSI UserSpace I/O driver. Nov 6 04:44:08.604376 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 6 04:44:08.604483 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Nov 6 04:44:08.606431 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 6 04:44:08.606481 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Nov 6 04:44:08.608256 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 6 04:44:08.608296 systemd[1]: Closed udev Control Socket. Nov 6 04:44:08.609743 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 6 04:44:08.609774 systemd[1]: Closed udev Kernel Socket. Nov 6 04:44:08.611280 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 6 04:44:08.611322 systemd[1]: Stopped dracut pre-udev hook. Nov 6 04:44:08.612617 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 6 04:44:08.612657 systemd[1]: Stopped dracut cmdline hook. Nov 6 04:44:08.614169 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 6 04:44:08.614208 systemd[1]: Stopped dracut ask for additional cmdline parameters. Nov 6 04:44:08.616550 systemd[1]: Starting Cleanup udev Database... Nov 6 04:44:08.617339 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Nov 6 04:44:08.618638 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 6 04:44:08.618713 systemd[1]: Stopped Create Static Device Nodes in /dev. Nov 6 04:44:08.620469 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 6 04:44:08.620508 systemd[1]: Stopped Create List of Static Device Nodes. Nov 6 04:44:08.621868 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 6 04:44:08.637000 audit: BPF prog-id=12 op=UNLOAD Nov 6 04:44:08.621914 systemd[1]: Stopped Setup Virtual Console. Nov 6 04:44:08.623745 systemd[1]: rngd.service: Deactivated successfully. Nov 6 04:44:08.623895 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Nov 6 04:44:08.625149 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 6 04:44:08.625252 systemd[1]: Finished Cleanup udev Database. Nov 6 04:44:08.626692 systemd[1]: Reached target Switch Root. Nov 6 04:44:08.628513 systemd[1]: Starting Switch Root... Nov 6 04:44:08.635949 systemd[1]: Switching root. Nov 6 04:44:08.652123 systemd-journald[269]: Journal stopped Nov 6 04:44:10.715671 systemd-journald[269]: Received SIGTERM from PID 1 (systemd). Nov 6 04:44:10.715712 kernel: SELinux: policy capability network_peer_controls=1 Nov 6 04:44:10.715726 kernel: SELinux: policy capability open_perms=1 Nov 6 04:44:10.715739 kernel: SELinux: policy capability extended_socket_class=1 Nov 6 04:44:10.715750 kernel: SELinux: policy capability always_check_network=0 Nov 6 04:44:10.715761 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 6 04:44:10.715770 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 6 04:44:10.715779 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 6 04:44:10.715789 systemd[1]: Successfully loaded SELinux policy in 32.208ms. Nov 6 04:44:10.715805 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.764ms. Nov 6 04:44:10.715815 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 6 04:44:10.715826 systemd[1]: Detected virtualization kvm. Nov 6 04:44:10.715862 systemd[1]: Detected architecture arm64. Nov 6 04:44:10.715875 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 6 04:44:10.715886 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 6 04:44:10.715898 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 6 04:44:10.715909 systemd[1]: Stopped Switch Root. Nov 6 04:44:10.715919 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 6 04:44:10.715929 systemd[1]: Created slice Slice /system/addon-config. Nov 6 04:44:10.715939 systemd[1]: Created slice Slice /system/addon-run. Nov 6 04:44:10.715949 systemd[1]: Created slice Slice /system/getty. Nov 6 04:44:10.715959 systemd[1]: Created slice Slice /system/modprobe. Nov 6 04:44:10.715969 systemd[1]: Created slice Slice /system/serial-getty. Nov 6 04:44:10.715979 systemd[1]: Created slice Slice /system/system-cloudinit. Nov 6 04:44:10.715989 systemd[1]: Created slice Slice /system/systemd-fsck. Nov 6 04:44:10.715999 systemd[1]: Created slice User and Session Slice. Nov 6 04:44:10.716009 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Nov 6 04:44:10.716018 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Nov 6 04:44:10.716028 systemd[1]: Set up automount Boot partition Automount Point. Nov 6 04:44:10.716038 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 6 04:44:10.716049 systemd[1]: Stopped target Switch Root. Nov 6 04:44:10.716060 systemd[1]: Stopped target Initrd File Systems. Nov 6 04:44:10.716078 systemd[1]: Stopped target Initrd Root File System. Nov 6 04:44:10.716090 systemd[1]: Reached target Remote Encrypted Volumes. Nov 6 04:44:10.716103 systemd[1]: Reached target Remote File Systems. Nov 6 04:44:10.716113 systemd[1]: Reached target Slice Units. Nov 6 04:44:10.716123 systemd[1]: Reached target Swaps. Nov 6 04:44:10.716134 systemd[1]: Reached target Verify torcx succeeded. Nov 6 04:44:10.716144 systemd[1]: Reached target Local Verity Protected Volumes. Nov 6 04:44:10.716153 systemd[1]: Listening on Process Core Dump Socket. Nov 6 04:44:10.716163 systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 6 04:44:10.716174 systemd[1]: Listening on Network Service Netlink Socket. Nov 6 04:44:10.716184 systemd[1]: Listening on udev Control Socket. Nov 6 04:44:10.716194 systemd[1]: Listening on udev Kernel Socket. Nov 6 04:44:10.716203 systemd[1]: Mounting Huge Pages File System... Nov 6 04:44:10.716213 systemd[1]: Mounting POSIX Message Queue File System... Nov 6 04:44:10.716222 systemd[1]: Mounting External Media Directory... Nov 6 04:44:10.716232 systemd[1]: Mounting Kernel Debug File System... Nov 6 04:44:10.716242 systemd[1]: Mounting Kernel Trace File System... Nov 6 04:44:10.716252 systemd[1]: Mounting Temporary Directory /tmp... Nov 6 04:44:10.716264 systemd[1]: Starting Create missing system files... Nov 6 04:44:10.716275 systemd[1]: Starting Create List of Static Device Nodes... Nov 6 04:44:10.716284 systemd[1]: Starting Load Kernel Module configfs... Nov 6 04:44:10.716295 systemd[1]: Starting Load Kernel Module drm... Nov 6 04:44:10.716304 systemd[1]: Starting Load Kernel Module fuse... Nov 6 04:44:10.716316 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Nov 6 04:44:10.716326 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 6 04:44:10.716336 systemd[1]: Stopped File System Check on Root Device. Nov 6 04:44:10.716346 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 6 04:44:10.716356 systemd[1]: Stopped systemd-fsck-usr.service. Nov 6 04:44:10.716367 kernel: fuse: init (API version 7.32) Nov 6 04:44:10.716378 systemd[1]: Stopped Journal Service. Nov 6 04:44:10.716389 systemd[1]: Starting Journal Service... Nov 6 04:44:10.716399 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Nov 6 04:44:10.716409 systemd[1]: Starting Remount Root and Kernel File Systems... Nov 6 04:44:10.716420 systemd[1]: Starting Apply Kernel Variables... Nov 6 04:44:10.716430 systemd[1]: Starting Coldplug All udev Devices... Nov 6 04:44:10.716441 systemd[1]: verity-setup.service: Deactivated successfully. Nov 6 04:44:10.716452 systemd-journald[690]: Journal started Nov 6 04:44:10.716491 systemd-journald[690]: Runtime Journal (/run/log/journal/c32df9d9ae204426bdc50dcd85a862e0) is 6.0M, max 48.5M, 42.4M free. Nov 6 04:44:08.727000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 6 04:44:08.754000 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 6 04:44:08.754000 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 6 04:44:08.754000 audit: BPF prog-id=15 op=LOAD Nov 6 04:44:08.754000 audit: BPF prog-id=15 op=UNLOAD Nov 6 04:44:08.755000 audit: BPF prog-id=16 op=LOAD Nov 6 04:44:08.755000 audit: BPF prog-id=16 op=UNLOAD Nov 6 04:44:08.796000 audit[642]: AVC avc: denied { associate } for pid=642 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 6 04:44:10.592000 audit: BPF prog-id=17 op=LOAD Nov 6 04:44:10.592000 audit: BPF prog-id=18 op=LOAD Nov 6 04:44:10.592000 audit: BPF prog-id=19 op=LOAD Nov 6 04:44:10.592000 audit: BPF prog-id=13 op=UNLOAD Nov 6 04:44:10.592000 audit: BPF prog-id=14 op=UNLOAD Nov 6 04:44:10.603000 audit: BPF prog-id=20 op=LOAD Nov 6 04:44:10.603000 audit: BPF prog-id=17 op=UNLOAD Nov 6 04:44:10.603000 audit: BPF prog-id=21 op=LOAD Nov 6 04:44:10.603000 audit: BPF prog-id=22 op=LOAD Nov 6 04:44:10.603000 audit: BPF prog-id=18 op=UNLOAD Nov 6 04:44:10.603000 audit: BPF prog-id=19 op=UNLOAD Nov 6 04:44:10.603000 audit: BPF prog-id=23 op=LOAD Nov 6 04:44:10.603000 audit: BPF prog-id=20 op=UNLOAD Nov 6 04:44:10.603000 audit: BPF prog-id=24 op=LOAD Nov 6 04:44:10.603000 audit: BPF prog-id=25 op=LOAD Nov 6 04:44:10.603000 audit: BPF prog-id=21 op=UNLOAD Nov 6 04:44:10.603000 audit: BPF prog-id=22 op=UNLOAD Nov 6 04:44:10.613000 audit: BPF prog-id=23 op=UNLOAD Nov 6 04:44:10.702000 audit: BPF prog-id=26 op=LOAD Nov 6 04:44:10.702000 audit: BPF prog-id=27 op=LOAD Nov 6 04:44:10.702000 audit: BPF prog-id=28 op=LOAD Nov 6 04:44:10.702000 audit: BPF prog-id=24 op=UNLOAD Nov 6 04:44:10.702000 audit: BPF prog-id=25 op=UNLOAD Nov 6 04:44:10.713000 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 6 04:44:10.592612 systemd[1]: Queued start job for default target Multi-User System. Nov 6 04:44:08.795204 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" 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 6 04:44:10.605044 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 6 04:44:08.795494 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 6 04:44:08.795513 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 6 04:44:10.717538 systemd[1]: Stopped verity-setup.service. Nov 6 04:44:08.795821 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 6 04:44:08.795849 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 6 04:44:08.795888 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 6 04:44:08.795901 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 6 04:44:08.796268 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 6 04:44:08.796313 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 6 04:44:08.796330 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 6 04:44:08.796713 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" 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 6 04:44:08.796745 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" 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 6 04:44:08.796765 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" 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 6 04:44:08.796780 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Nov 6 04:44:08.796898 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" 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 6 04:44:08.796916 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:08Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 6 04:44:10.499265 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:10Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 6 04:44:10.499544 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:10Z" 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 6 04:44:10.499645 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:10Z" 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 6 04:44:10.499769 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:10Z" 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 6 04:44:10.499882 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:10Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 6 04:44:10.499939 /usr/lib/systemd/system-generators/torcx-generator[642]: time="2025-11-06T04:44:10Z" 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 6 04:44:10.721062 systemd[1]: Started Journal Service. Nov 6 04:44:10.721599 systemd[1]: Mounted Huge Pages File System. Nov 6 04:44:10.722574 systemd[1]: Mounted POSIX Message Queue File System. Nov 6 04:44:10.723633 systemd[1]: Mounted External Media Directory. Nov 6 04:44:10.724596 systemd[1]: Mounted Kernel Debug File System. Nov 6 04:44:10.725596 systemd[1]: Mounted Kernel Trace File System. Nov 6 04:44:10.726532 systemd[1]: Mounted Temporary Directory /tmp. Nov 6 04:44:10.727760 systemd[1]: Finished Create missing system files. Nov 6 04:44:10.729023 systemd[1]: Finished Create List of Static Device Nodes. Nov 6 04:44:10.730160 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 6 04:44:10.730353 systemd[1]: Finished Load Kernel Module configfs. Nov 6 04:44:10.731465 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 6 04:44:10.731662 systemd[1]: Finished Load Kernel Module drm. Nov 6 04:44:10.732697 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 6 04:44:10.732901 systemd[1]: Finished Load Kernel Module fuse. Nov 6 04:44:10.734029 systemd[1]: Finished Remount Root and Kernel File Systems. Nov 6 04:44:10.755333 systemd[1]: Finished Apply Kernel Variables. Nov 6 04:44:10.758462 systemd[1]: Mounting FUSE Control File System... Nov 6 04:44:10.760314 systemd[1]: Mounting Kernel Configuration File System... Nov 6 04:44:10.761269 systemd[1]: Condition check resulted in Remount Root File System being skipped. Nov 6 04:44:10.762259 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Nov 6 04:44:10.763248 systemd[1]: Starting Flush Journal to Persistent Storage... Nov 6 04:44:10.764469 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Nov 6 04:44:10.765456 systemd[1]: Starting Load/Save Random Seed... Nov 6 04:44:10.768636 systemd-journald[690]: Time spent on flushing to /var/log/journal/c32df9d9ae204426bdc50dcd85a862e0 is 11.449ms for 666 entries. Nov 6 04:44:10.768636 systemd-journald[690]: System Journal (/var/log/journal/c32df9d9ae204426bdc50dcd85a862e0) is 8.0M, max 203.0M, 195.0M free. Nov 6 04:44:10.789000 audit: BPF prog-id=29 op=LOAD Nov 6 04:44:10.790000 audit: BPF prog-id=30 op=LOAD Nov 6 04:44:10.790000 audit: BPF prog-id=31 op=LOAD Nov 6 04:44:10.790000 audit: BPF prog-id=10 op=UNLOAD Nov 6 04:44:10.790000 audit: BPF prog-id=11 op=UNLOAD Nov 6 04:44:10.766438 systemd[1]: Condition check resulted in Create System Users being skipped. Nov 6 04:44:10.767425 systemd[1]: Starting Create Static Device Nodes in /dev... Nov 6 04:44:10.769315 systemd[1]: Mounted FUSE Control File System. Nov 6 04:44:10.771266 systemd[1]: Mounted Kernel Configuration File System. Nov 6 04:44:10.775008 systemd[1]: Finished Load/Save Random Seed. Nov 6 04:44:10.776598 systemd[1]: Condition check resulted in First Boot Complete being skipped. Nov 6 04:44:10.784169 systemd[1]: Finished Coldplug All udev Devices. Nov 6 04:44:10.785447 systemd[1]: Finished Create Static Device Nodes in /dev. Nov 6 04:44:10.788792 systemd[1]: Starting Wait for udev To Complete Device Initialization... Nov 6 04:44:10.791498 systemd[1]: Starting Rule-based Manager for Device Events and Files... Nov 6 04:44:10.794818 systemd[1]: Finished Flush Journal to Persistent Storage. Nov 6 04:44:10.834063 systemd[1]: Started Rule-based Manager for Device Events and Files. Nov 6 04:44:10.839000 audit: BPF prog-id=32 op=LOAD Nov 6 04:44:10.841104 systemd[1]: Starting Network Configuration... Nov 6 04:44:10.872964 systemd-networkd[721]: lo: Link UP Nov 6 04:44:10.872976 systemd-networkd[721]: lo: Gained carrier Nov 6 04:44:10.873389 systemd-networkd[721]: Enumeration completed Nov 6 04:44:10.873508 systemd[1]: Started Network Configuration. Nov 6 04:44:10.884138 systemd-udevd[707]: Using default interface naming scheme 'v249'. Nov 6 04:44:10.908182 udevadm[702]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Nov 6 04:44:10.918550 systemd-networkd[721]: eth0: Link UP Nov 6 04:44:10.926921 systemd-networkd[721]: eth0: Gained carrier Nov 6 04:44:10.928973 systemd[1]: Finished Wait for udev To Complete Device Initialization. Nov 6 04:44:10.937997 systemd-networkd[721]: eth0: DHCPv4 address 10.0.0.3/16 via 10.0.0.1 Nov 6 04:44:10.938857 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 6 04:44:10.947002 lvm[730]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 6 04:44:10.977924 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 6 04:44:10.978936 systemd[1]: Reached target Local Encrypted Volumes. Nov 6 04:44:10.995878 systemd[1]: Starting Activation of LVM2 logical volumes... Nov 6 04:44:10.999291 lvm[731]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 6 04:44:11.028899 systemd[1]: Finished Activation of LVM2 logical volumes. Nov 6 04:44:11.029888 systemd[1]: Reached target Preparation for Local File Systems. Nov 6 04:44:11.030862 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Nov 6 04:44:11.030890 systemd[1]: Reached target Containers. Nov 6 04:44:11.043131 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Nov 6 04:44:11.054793 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Nov 6 04:44:11.057044 systemd[1]: Mounting /usr/share/oem... Nov 6 04:44:11.062870 kernel: BTRFS info (device vda6): disk space caching is enabled Nov 6 04:44:11.063017 kernel: BTRFS info (device vda6): has skinny extents Nov 6 04:44:11.064942 systemd[1]: Mounted /usr/share/oem. Nov 6 04:44:11.065685 systemd[1]: Reached target Local File Systems. Nov 6 04:44:11.066599 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped. Nov 6 04:44:11.066947 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 6 04:44:11.066984 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Nov 6 04:44:11.067013 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Nov 6 04:44:11.078691 systemd[1]: Starting Create Volatile Files and Directories... Nov 6 04:44:11.084705 systemd-tmpfiles[754]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 6 04:44:11.085721 systemd-tmpfiles[754]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Nov 6 04:44:11.112270 systemd-tmpfiles[754]: Detected autofs mount point /boot during canonicalization of /boot. Nov 6 04:44:11.112283 systemd-tmpfiles[754]: Skipping /boot Nov 6 04:44:11.117636 systemd-tmpfiles[754]: Detected autofs mount point /boot during canonicalization of /boot. Nov 6 04:44:11.117652 systemd-tmpfiles[754]: Skipping /boot Nov 6 04:44:11.147623 systemd[1]: Finished Create Volatile Files and Directories. Nov 6 04:44:11.159817 systemd[1]: Starting Load Security Auditing Rules... Nov 6 04:44:11.161593 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Nov 6 04:44:11.162656 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped. Nov 6 04:44:11.162000 audit: BPF prog-id=33 op=LOAD Nov 6 04:44:11.164064 systemd[1]: Starting Network Name Resolution... Nov 6 04:44:11.164000 audit: BPF prog-id=34 op=LOAD Nov 6 04:44:11.166686 systemd[1]: Starting Network Time Synchronization... Nov 6 04:44:11.167913 systemd[1]: Condition check resulted in Update is Completed being skipped. Nov 6 04:44:11.169611 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Nov 6 04:44:11.171056 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Nov 6 04:44:11.172260 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Nov 6 04:44:11.175214 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Nov 6 04:44:11.191000 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 6 04:44:11.192646 augenrules[776]: No rules Nov 6 04:44:11.193402 systemd[1]: Finished Load Security Auditing Rules. Nov 6 04:44:10.063430 systemd-timesyncd[764]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Nov 6 04:44:10.064216 systemd-resolved[758]: Positive Trust Anchors: Nov 6 04:44:10.064223 systemd-resolved[758]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 6 04:44:10.064249 systemd-resolved[758]: 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 6 04:44:10.064407 systemd[1]: Started Network Time Synchronization. Nov 6 04:44:10.065684 systemd[1]: Reached target System Initialization. Nov 6 04:44:10.066908 systemd-resolved[758]: Defaulting to hostname 'linux'. Nov 6 04:44:10.066912 systemd[1]: Started Watch for update engine configuration changes. Nov 6 04:44:10.068217 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 6 04:44:10.071138 systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 6 04:44:10.072402 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Nov 6 04:44:10.072432 systemd[1]: Reached target Path Units. Nov 6 04:44:10.073118 systemd[1]: Reached target System Time Set. Nov 6 04:44:10.075524 systemd[1]: Started Daily Log Rotation. Nov 6 04:44:10.076530 systemd[1]: Started Weekly check for MD array's redundancy information.. Nov 6 04:44:10.077640 systemd[1]: Reached target Timer Units. Nov 6 04:44:10.078706 systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 6 04:44:10.089944 systemd[1]: Starting Docker Socket for the API... Nov 6 04:44:10.093163 systemd[1]: Listening on OpenSSH Server Socket. Nov 6 04:44:10.094485 systemd[1]: Started Network Name Resolution. Nov 6 04:44:10.095438 systemd[1]: Listening on Docker Socket for the API. Nov 6 04:44:10.096342 systemd[1]: Reached target Network. Nov 6 04:44:10.097013 systemd[1]: Reached target Host and Network Name Lookups. Nov 6 04:44:10.097952 systemd[1]: Reached target Socket Units. Nov 6 04:44:10.098702 systemd[1]: Reached target Basic System. Nov 6 04:44:10.099442 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Nov 6 04:44:10.099473 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Nov 6 04:44:10.100444 systemd[1]: Started D-Bus System Message Bus. Nov 6 04:44:10.103578 systemd[1]: Starting Extend Filesystems... Nov 6 04:44:10.104362 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Nov 6 04:44:10.105333 systemd[1]: Starting Generate /run/flatcar/motd... Nov 6 04:44:10.107093 systemd[1]: Starting Install an ssh key from /proc/cmdline... Nov 6 04:44:10.108909 systemd[1]: Starting Generate sshd host keys... Nov 6 04:44:10.110419 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Nov 6 04:44:10.110454 systemd[1]: Reached target Load system-provided cloud configs. Nov 6 04:44:10.115045 systemd[1]: Starting User Login Management... Nov 6 04:44:10.116253 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 6 04:44:10.116789 extend-filesystems[786]: Found vda Nov 6 04:44:10.116916 systemd[1]: Starting Update Engine... Nov 6 04:44:10.117684 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Nov 6 04:44:10.117711 systemd[1]: Reached target Load user-provided cloud configs. Nov 6 04:44:10.119102 extend-filesystems[786]: Found vda1 Nov 6 04:44:10.119102 extend-filesystems[786]: Found vda2 Nov 6 04:44:10.119102 extend-filesystems[786]: Found vda3 Nov 6 04:44:10.119102 extend-filesystems[786]: Found usr Nov 6 04:44:10.119102 extend-filesystems[786]: Found vda4 Nov 6 04:44:10.119102 extend-filesystems[786]: Found vda6 Nov 6 04:44:10.119102 extend-filesystems[786]: Found vda7 Nov 6 04:44:10.119102 extend-filesystems[786]: Found vda9 Nov 6 04:44:10.119102 extend-filesystems[786]: Checking size of /dev/vda9 Nov 6 04:44:10.120102 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 6 04:44:10.120352 systemd[1]: Finished Install an ssh key from /proc/cmdline. Nov 6 04:44:10.122594 systemd[1]: motdgen.service: Deactivated successfully. Nov 6 04:44:10.122811 systemd[1]: Finished Generate /run/flatcar/motd. Nov 6 04:44:10.137550 extend-filesystems[786]: Old size kept for /dev/vda9 Nov 6 04:44:10.137752 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 6 04:44:10.137979 systemd[1]: Finished Extend Filesystems. Nov 6 04:44:10.164127 update_engine[800]: I1106 04:44:10.163763 800 main.cc:89] Flatcar Update Engine starting Nov 6 04:44:10.164877 update_engine[800]: I1106 04:44:10.164846 800 payload_state.cc:360] Current Response Signature = Nov 6 04:44:10.164877 update_engine[800]: NumURLs = 1 Nov 6 04:44:10.164877 update_engine[800]: Url0 = http://10.0.0.2:34567/packages/update.gz Nov 6 04:44:10.164877 update_engine[800]: Payload Size = 434038479 Nov 6 04:44:10.164877 update_engine[800]: Payload Sha256 Hash = khqRMHuZIPKN4kcwxShqRXyUc6wqJFavlp0HB0NXSnY= Nov 6 04:44:10.164877 update_engine[800]: Is Delta Payload = 0 Nov 6 04:44:10.164877 update_engine[800]: Max Failure Count Per Url = 10 Nov 6 04:44:10.164877 update_engine[800]: Disable Payload Backoff = 1 Nov 6 04:44:10.165071 update_engine[800]: I1106 04:44:10.165052 800 payload_state.cc:381] Payload Attempt Number = 0 Nov 6 04:44:10.165279 update_engine[800]: I1106 04:44:10.165238 800 payload_state.cc:404] Current URL Index = 0 Nov 6 04:44:10.165459 update_engine[800]: I1106 04:44:10.165434 800 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Nov 6 04:44:10.165660 update_engine[800]: I1106 04:44:10.165625 800 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Nov 6 04:44:10.166790 systemd-logind[798]: Watching system buttons on /dev/input/event0 (Power Button) Nov 6 04:44:10.167035 systemd-logind[798]: New seat seat0. Nov 6 04:44:10.167472 systemd[1]: Started Update Engine. Nov 6 04:44:10.169860 update_engine[800]: I1106 04:44:10.169064 800 update_check_scheduler.cc:74] Next update check in 6m27s Nov 6 04:44:10.170467 systemd[1]: Started User Login Management. Nov 6 04:44:10.174236 systemd[1]: Finished Generate sshd host keys. Nov 6 04:44:10.189408 systemd[1]: Starting Generate /run/issue... Nov 6 04:44:10.193830 systemd[1]: issuegen.service: Deactivated successfully. Nov 6 04:44:10.194069 systemd[1]: Finished Generate /run/issue. Nov 6 04:44:10.196143 systemd[1]: Starting Permit User Sessions... Nov 6 04:44:10.200729 systemd[1]: Finished Permit User Sessions. Nov 6 04:44:10.202747 systemd[1]: Started Getty on tty1. Nov 6 04:44:10.204735 systemd[1]: Started Serial Getty on ttyAMA0. Nov 6 04:44:10.205762 systemd[1]: Reached target Login Prompts. Nov 6 04:44:10.206618 systemd[1]: Reached target Multi-User System. Nov 6 04:44:10.208553 systemd[1]: Starting Record Runlevel Change in UTMP... Nov 6 04:44:10.213582 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 6 04:44:10.213807 systemd[1]: Finished Record Runlevel Change in UTMP. Nov 6 04:44:10.214833 systemd[1]: Startup finished in 691ms (kernel) + 1.137s (initrd) + 2.663s (userspace) = 4.492s. Nov 6 04:44:10.811512 systemd[1]: Created slice Slice /system/sshd. Nov 6 04:44:10.812813 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:55018). Nov 6 04:44:10.849610 sshd[825]: Accepted publickey for core from 10.0.0.1 port 55018 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:44:10.851574 sshd[825]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:44:10.866789 systemd[1]: Created slice User Slice of UID 500. Nov 6 04:44:10.867992 systemd[1]: Starting User Runtime Directory /run/user/500... Nov 6 04:44:10.869669 systemd-logind[798]: New session 1 of user core. Nov 6 04:44:10.874302 systemd[1]: Finished User Runtime Directory /run/user/500. Nov 6 04:44:10.875716 systemd[1]: Starting User Manager for UID 500... Nov 6 04:44:10.877926 systemd[828]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:44:10.927776 systemd[828]: Queued start job for default target Main User Target. Nov 6 04:44:10.927939 systemd[828]: Reached target Paths. Nov 6 04:44:10.927953 systemd[828]: Reached target Sockets. Nov 6 04:44:10.927968 systemd[828]: Reached target Timers. Nov 6 04:44:10.927980 systemd[828]: Reached target Basic System. Nov 6 04:44:10.928022 systemd[828]: Reached target Main User Target. Nov 6 04:44:10.928034 systemd[828]: Startup finished in 46ms. Nov 6 04:44:10.928116 systemd[1]: Started User Manager for UID 500. Nov 6 04:44:10.939447 systemd[1]: Started Session 1 of User core. Nov 6 04:44:11.000989 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54664). Nov 6 04:44:11.034953 sshd[837]: Accepted publickey for core from 10.0.0.1 port 54664 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:44:11.035994 sshd[837]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:44:11.038851 systemd-logind[798]: New session 2 of user core. Nov 6 04:44:11.050508 systemd[1]: Started Session 2 of User core. Nov 6 04:44:11.102666 sshd[837]: pam_unix(sshd:session): session closed for user core Nov 6 04:44:11.115823 systemd[1]: sshd@1-10.0.0.3:22-10.0.0.1:54664.service: Deactivated successfully. Nov 6 04:44:11.116450 systemd[1]: session-2.scope: Deactivated successfully. Nov 6 04:44:11.117011 systemd-logind[798]: Session 2 logged out. Waiting for processes to exit. Nov 6 04:44:11.117978 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54666). Nov 6 04:44:11.118450 systemd-logind[798]: Removed session 2. Nov 6 04:44:11.150255 sshd[843]: Accepted publickey for core from 10.0.0.1 port 54666 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:44:11.151201 sshd[843]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:44:11.154052 systemd-logind[798]: New session 3 of user core. Nov 6 04:44:11.162410 systemd[1]: Started Session 3 of User core. Nov 6 04:44:11.209535 sshd[843]: pam_unix(sshd:session): session closed for user core Nov 6 04:44:11.223240 systemd[1]: sshd@2-10.0.0.3:22-10.0.0.1:54666.service: Deactivated successfully. Nov 6 04:44:11.223864 systemd[1]: session-3.scope: Deactivated successfully. Nov 6 04:44:11.224449 systemd-logind[798]: Session 3 logged out. Waiting for processes to exit. Nov 6 04:44:11.225422 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54672). Nov 6 04:44:11.226102 systemd-logind[798]: Removed session 3. Nov 6 04:44:11.262413 sshd[850]: Accepted publickey for core from 10.0.0.1 port 54672 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:44:11.263398 sshd[850]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:44:11.266306 systemd-logind[798]: New session 4 of user core. Nov 6 04:44:11.278446 systemd[1]: Started Session 4 of User core. Nov 6 04:44:11.329575 sshd[850]: pam_unix(sshd:session): session closed for user core Nov 6 04:44:11.341195 systemd[1]: sshd@3-10.0.0.3:22-10.0.0.1:54672.service: Deactivated successfully. Nov 6 04:44:11.341750 systemd[1]: session-4.scope: Deactivated successfully. Nov 6 04:44:11.342338 systemd-logind[798]: Session 4 logged out. Waiting for processes to exit. Nov 6 04:44:11.343317 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54674). Nov 6 04:44:11.343942 systemd-logind[798]: Removed session 4. Nov 6 04:44:11.375209 sshd[856]: Accepted publickey for core from 10.0.0.1 port 54674 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:44:11.375936 sshd[856]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:44:11.379031 systemd-logind[798]: New session 5 of user core. Nov 6 04:44:11.386403 systemd-networkd[721]: eth0: Gained IPv6LL Nov 6 04:44:11.388508 systemd[1]: Started Session 5 of User core. Nov 6 04:44:11.443858 sudo[859]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Nov 6 04:44:11.444066 sudo[859]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 6 04:44:11.460620 sudo[859]: pam_unix(sudo:session): session closed for user root Nov 6 04:44:11.462477 sshd[856]: pam_unix(sshd:session): session closed for user core Nov 6 04:44:11.477747 dbus-daemon[785]: [system] Reloaded configuration Nov 6 04:44:11.478174 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54680). Nov 6 04:44:11.480646 systemd[1]: sshd@4-10.0.0.3:22-10.0.0.1:54674.service: Deactivated successfully. Nov 6 04:44:11.481314 systemd[1]: session-5.scope: Deactivated successfully. Nov 6 04:44:11.481982 systemd-logind[798]: Session 5 logged out. Waiting for processes to exit. Nov 6 04:44:11.482810 systemd-logind[798]: Removed session 5. Nov 6 04:44:11.510558 sshd[862]: Accepted publickey for core from 10.0.0.1 port 54680 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:44:11.511555 sshd[862]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:44:11.514119 systemd-logind[798]: New session 6 of user core. Nov 6 04:44:11.524427 systemd[1]: Started Session 6 of User core. Nov 6 04:44:11.575293 sudo[868]: 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 6 04:44:11.575498 sudo[868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 6 04:44:11.577727 sudo[868]: pam_unix(sudo:session): session closed for user root Nov 6 04:44:11.581152 sudo[867]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Nov 6 04:44:11.581371 sudo[867]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 6 04:44:11.599335 systemd[1]: Stopping Load Security Auditing Rules... Nov 6 04:44:11.599000 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 6 04:44:11.601447 auditctl[871]: No rules Nov 6 04:44:11.601759 systemd[1]: audit-rules.service: Deactivated successfully. Nov 6 04:44:11.601990 systemd[1]: Stopped Load Security Auditing Rules. Nov 6 04:44:11.602951 kernel: kauditd_printk_skb: 49 callbacks suppressed Nov 6 04:44:11.602985 kernel: audit: type=1305 audit(1762404251.599:60): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 6 04:44:11.603348 systemd[1]: Starting Load Security Auditing Rules... Nov 6 04:44:11.617789 augenrules[888]: No rules Nov 6 04:44:11.618464 systemd[1]: Finished Load Security Auditing Rules. Nov 6 04:44:11.619318 sudo[867]: pam_unix(sudo:session): session closed for user root Nov 6 04:44:11.620558 sshd[862]: pam_unix(sshd:session): session closed for user core Nov 6 04:44:11.636906 systemd[1]: sshd@5-10.0.0.3:22-10.0.0.1:54680.service: Deactivated successfully. Nov 6 04:44:11.637494 systemd[1]: session-6.scope: Deactivated successfully. Nov 6 04:44:11.638139 systemd-logind[798]: Session 6 logged out. Waiting for processes to exit. Nov 6 04:44:11.639196 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54690). Nov 6 04:44:11.639929 systemd-logind[798]: Removed session 6. Nov 6 04:44:11.673862 sshd[894]: Accepted publickey for core from 10.0.0.1 port 54690 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:44:11.675135 sshd[894]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:44:11.677654 kernel: audit: type=1006 audit(1762404251.673:61): pid=894 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 6 04:44:11.677845 systemd-logind[798]: New session 7 of user core. Nov 6 04:44:11.692486 systemd[1]: Started Session 7 of User core. Nov 6 04:44:11.742171 sshd[894]: pam_unix(sshd:session): session closed for user core Nov 6 04:44:11.753353 systemd[1]: sshd@6-10.0.0.3:22-10.0.0.1:54690.service: Deactivated successfully. Nov 6 04:44:11.753988 systemd[1]: session-7.scope: Deactivated successfully. Nov 6 04:44:11.754662 systemd-logind[798]: Session 7 logged out. Waiting for processes to exit. Nov 6 04:44:11.755807 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:54692). Nov 6 04:44:11.756528 systemd-logind[798]: Removed session 7. Nov 6 04:44:11.788303 sshd[900]: Accepted publickey for core from 10.0.0.1 port 54692 ssh2: RSA SHA256:Kcyuj4yHJauJuGymbsiNF8z26i3dtnu5nOsQ+Zen0Fo Nov 6 04:44:11.789377 sshd[900]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 6 04:44:11.792292 kernel: audit: type=1006 audit(1762404251.787:62): pid=900 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 6 04:44:11.792333 systemd-logind[798]: New session 8 of user core. Nov 6 04:44:11.805455 systemd[1]: Started Session 8 of User core. Nov 6 04:44:11.855228 sshd[900]: pam_unix(sshd:session): session closed for user core Nov 6 04:44:11.857302 systemd[1]: sshd@7-10.0.0.3:22-10.0.0.1:54692.service: Deactivated successfully. Nov 6 04:44:11.857974 systemd[1]: session-8.scope: Deactivated successfully. Nov 6 04:44:11.858564 systemd-logind[798]: Session 8 logged out. Waiting for processes to exit. Nov 6 04:44:11.859240 systemd-logind[798]: Removed session 8.