Oct 9 00:35:34.699105 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 9 00:35:34.699122 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 Oct 9 00:35:34.699131 kernel: efi: EFI v2.70 by EDK II Oct 9 00:35:34.699136 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdba6e018 ACPI 2.0=0xd9710018 RNG=0xdcfdd318 MEMRESERVE=0xd9b41c18 Oct 9 00:35:34.699141 kernel: efi: seeding entropy pool Oct 9 00:35:34.699146 kernel: efi: memattr: Unexpected EFI Memory Attributes table version 2 Oct 9 00:35:34.699152 kernel: ACPI: Early table checksum verification disabled Oct 9 00:35:34.699157 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Oct 9 00:35:34.699162 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 9 00:35:34.699168 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:35:34.699174 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:35:34.699179 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:35:34.699184 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:35:34.699190 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:35:34.699196 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:35:34.699201 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:35:34.699208 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:35:34.699213 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:35:34.699219 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 9 00:35:34.699224 kernel: ACPI: NUMA: Failed to initialise from firmware Oct 9 00:35:34.699230 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 9 00:35:34.699235 kernel: NUMA: NODE_DATA [mem 0xdc95b900-0xdc960fff] Oct 9 00:35:34.699240 kernel: Zone ranges: Oct 9 00:35:34.699246 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 9 00:35:34.699251 kernel: DMA32 empty Oct 9 00:35:34.699257 kernel: Normal empty Oct 9 00:35:34.699262 kernel: Movable zone start for each node Oct 9 00:35:34.699268 kernel: Early memory node ranges Oct 9 00:35:34.699274 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Oct 9 00:35:34.699279 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Oct 9 00:35:34.699284 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Oct 9 00:35:34.699290 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 9 00:35:34.699295 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 9 00:35:34.699300 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 9 00:35:34.699306 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 9 00:35:34.699311 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 9 00:35:34.699316 kernel: On node 0 totalpages: 643072 Oct 9 00:35:34.699322 kernel: DMA zone: 10048 pages used for memmap Oct 9 00:35:34.699327 kernel: DMA zone: 0 pages reserved Oct 9 00:35:34.699333 kernel: DMA zone: 643072 pages, LIFO batch:63 Oct 9 00:35:34.699340 kernel: psci: probing for conduit method from ACPI. Oct 9 00:35:34.699358 kernel: psci: PSCIv1.1 detected in firmware. Oct 9 00:35:34.699374 kernel: psci: Using standard PSCI v0.2 function IDs Oct 9 00:35:34.699380 kernel: psci: Trusted OS migration not required Oct 9 00:35:34.699385 kernel: psci: SMC Calling Convention v1.1 Oct 9 00:35:34.699391 kernel: ACPI: SRAT not present Oct 9 00:35:34.699396 kernel: percpu: Embedded 32 pages/cpu s93720 r8192 d29160 u131072 Oct 9 00:35:34.699402 kernel: pcpu-alloc: s93720 r8192 d29160 u131072 alloc=32*4096 Oct 9 00:35:34.699408 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 9 00:35:34.699415 kernel: Detected PIPT I-cache on CPU0 Oct 9 00:35:34.699421 kernel: CPU features: detected: GIC system register CPU interface Oct 9 00:35:34.699426 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 9 00:35:34.699432 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 9 00:35:34.699438 kernel: CPU features: detected: Hardware dirty bit management Oct 9 00:35:34.699443 kernel: CPU features: detected: Spectre-v4 Oct 9 00:35:34.699449 kernel: CPU features: detected: ARM erratum 1418040 Oct 9 00:35:34.699454 kernel: CPU features: detected: Spectre-BHB Oct 9 00:35:34.699460 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 9 00:35:34.699465 kernel: Policy zone: DMA Oct 9 00:35:34.699473 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 Oct 9 00:35:34.699479 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 9 00:35:34.699485 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 9 00:35:34.699490 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 9 00:35:34.699497 kernel: Memory: 2452056K/2572288K available (9344K kernel code, 2274K rwdata, 6844K rodata, 34240K init, 769K bss, 120232K reserved, 0K cma-reserved) Oct 9 00:35:34.699503 kernel: random: get_random_u64 called from __kmem_cache_create+0x28/0x4a0 with crng_init=0 Oct 9 00:35:34.699509 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 9 00:35:34.699519 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 9 00:35:34.699526 kernel: rcu: RCU event tracing is enabled. Oct 9 00:35:34.699532 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 9 00:35:34.699538 kernel: Trampoline variant of Tasks RCU enabled. Oct 9 00:35:34.699545 kernel: Tracing variant of Tasks RCU enabled. Oct 9 00:35:34.699550 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 9 00:35:34.699556 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 9 00:35:34.699562 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 9 00:35:34.699567 kernel: GICv3: 256 SPIs implemented Oct 9 00:35:34.699573 kernel: GICv3: 0 Extended SPIs implemented Oct 9 00:35:34.699578 kernel: GICv3: Distributor has no Range Selector support Oct 9 00:35:34.699584 kernel: GICv3: 16 PPIs implemented Oct 9 00:35:34.699589 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 9 00:35:34.699595 kernel: ACPI: SRAT not present Oct 9 00:35:34.699600 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 9 00:35:34.699606 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Oct 9 00:35:34.699616 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Oct 9 00:35:34.699622 kernel: GICv3: using LPI property table @0x00000000400d0000 Oct 9 00:35:34.699628 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Oct 9 00:35:34.699634 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:35:34.699639 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 9 00:35:34.699645 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 9 00:35:34.699651 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 9 00:35:34.699657 kernel: arm-pv: using stolen time PV Oct 9 00:35:34.699663 kernel: Console: colour dummy device 80x25 Oct 9 00:35:34.699669 kernel: ACPI: Core revision 20200925 Oct 9 00:35:34.699675 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 9 00:35:34.699682 kernel: pid_max: default: 32768 minimum: 301 Oct 9 00:35:34.699688 kernel: LSM: Security Framework initializing Oct 9 00:35:34.699694 kernel: SELinux: Initializing. Oct 9 00:35:34.699699 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 9 00:35:34.699705 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 9 00:35:34.699711 kernel: rcu: Hierarchical SRCU implementation. Oct 9 00:35:34.699717 kernel: Platform MSI: ITS@0x8080000 domain created Oct 9 00:35:34.699723 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 9 00:35:34.699729 kernel: Remapping and enabling EFI services. Oct 9 00:35:34.699735 kernel: smp: Bringing up secondary CPUs ... Oct 9 00:35:34.699741 kernel: Detected PIPT I-cache on CPU1 Oct 9 00:35:34.699747 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 9 00:35:34.699753 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Oct 9 00:35:34.699759 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:35:34.699765 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 9 00:35:34.699771 kernel: Detected PIPT I-cache on CPU2 Oct 9 00:35:34.699777 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 9 00:35:34.699783 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Oct 9 00:35:34.699789 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:35:34.699796 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 9 00:35:34.699802 kernel: Detected PIPT I-cache on CPU3 Oct 9 00:35:34.699808 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 9 00:35:34.699814 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Oct 9 00:35:34.699820 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:35:34.699826 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 9 00:35:34.699835 kernel: smp: Brought up 1 node, 4 CPUs Oct 9 00:35:34.699842 kernel: SMP: Total of 4 processors activated. Oct 9 00:35:34.699849 kernel: CPU features: detected: Privileged Access Never Oct 9 00:35:34.699855 kernel: CPU features: detected: LSE atomic instructions Oct 9 00:35:34.699861 kernel: CPU features: detected: User Access Override Oct 9 00:35:34.699867 kernel: CPU features: detected: 32-bit EL0 Support Oct 9 00:35:34.699874 kernel: CPU features: detected: Common not Private translations Oct 9 00:35:34.699880 kernel: CPU features: detected: RAS Extension Support Oct 9 00:35:34.699886 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 9 00:35:34.699892 kernel: CPU features: detected: CRC32 instructions Oct 9 00:35:34.699898 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 9 00:35:34.699905 kernel: CPU: All CPU(s) started at EL1 Oct 9 00:35:34.699911 kernel: alternatives: patching kernel code Oct 9 00:35:34.699917 kernel: devtmpfs: initialized Oct 9 00:35:34.699923 kernel: KASLR enabled Oct 9 00:35:34.699929 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 9 00:35:34.699936 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 9 00:35:34.699942 kernel: pinctrl core: initialized pinctrl subsystem Oct 9 00:35:34.699948 kernel: SMBIOS 3.0.0 present. Oct 9 00:35:34.699954 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Oct 9 00:35:34.699961 kernel: NET: Registered protocol family 16 Oct 9 00:35:34.699967 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 9 00:35:34.699973 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 9 00:35:34.699979 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 9 00:35:34.699985 kernel: audit: initializing netlink subsys (disabled) Oct 9 00:35:34.699991 kernel: audit: type=2000 audit(0.031:1): state=initialized audit_enabled=0 res=1 Oct 9 00:35:34.699999 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 9 00:35:34.700005 kernel: cpuidle: using governor menu Oct 9 00:35:34.700011 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 9 00:35:34.700018 kernel: ASID allocator initialised with 32768 entries Oct 9 00:35:34.700024 kernel: ACPI: bus type PCI registered Oct 9 00:35:34.700030 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 9 00:35:34.700036 kernel: Serial: AMBA PL011 UART driver Oct 9 00:35:34.700042 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 9 00:35:34.700048 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 9 00:35:34.700055 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 9 00:35:34.700061 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 9 00:35:34.700068 kernel: cryptd: max_cpu_qlen set to 1000 Oct 9 00:35:34.700074 kernel: ACPI: Added _OSI(Module Device) Oct 9 00:35:34.700080 kernel: ACPI: Added _OSI(Processor Device) Oct 9 00:35:34.700086 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 9 00:35:34.700092 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 9 00:35:34.700098 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 9 00:35:34.700104 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 9 00:35:34.700112 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 9 00:35:34.700118 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 9 00:35:34.700124 kernel: ACPI: Interpreter enabled Oct 9 00:35:34.700130 kernel: ACPI: Using GIC for interrupt routing Oct 9 00:35:34.700136 kernel: ACPI: MCFG table detected, 1 entries Oct 9 00:35:34.700143 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 9 00:35:34.700149 kernel: printk: console [ttyAMA0] enabled Oct 9 00:35:34.700155 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 9 00:35:34.702069 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 9 00:35:34.702131 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 9 00:35:34.702183 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 9 00:35:34.702234 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 9 00:35:34.702284 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 9 00:35:34.702293 kernel: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 9 00:35:34.702299 kernel: PCI host bridge to bus 0000:00 Oct 9 00:35:34.702368 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 9 00:35:34.702420 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 9 00:35:34.702466 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 9 00:35:34.702512 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 9 00:35:34.702589 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 9 00:35:34.702650 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 9 00:35:34.702705 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 9 00:35:34.702758 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 9 00:35:34.702816 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 9 00:35:34.702870 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 9 00:35:34.702923 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 9 00:35:34.702978 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 9 00:35:34.703026 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 9 00:35:34.703072 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 9 00:35:34.703119 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 9 00:35:34.703128 kernel: ACPI: PCI Interrupt Link [GSI0] (IRQs *35) Oct 9 00:35:34.703135 kernel: ACPI: PCI Interrupt Link [GSI1] (IRQs *36) Oct 9 00:35:34.703141 kernel: ACPI: PCI Interrupt Link [GSI2] (IRQs *37) Oct 9 00:35:34.703147 kernel: ACPI: PCI Interrupt Link [GSI3] (IRQs *38) Oct 9 00:35:34.703153 kernel: vgaarb: loaded Oct 9 00:35:34.703159 kernel: Registered efivars operations Oct 9 00:35:34.703165 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 9 00:35:34.703171 kernel: VFS: Disk quotas dquot_6.6.0 Oct 9 00:35:34.703177 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 9 00:35:34.703183 kernel: pnp: PnP ACPI init Oct 9 00:35:34.703246 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 9 00:35:34.703297 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Oct 9 00:35:34.703306 kernel: pnp: PnP ACPI: found 1 devices Oct 9 00:35:34.703312 kernel: NET: Registered protocol family 2 Oct 9 00:35:34.703319 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 9 00:35:34.703325 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 9 00:35:34.703332 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 9 00:35:34.703338 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 9 00:35:34.703354 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 9 00:35:34.703361 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 9 00:35:34.703367 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 9 00:35:34.703374 kernel: NET: Registered protocol family 1 Oct 9 00:35:34.703380 kernel: PCI: CLS 0 bytes, default 64 Oct 9 00:35:34.703386 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 9 00:35:34.703392 kernel: kvm [1]: HYP mode not available Oct 9 00:35:34.703398 kernel: Initialise system trusted keyrings Oct 9 00:35:34.703405 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 9 00:35:34.703413 kernel: Key type asymmetric registered Oct 9 00:35:34.703419 kernel: Asymmetric key parser 'x509' registered Oct 9 00:35:34.703425 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 9 00:35:34.703431 kernel: io scheduler mq-deadline registered Oct 9 00:35:34.703438 kernel: io scheduler kyber registered Oct 9 00:35:34.703444 kernel: io scheduler bfq registered Oct 9 00:35:34.703450 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 9 00:35:34.703457 kernel: ACPI: Power Button [PWRB] Oct 9 00:35:34.703463 kernel: PCI Interrupt Link [GSI1] enabled at IRQ 36 Oct 9 00:35:34.703531 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 9 00:35:34.703540 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 9 00:35:34.703546 kernel: msm_serial: driver initialized Oct 9 00:35:34.703553 kernel: random: fast init done Oct 9 00:35:34.703559 kernel: random: crng init done Oct 9 00:35:34.703566 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Oct 9 00:35:34.703572 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Oct 9 00:35:34.703579 kernel: thunder_xcv, ver 1.0 Oct 9 00:35:34.703585 kernel: thunder_bgx, ver 1.0 Oct 9 00:35:34.703591 kernel: nicpf, ver 1.0 Oct 9 00:35:34.703600 kernel: nicvf, ver 1.0 Oct 9 00:35:34.703663 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 9 00:35:34.703714 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-10-09T00:35:34 UTC (1728434134) Oct 9 00:35:34.703722 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 9 00:35:34.703728 kernel: NET: Registered protocol family 10 Oct 9 00:35:34.703734 kernel: Segment Routing with IPv6 Oct 9 00:35:34.703740 kernel: NET: Registered protocol family 17 Oct 9 00:35:34.703746 kernel: Key type dns_resolver registered Oct 9 00:35:34.703754 kernel: registered taskstats version 1 Oct 9 00:35:34.703760 kernel: Loading compiled-in X.509 certificates Oct 9 00:35:34.703766 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: acb58ed5bddf18757940d1f794ad1dcb34e85378' Oct 9 00:35:34.703772 kernel: Key type ._fscrypt registered Oct 9 00:35:34.703778 kernel: Key type .fscrypt registered Oct 9 00:35:34.703784 kernel: Key type fscrypt-provisioning registered Oct 9 00:35:34.703790 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 9 00:35:34.703796 kernel: ima: Allocated hash algorithm: sha1 Oct 9 00:35:34.703803 kernel: ima: No architecture policies found Oct 9 00:35:34.703810 kernel: Freeing unused kernel memory: 34240K Oct 9 00:35:34.703816 kernel: Run /init as init process Oct 9 00:35:34.703822 kernel: with arguments: Oct 9 00:35:34.703829 kernel: /init Oct 9 00:35:34.703835 kernel: with environment: Oct 9 00:35:34.703841 kernel: HOME=/ Oct 9 00:35:34.703847 kernel: TERM=linux Oct 9 00:35:34.703853 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 9 00:35:34.703861 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) Oct 9 00:35:34.703871 systemd[1]: Detected virtualization kvm. Oct 9 00:35:34.703878 systemd[1]: Detected architecture arm64. Oct 9 00:35:34.703885 systemd[1]: Running in initial RAM disk. Oct 9 00:35:34.703891 systemd[1]: No hostname configured, using default hostname. Oct 9 00:35:34.703898 systemd[1]: Hostname set to . Oct 9 00:35:34.703905 systemd[1]: Initializing machine ID from VM UUID. Oct 9 00:35:34.703912 systemd[1]: Queued start job for default target Initrd Default Target. Oct 9 00:35:34.703919 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 9 00:35:34.703927 systemd[1]: Reached target Local Encrypted Volumes. Oct 9 00:35:34.703933 systemd[1]: Reached target Path Units. Oct 9 00:35:34.703940 systemd[1]: Reached target Slice Units. Oct 9 00:35:34.703947 systemd[1]: Reached target Swaps. Oct 9 00:35:34.703953 systemd[1]: Reached target Timer Units. Oct 9 00:35:34.703961 systemd[1]: Listening on Open-iSCSI iscsid Socket. Oct 9 00:35:34.703967 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Oct 9 00:35:34.703974 systemd[1]: Listening on Journal Audit Socket. Oct 9 00:35:34.703983 systemd[1]: Listening on Journal Socket (/dev/log). Oct 9 00:35:34.703989 systemd[1]: Listening on Journal Socket. Oct 9 00:35:34.703996 systemd[1]: Listening on Network Service Netlink Socket. Oct 9 00:35:34.704003 systemd[1]: Listening on udev Control Socket. Oct 9 00:35:34.704009 systemd[1]: Listening on udev Kernel Socket. Oct 9 00:35:34.704016 systemd[1]: Reached target Socket Units. Oct 9 00:35:34.704023 systemd[1]: Starting Create List of Static Device Nodes... Oct 9 00:35:34.704029 systemd[1]: Finished Network Cleanup. Oct 9 00:35:34.704036 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Oct 9 00:35:34.704043 systemd[1]: Starting Journal Service... Oct 9 00:35:34.704050 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 9 00:35:34.704057 systemd[1]: Starting Apply Kernel Variables... Oct 9 00:35:34.704063 systemd[1]: Starting Setup Virtual Console... Oct 9 00:35:34.704069 systemd[1]: Finished Create List of Static Device Nodes. Oct 9 00:35:34.704076 systemd[1]: Finished Apply Kernel Variables. Oct 9 00:35:34.704083 systemd[1]: Finished Setup Virtual Console. Oct 9 00:35:34.704089 systemd[1]: Starting dracut ask for additional cmdline parameters... Oct 9 00:35:34.704096 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 9 00:35:34.704103 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 9 00:35:34.704112 systemd-journald[279]: Journal started Oct 9 00:35:34.704147 systemd-journald[279]: Runtime Journal (/run/log/journal/7340d129bcaf47819d23f83be67500c6) is 6.0M, max 48.5M, 42.4M free. Oct 9 00:35:34.705377 systemd[1]: Started Journal Service. Oct 9 00:35:34.711537 systemd[1]: Finished dracut ask for additional cmdline parameters. Oct 9 00:35:34.712837 systemd[1]: Starting dracut cmdline hook... Oct 9 00:35:34.721298 dracut-cmdline[296]: dracut-dracut-053 Oct 9 00:35:34.723481 dracut-cmdline[296]: 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 Oct 9 00:35:34.788370 kernel: SCSI subsystem initialized Oct 9 00:35:34.791362 kernel: Loading iSCSI transport class v2.0-870. Oct 9 00:35:34.799378 kernel: iscsi: registered transport (tcp) Oct 9 00:35:34.810378 kernel: iscsi: registered transport (qla4xxx) Oct 9 00:35:34.810411 kernel: QLogic iSCSI HBA Driver Oct 9 00:35:34.819710 systemd[1]: Finished dracut cmdline hook. Oct 9 00:35:34.820951 systemd[1]: Starting dracut pre-udev hook... Oct 9 00:35:34.833953 kernel: device-mapper: uevent: version 1.0.3 Oct 9 00:35:34.833991 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Oct 9 00:35:34.868372 kernel: raid6: neonx8 gen() 13778 MB/s Oct 9 00:35:34.885358 kernel: raid6: neonx8 xor() 10760 MB/s Oct 9 00:35:34.902366 kernel: raid6: neonx4 gen() 13598 MB/s Oct 9 00:35:34.919357 kernel: raid6: neonx4 xor() 11583 MB/s Oct 9 00:35:34.936355 kernel: raid6: neonx2 gen() 13040 MB/s Oct 9 00:35:34.953365 kernel: raid6: neonx2 xor() 9894 MB/s Oct 9 00:35:34.970367 kernel: raid6: neonx1 gen() 10916 MB/s Oct 9 00:35:34.987358 kernel: raid6: neonx1 xor() 8836 MB/s Oct 9 00:35:35.004356 kernel: raid6: int64x8 gen() 6837 MB/s Oct 9 00:35:35.021357 kernel: raid6: int64x8 xor() 3799 MB/s Oct 9 00:35:35.038363 kernel: raid6: int64x4 gen() 6921 MB/s Oct 9 00:35:35.055354 kernel: raid6: int64x4 xor() 3836 MB/s Oct 9 00:35:35.072357 kernel: raid6: int64x2 gen() 6196 MB/s Oct 9 00:35:35.089357 kernel: raid6: int64x2 xor() 3317 MB/s Oct 9 00:35:35.106357 kernel: raid6: int64x1 gen() 5012 MB/s Oct 9 00:35:35.123617 kernel: raid6: int64x1 xor() 2603 MB/s Oct 9 00:35:35.123639 kernel: raid6: using algorithm neonx8 gen() 13778 MB/s Oct 9 00:35:35.123648 kernel: raid6: .... xor() 10760 MB/s, rmw enabled Oct 9 00:35:35.123656 kernel: raid6: using neon recovery algorithm Oct 9 00:35:35.134365 kernel: xor: measuring software checksum speed Oct 9 00:35:35.135358 kernel: 8regs : 17152 MB/sec Oct 9 00:35:35.136361 kernel: 32regs : 20728 MB/sec Oct 9 00:35:35.137362 kernel: arm64_neon : 28824 MB/sec Oct 9 00:35:35.137373 kernel: xor: using function: arm64_neon (28824 MB/sec) Oct 9 00:35:35.190373 kernel: Btrfs loaded, crc32c=crc32c-generic Oct 9 00:35:35.208773 systemd[1]: Finished dracut pre-udev hook. Oct 9 00:35:35.209000 audit: BPF prog-id=6 op=LOAD Oct 9 00:35:35.210000 audit: BPF prog-id=7 op=LOAD Oct 9 00:35:35.210000 audit: BPF prog-id=8 op=LOAD Oct 9 00:35:35.211897 kernel: audit: type=1334 audit(1728434135.209:2): prog-id=6 op=LOAD Oct 9 00:35:35.211921 kernel: audit: type=1334 audit(1728434135.210:3): prog-id=7 op=LOAD Oct 9 00:35:35.211929 kernel: audit: type=1334 audit(1728434135.210:4): prog-id=8 op=LOAD Oct 9 00:35:35.211892 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 9 00:35:35.224089 systemd-udevd[416]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 9 00:35:35.226650 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 9 00:35:35.228555 systemd[1]: Starting dracut pre-trigger hook... Oct 9 00:35:35.229000 audit: BPF prog-id=9 op=LOAD Oct 9 00:35:35.230267 systemd[1]: Starting Network Configuration... Oct 9 00:35:35.231458 kernel: audit: type=1334 audit(1728434135.229:5): prog-id=9 op=LOAD Oct 9 00:35:35.244266 dracut-pre-trigger[424]: rd.md=0: removing MD RAID activation Oct 9 00:35:35.251045 systemd-networkd[429]: lo: Link UP Oct 9 00:35:35.251052 systemd-networkd[429]: lo: Gained carrier Oct 9 00:35:35.251461 systemd-networkd[429]: Enumeration completed Oct 9 00:35:35.252965 systemd[1]: Started Network Configuration. Oct 9 00:35:35.254000 audit: BPF prog-id=10 op=LOAD Oct 9 00:35:35.255278 systemd[1]: Starting Network Name Resolution... Oct 9 00:35:35.256719 kernel: audit: type=1334 audit(1728434135.254:6): prog-id=10 op=LOAD Oct 9 00:35:35.274270 systemd[1]: Finished dracut pre-trigger hook. Oct 9 00:35:35.275861 systemd[1]: Starting Coldplug All udev Devices... Oct 9 00:35:35.287689 systemd-resolved[446]: Positive Trust Anchors: Oct 9 00:35:35.287700 systemd-resolved[446]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 9 00:35:35.287729 systemd-resolved[446]: 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 Oct 9 00:35:35.288168 systemd-resolved[446]: Defaulting to hostname 'linux'. Oct 9 00:35:35.288939 systemd[1]: Started Network Name Resolution. Oct 9 00:35:35.289716 systemd-udevd[416]: /usr/lib/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Oct 9 00:35:35.290143 systemd[1]: Reached target Network. Oct 9 00:35:35.294330 systemd[1]: Reached target Host and Network Name Lookups. Oct 9 00:35:35.297555 systemd[1]: Starting iSCSI UserSpace I/O driver... Oct 9 00:35:35.307584 systemd[1]: Finished Coldplug All udev Devices. Oct 9 00:35:35.318468 systemd[1]: Started iSCSI UserSpace I/O driver. Oct 9 00:35:35.320299 systemd[1]: Starting Open-iSCSI... Oct 9 00:35:35.325214 iscsid[484]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 9 00:35:35.325214 iscsid[484]: 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]. Oct 9 00:35:35.325214 iscsid[484]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 9 00:35:35.325214 iscsid[484]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 9 00:35:35.325214 iscsid[484]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 9 00:35:35.325214 iscsid[484]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 9 00:35:35.344776 systemd[1]: Started Open-iSCSI. Oct 9 00:35:35.346428 systemd[1]: Starting dracut initqueue hook... Oct 9 00:35:35.356742 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 9 00:35:35.356875 kernel: vda: detected capacity change from 0 to 4756340736 Oct 9 00:35:35.372369 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 00:35:35.372818 systemd-udevd[480]: Using default interface naming scheme 'v249'. Oct 9 00:35:35.379325 systemd-networkd[429]: eth0: Link UP Oct 9 00:35:35.394365 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by systemd-udevd (467) Oct 9 00:35:35.396281 systemd[1]: Found device /dev/disk/by-label/ROOT. Oct 9 00:35:35.398904 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Oct 9 00:35:35.407272 systemd[1]: Found device /dev/disk/by-label/OEM. Oct 9 00:35:35.409385 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 9 00:35:35.410148 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Oct 9 00:35:35.413163 systemd[1]: Reached target Initrd Root Device. Oct 9 00:35:35.414968 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Oct 9 00:35:35.418918 systemd[1]: Finished dracut initqueue hook. Oct 9 00:35:35.420341 systemd[1]: Reached target Preparation for Remote File Systems. Oct 9 00:35:35.421633 systemd[1]: Reached target Remote Encrypted Volumes. Oct 9 00:35:35.422919 systemd[1]: Reached target Remote File Systems. Oct 9 00:35:35.425541 systemd[1]: Starting dracut pre-mount hook... Oct 9 00:35:35.428367 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 00:35:35.439305 systemd[1]: Finished dracut pre-mount hook. Oct 9 00:35:36.405397 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 9 00:35:36.405118 systemd-networkd[429]: eth0: Gained carrier Oct 9 00:35:36.416429 systemd-networkd[429]: eth0: DHCPv4 address 10.0.0.2/16 via 10.0.0.1 Oct 9 00:35:36.457090 disk-uuid[504]: The operation has completed successfully. Oct 9 00:35:36.458260 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 00:35:36.484331 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 9 00:35:36.484469 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Oct 9 00:35:36.485954 systemd[1]: Starting Ignition (setup)... Oct 9 00:35:36.494783 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 9 00:35:36.494830 kernel: BTRFS info (device vda6): has skinny extents Oct 9 00:35:36.501257 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 9 00:35:36.507362 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 9 00:35:36.507480 systemd[1]: Finished Ignition (setup). Oct 9 00:35:36.509328 systemd[1]: Starting Ignition (disks)... Oct 9 00:35:36.525109 ignition[540]: Ignition v0.36.1-15-gde4e6cc9 Oct 9 00:35:36.525128 ignition[540]: Stage: disks Oct 9 00:35:36.525139 ignition[540]: reading system config file "/usr/lib/ignition/base.ign" Oct 9 00:35:36.525150 ignition[540]: no config at "/usr/lib/ignition/base.ign" Oct 9 00:35:36.525194 ignition[540]: parsed url from cmdline: "" Oct 9 00:35:36.525197 ignition[540]: no config URL provided Oct 9 00:35:36.525202 ignition[540]: reading system config file "/usr/lib/ignition/user.ign" Oct 9 00:35:36.525209 ignition[540]: no config at "/usr/lib/ignition/user.ign" Oct 9 00:35:36.525229 ignition[540]: op(1): [started] loading QEMU firmware config module Oct 9 00:35:36.525234 ignition[540]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 9 00:35:36.526177 ignition[540]: op(1): [finished] loading QEMU firmware config module Oct 9 00:35:36.539020 ignition[540]: parsing config with SHA512: d404d1d3dbeed07d2d9b501eba97772cac26d5846ac2ad56588be54890a1045c31ff031892e7d79685be59dc005e9e02e0134e22db59a597a411869bf16dbee1 Oct 9 00:35:36.541041 ignition[540]: disks: disks passed Oct 9 00:35:36.541050 ignition[540]: Ignition finished successfully Oct 9 00:35:36.541661 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 9 00:35:36.541774 systemd[1]: Finished Ignition (disks). Oct 9 00:35:36.542981 systemd[1]: Reached target Preparation for Local File Systems. Oct 9 00:35:36.545043 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Oct 9 00:35:36.546924 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Oct 9 00:35:36.555799 systemd-fsck[553]: ROOT: clean, 528/553792 files, 37752/553472 blocks Oct 9 00:35:36.561077 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Oct 9 00:35:36.564251 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 9 00:35:36.563553 systemd[1]: Mounting /sysroot... Oct 9 00:35:36.588655 systemd[1]: Found device /dev/mapper/usr. Oct 9 00:35:36.590807 systemd[1]: Starting File System Check on /dev/mapper/usr... Oct 9 00:35:36.591901 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Oct 9 00:35:36.604899 systemd-fsck[571]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Oct 9 00:35:36.604899 systemd-fsck[571]: You must have r/w access to the filesystem or be root Oct 9 00:35:36.608449 systemd-fsck[568]: fsck failed with exit status 8. Oct 9 00:35:36.613785 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Oct 9 00:35:36.613808 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Oct 9 00:35:36.608629 systemd-fsck[568]: Ignoring error. Oct 9 00:35:36.609910 systemd[1]: Mounted /sysroot. Oct 9 00:35:36.613177 systemd[1]: Reached target Initrd Root File System. Oct 9 00:35:36.615796 systemd[1]: Finished File System Check on /dev/mapper/usr. Oct 9 00:35:36.617842 systemd[1]: Mounting /sysusr/usr... Oct 9 00:35:36.625377 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Oct 9 00:35:36.625400 systemd[1]: Mounted /sysusr/usr. Oct 9 00:35:36.626054 systemd[1]: Reached target Local File Systems. Oct 9 00:35:36.627077 systemd[1]: Reached target System Initialization. Oct 9 00:35:36.628240 systemd[1]: Reached target Basic System. Oct 9 00:35:36.635195 systemd[1]: Mounting /sysroot/usr... Oct 9 00:35:36.638088 systemd[1]: Mounted /sysroot/usr. Oct 9 00:35:36.639550 systemd[1]: Starting Root filesystem setup... Oct 9 00:35:36.702606 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 9 00:35:36.702768 systemd[1]: Finished Root filesystem setup. Oct 9 00:35:36.705371 systemd[1]: Starting Ignition (files)... Oct 9 00:35:36.707785 systemd[1]: Starting /sysroot/boot... Oct 9 00:35:36.709685 ignition[586]: Ignition v0.36.1-15-gde4e6cc9 Oct 9 00:35:36.709700 ignition[586]: Stage: files Oct 9 00:35:36.709710 ignition[586]: reading system config file "/usr/lib/ignition/base.ign" Oct 9 00:35:36.709720 ignition[586]: no config at "/usr/lib/ignition/base.ign" Oct 9 00:35:36.710253 ignition[586]: files: compiled without relabeling support, skipping Oct 9 00:35:36.758824 systemd[1]: Finished /sysroot/boot. Oct 9 00:35:36.814084 ignition[586]: files: createUsers: op(1): [started] creating or modifying user "core" Oct 9 00:35:36.814098 ignition[586]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Oct 9 00:35:36.815995 ignition[586]: files: createUsers: op(1): [finished] creating or modifying user "core" Oct 9 00:35:36.816005 ignition[586]: files: createUsers: op(2): [started] adding ssh keys to user "core" Oct 9 00:35:36.818758 ignition[586]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Oct 9 00:35:36.818799 ignition[586]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Oct 9 00:35:36.819926 ignition[586]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Oct 9 00:35:36.819933 ignition[586]: files: op(4): [started] processing unit "coreos-metadata.service" Oct 9 00:35:36.820103 ignition[586]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 9 00:35:36.824928 ignition[586]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Oct 9 00:35:36.824941 ignition[586]: files: op(4): [finished] processing unit "coreos-metadata.service" Oct 9 00:35:36.825703 systemd[1]: ignition-files.service: Deactivated successfully. Oct 9 00:35:36.824947 ignition[586]: files: files passed Oct 9 00:35:36.825818 systemd[1]: Finished Ignition (files). Oct 9 00:35:36.824951 ignition[586]: Ignition finished successfully Oct 9 00:35:36.826993 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Oct 9 00:35:36.827684 systemd[1]: Starting Ignition (record completion)... Oct 9 00:35:36.828882 systemd[1]: Starting Reload Configuration from the Real Root... Oct 9 00:35:36.831172 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 9 00:35:36.831285 systemd[1]: Finished Ignition (record completion). Oct 9 00:35:36.834000 audit: BPF prog-id=9 op=UNLOAD Oct 9 00:35:36.833807 systemd[1]: Reloading. Oct 9 00:35:36.837366 kernel: audit: type=1334 audit(1728434136.834:7): prog-id=9 op=UNLOAD Oct 9 00:35:36.838000 audit: BPF prog-id=6 op=UNLOAD Oct 9 00:35:36.839359 kernel: audit: type=1334 audit(1728434136.838:8): prog-id=6 op=UNLOAD Oct 9 00:35:36.842000 audit: BPF prog-id=10 op=UNLOAD Oct 9 00:35:36.842000 audit: BPF prog-id=3 op=UNLOAD Oct 9 00:35:36.846367 kernel: audit: type=1334 audit(1728434136.842:9): prog-id=10 op=UNLOAD Oct 9 00:35:36.846402 kernel: audit: type=1334 audit(1728434136.842:10): prog-id=3 op=UNLOAD Oct 9 00:35:36.922000 audit: BPF prog-id=11 op=LOAD Oct 9 00:35:36.923000 audit: BPF prog-id=12 op=LOAD Oct 9 00:35:36.923000 audit: BPF prog-id=13 op=LOAD Oct 9 00:35:36.923000 audit: BPF prog-id=14 op=LOAD Oct 9 00:35:36.923000 audit: BPF prog-id=7 op=UNLOAD Oct 9 00:35:36.923000 audit: BPF prog-id=8 op=UNLOAD Oct 9 00:35:36.923000 audit: BPF prog-id=15 op=LOAD Oct 9 00:35:36.924000 audit: BPF prog-id=16 op=LOAD Oct 9 00:35:36.924000 audit: BPF prog-id=17 op=LOAD Oct 9 00:35:36.924000 audit: BPF prog-id=18 op=LOAD Oct 9 00:35:36.924000 audit: BPF prog-id=4 op=UNLOAD Oct 9 00:35:36.924000 audit: BPF prog-id=5 op=UNLOAD Oct 9 00:35:36.940455 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 9 00:35:36.940591 systemd[1]: Finished Reload Configuration from the Real Root. Oct 9 00:35:36.941491 systemd[1]: Reached target Initrd File Systems. Oct 9 00:35:36.942114 systemd[1]: Reached target Initrd Default Target. Oct 9 00:35:36.942859 systemd[1]: Condition check resulted in dracut mount hook being skipped. Oct 9 00:35:36.943655 systemd[1]: Starting dracut pre-pivot and cleanup hook... Oct 9 00:35:36.954840 systemd[1]: Finished dracut pre-pivot and cleanup hook. Oct 9 00:35:36.956290 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Oct 9 00:35:36.962674 systemd[1]: Stopped target Host and Network Name Lookups. Oct 9 00:35:36.963478 systemd[1]: Stopped target Remote Encrypted Volumes. Oct 9 00:35:36.964682 systemd[1]: Stopped target Timer Units. Oct 9 00:35:36.965752 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 9 00:35:36.965868 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Oct 9 00:35:36.966831 systemd[1]: Stopped target Initrd Default Target. Oct 9 00:35:36.968001 systemd[1]: Stopped target Basic System. Oct 9 00:35:36.969104 systemd[1]: Stopped target Initrd Root Device. Oct 9 00:35:36.970212 systemd[1]: Stopped target Path Units. Oct 9 00:35:36.971220 systemd[1]: Stopped target Remote File Systems. Oct 9 00:35:36.972392 systemd[1]: Stopped target Preparation for Remote File Systems. Oct 9 00:35:36.973554 systemd[1]: Stopped target Slice Units. Oct 9 00:35:36.974539 systemd[1]: Stopped target Socket Units. Oct 9 00:35:36.975683 systemd[1]: Stopped target System Initialization. Oct 9 00:35:36.976757 systemd[1]: Stopped target Local File Systems. Oct 9 00:35:36.977821 systemd[1]: Stopped target Preparation for Local File Systems. Oct 9 00:35:36.979070 systemd[1]: Stopped target Swaps. Oct 9 00:35:36.980040 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 9 00:35:36.980148 systemd[1]: Stopped dracut pre-mount hook. Oct 9 00:35:36.981237 systemd[1]: Stopped target Local Encrypted Volumes. Oct 9 00:35:36.982212 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 9 00:35:36.985371 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Oct 9 00:35:36.986251 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 9 00:35:36.986392 systemd[1]: Stopped dracut initqueue hook. Oct 9 00:35:36.989098 iscsid[484]: iscsid shutting down. Oct 9 00:35:36.987758 systemd[1]: Stopping Open-iSCSI... Oct 9 00:35:36.989326 systemd[1]: Stopping /sysroot/boot... Oct 9 00:35:36.990200 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 9 00:35:36.990336 systemd[1]: Stopped Coldplug All udev Devices. Oct 9 00:35:36.991302 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 9 00:35:36.991426 systemd[1]: Stopped dracut pre-trigger hook. Oct 9 00:35:36.993356 systemd[1]: iscsid.service: Deactivated successfully. Oct 9 00:35:36.993519 systemd[1]: Stopped Open-iSCSI. Oct 9 00:35:36.994418 systemd[1]: iscsid.socket: Deactivated successfully. Oct 9 00:35:36.994487 systemd[1]: Closed Open-iSCSI iscsid Socket. Oct 9 00:35:36.995588 systemd[1]: Stopping iSCSI UserSpace I/O driver... Oct 9 00:35:37.002280 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 9 00:35:37.002442 systemd[1]: Stopped iSCSI UserSpace I/O driver. Oct 9 00:35:37.003668 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 9 00:35:37.003779 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Oct 9 00:35:37.005334 systemd[1]: Stopped target Network. Oct 9 00:35:37.005987 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 9 00:35:37.006049 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Oct 9 00:35:37.007151 systemd[1]: Stopping Network Name Resolution... Oct 9 00:35:37.008325 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 9 00:35:37.008442 systemd[1]: Stopped /sysroot/boot. Oct 9 00:35:37.012591 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 9 00:35:37.012701 systemd[1]: Stopped Network Name Resolution. Oct 9 00:35:37.013920 systemd[1]: Stopping Network Configuration... Oct 9 00:35:37.017866 systemd-networkd[429]: eth0: DHCP lease lost Oct 9 00:35:37.020000 audit: BPF prog-id=15 op=UNLOAD Oct 9 00:35:37.022377 systemd-networkd[429]: eth0: DHCPv6 lease lost Oct 9 00:35:37.023283 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 9 00:35:37.023413 systemd[1]: Stopped Network Configuration. Oct 9 00:35:37.024781 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 9 00:35:37.024811 systemd[1]: Closed Network Service Netlink Socket. Oct 9 00:35:37.026356 systemd[1]: Stopping Network Cleanup... Oct 9 00:35:37.026858 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 9 00:35:37.026930 systemd[1]: Stopped Apply Kernel Variables. Oct 9 00:35:37.028083 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Oct 9 00:35:37.032000 audit: BPF prog-id=11 op=UNLOAD Oct 9 00:35:37.035720 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 9 00:35:37.035846 systemd[1]: Stopped Network Cleanup. Oct 9 00:35:37.038208 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 9 00:35:37.038391 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Oct 9 00:35:37.039819 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 9 00:35:37.041000 audit: BPF prog-id=12 op=UNLOAD Oct 9 00:35:37.039862 systemd[1]: Closed udev Control Socket. Oct 9 00:35:37.040850 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 9 00:35:37.040881 systemd[1]: Closed udev Kernel Socket. Oct 9 00:35:37.041959 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 9 00:35:37.041995 systemd[1]: Stopped dracut pre-udev hook. Oct 9 00:35:37.042912 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 9 00:35:37.042945 systemd[1]: Stopped dracut cmdline hook. Oct 9 00:35:37.043965 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 9 00:35:37.043994 systemd[1]: Stopped dracut ask for additional cmdline parameters. Oct 9 00:35:37.045756 systemd[1]: Starting Cleanup udev Database... Oct 9 00:35:37.046705 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Oct 9 00:35:37.047964 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 9 00:35:37.048016 systemd[1]: Stopped Create Static Device Nodes in /dev. Oct 9 00:35:37.049064 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 9 00:35:37.049096 systemd[1]: Stopped Create List of Static Device Nodes. Oct 9 00:35:37.050398 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 9 00:35:37.050432 systemd[1]: Stopped Setup Virtual Console. Oct 9 00:35:37.051858 systemd[1]: rngd.service: Deactivated successfully. Oct 9 00:35:37.051974 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Oct 9 00:35:37.052965 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 9 00:35:37.053070 systemd[1]: Finished Cleanup udev Database. Oct 9 00:35:37.054048 systemd[1]: Reached target Switch Root. Oct 9 00:35:37.061000 audit: BPF prog-id=16 op=UNLOAD Oct 9 00:35:37.055853 systemd[1]: Starting Switch Root... Oct 9 00:35:37.060919 systemd[1]: Switching root. Oct 9 00:35:37.076675 systemd-journald[279]: Journal stopped Oct 9 00:35:39.369999 systemd-journald[279]: Received SIGTERM from PID 1 (systemd). Oct 9 00:35:39.370067 kernel: SELinux: policy capability network_peer_controls=1 Oct 9 00:35:39.370079 kernel: SELinux: policy capability open_perms=1 Oct 9 00:35:39.370092 kernel: SELinux: policy capability extended_socket_class=1 Oct 9 00:35:39.370101 kernel: SELinux: policy capability always_check_network=0 Oct 9 00:35:39.370110 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 9 00:35:39.370119 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 9 00:35:39.370128 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 9 00:35:39.370137 systemd[1]: Successfully loaded SELinux policy in 43.186ms. Oct 9 00:35:39.370153 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 7.169ms. Oct 9 00:35:39.370164 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) Oct 9 00:35:39.370176 systemd[1]: Detected virtualization kvm. Oct 9 00:35:39.370186 systemd[1]: Detected architecture arm64. Oct 9 00:35:39.370196 systemd[1]: Detected first boot. Oct 9 00:35:39.370206 systemd[1]: Initializing machine ID from VM UUID. Oct 9 00:35:39.370216 systemd[1]: Populated /etc with preset unit settings. Oct 9 00:35:39.370228 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. Oct 9 00:35:39.370239 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 9 00:35:39.370249 kernel: kauditd_printk_skb: 24 callbacks suppressed Oct 9 00:35:39.370259 kernel: audit: type=1334 audit(1728434139.208:35): prog-id=21 op=LOAD Oct 9 00:35:39.370269 kernel: audit: type=1334 audit(1728434139.208:36): prog-id=22 op=LOAD Oct 9 00:35:39.370278 kernel: audit: type=1334 audit(1728434139.209:37): prog-id=23 op=LOAD Oct 9 00:35:39.370288 kernel: audit: type=1334 audit(1728434139.209:38): prog-id=17 op=UNLOAD Oct 9 00:35:39.370298 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 9 00:35:39.370308 kernel: audit: type=1334 audit(1728434139.209:39): prog-id=18 op=UNLOAD Oct 9 00:35:39.370316 systemd[1]: Stopped Switch Root. Oct 9 00:35:39.370326 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 9 00:35:39.370336 systemd[1]: Created slice Slice /system/addon-config. Oct 9 00:35:39.370360 systemd[1]: Created slice Slice /system/addon-run. Oct 9 00:35:39.370372 systemd[1]: Created slice Slice /system/getty. Oct 9 00:35:39.370382 systemd[1]: Created slice Slice /system/modprobe. Oct 9 00:35:39.370391 systemd[1]: Created slice Slice /system/serial-getty. Oct 9 00:35:39.370401 systemd[1]: Created slice Slice /system/system-cloudinit. Oct 9 00:35:39.370410 systemd[1]: Created slice Slice /system/systemd-fsck. Oct 9 00:35:39.370419 kernel: audit: type=1334 audit(1728434139.225:40): prog-id=21 op=UNLOAD Oct 9 00:35:39.370429 systemd[1]: Created slice User and Session Slice. Oct 9 00:35:39.370439 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Oct 9 00:35:39.370449 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Oct 9 00:35:39.370460 systemd[1]: Set up automount Boot partition Automount Point. Oct 9 00:35:39.370469 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Oct 9 00:35:39.370479 systemd[1]: Stopped target Switch Root. Oct 9 00:35:39.370489 systemd[1]: Stopped target Initrd File Systems. Oct 9 00:35:39.370498 systemd[1]: Stopped target Initrd Root File System. Oct 9 00:35:39.370516 systemd[1]: Reached target Remote Encrypted Volumes. Oct 9 00:35:39.370528 systemd[1]: Reached target Remote File Systems. Oct 9 00:35:39.370538 systemd[1]: Reached target Slice Units. Oct 9 00:35:39.370547 systemd[1]: Reached target Swaps. Oct 9 00:35:39.370557 systemd[1]: Reached target Verify torcx succeeded. Oct 9 00:35:39.370569 systemd[1]: Reached target Local Verity Protected Volumes. Oct 9 00:35:39.370579 systemd[1]: Listening on Process Core Dump Socket. Oct 9 00:35:39.370588 systemd[1]: Listening on initctl Compatibility Named Pipe. Oct 9 00:35:39.370598 systemd[1]: Listening on Network Service Netlink Socket. Oct 9 00:35:39.370607 systemd[1]: Listening on udev Control Socket. Oct 9 00:35:39.370617 systemd[1]: Listening on udev Kernel Socket. Oct 9 00:35:39.370627 systemd[1]: Mounting Huge Pages File System... Oct 9 00:35:39.370639 systemd[1]: Mounting POSIX Message Queue File System... Oct 9 00:35:39.370649 systemd[1]: Mounting External Media Directory... Oct 9 00:35:39.370660 systemd[1]: Mounting Kernel Debug File System... Oct 9 00:35:39.370670 systemd[1]: Mounting Kernel Trace File System... Oct 9 00:35:39.370680 systemd[1]: Mounting Temporary Directory /tmp... Oct 9 00:35:39.370690 systemd[1]: Starting Create missing system files... Oct 9 00:35:39.370700 systemd[1]: Starting Create List of Static Device Nodes... Oct 9 00:35:39.370710 systemd[1]: Starting Load Kernel Module configfs... Oct 9 00:35:39.370720 systemd[1]: Starting Load Kernel Module drm... Oct 9 00:35:39.370729 systemd[1]: Starting Load Kernel Module fuse... Oct 9 00:35:39.370739 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Oct 9 00:35:39.370749 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 9 00:35:39.370761 systemd[1]: Stopped File System Check on Root Device. Oct 9 00:35:39.370771 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 9 00:35:39.370782 systemd[1]: Stopped systemd-fsck-usr.service. Oct 9 00:35:39.370793 systemd[1]: Stopped Journal Service. Oct 9 00:35:39.370803 kernel: audit: type=1334 audit(1728434139.329:41): prog-id=24 op=LOAD Oct 9 00:35:39.370813 kernel: audit: type=1334 audit(1728434139.337:42): prog-id=25 op=LOAD Oct 9 00:35:39.370823 kernel: audit: type=1334 audit(1728434139.338:43): prog-id=26 op=LOAD Oct 9 00:35:39.370834 kernel: audit: type=1334 audit(1728434139.338:44): prog-id=22 op=UNLOAD Oct 9 00:35:39.370843 systemd[1]: Starting Journal Service... Oct 9 00:35:39.370853 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Oct 9 00:35:39.370863 systemd[1]: Starting Remount Root and Kernel File Systems... Oct 9 00:35:39.370873 systemd[1]: Starting Apply Kernel Variables... Oct 9 00:35:39.370883 systemd[1]: Starting Coldplug All udev Devices... Oct 9 00:35:39.370893 kernel: fuse: init (API version 7.32) Oct 9 00:35:39.370902 systemd[1]: verity-setup.service: Deactivated successfully. Oct 9 00:35:39.370912 systemd[1]: Stopped verity-setup.service. Oct 9 00:35:39.370922 systemd[1]: Mounted Huge Pages File System. Oct 9 00:35:39.370932 systemd[1]: Mounted POSIX Message Queue File System. Oct 9 00:35:39.370942 systemd[1]: Mounted External Media Directory. Oct 9 00:35:39.370952 systemd[1]: Mounted Kernel Debug File System. Oct 9 00:35:39.370961 systemd[1]: Mounted Kernel Trace File System. Oct 9 00:35:39.370971 systemd[1]: Mounted Temporary Directory /tmp. Oct 9 00:35:39.370982 systemd[1]: Finished Create missing system files. Oct 9 00:35:39.370991 systemd[1]: Finished Create List of Static Device Nodes. Oct 9 00:35:39.371001 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 9 00:35:39.371010 systemd[1]: Finished Load Kernel Module configfs. Oct 9 00:35:39.371020 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 9 00:35:39.371031 systemd[1]: Finished Load Kernel Module drm. Oct 9 00:35:39.371042 systemd-journald[800]: Journal started Oct 9 00:35:39.371085 systemd-journald[800]: Runtime Journal (/run/log/journal/7340d129bcaf47819d23f83be67500c6) is 6.0M, max 48.5M, 42.4M free. Oct 9 00:35:37.209000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 9 00:35:37.256000 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 Oct 9 00:35:37.256000 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 Oct 9 00:35:37.256000 audit: BPF prog-id=19 op=LOAD Oct 9 00:35:37.256000 audit: BPF prog-id=19 op=UNLOAD Oct 9 00:35:37.256000 audit: BPF prog-id=20 op=LOAD Oct 9 00:35:37.256000 audit: BPF prog-id=20 op=UNLOAD Oct 9 00:35:37.300000 audit[750]: AVC avc: denied { associate } for pid=750 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 Oct 9 00:35:39.208000 audit: BPF prog-id=21 op=LOAD Oct 9 00:35:39.208000 audit: BPF prog-id=22 op=LOAD Oct 9 00:35:39.209000 audit: BPF prog-id=23 op=LOAD Oct 9 00:35:39.209000 audit: BPF prog-id=17 op=UNLOAD Oct 9 00:35:39.209000 audit: BPF prog-id=18 op=UNLOAD Oct 9 00:35:39.225000 audit: BPF prog-id=21 op=UNLOAD Oct 9 00:35:39.329000 audit: BPF prog-id=24 op=LOAD Oct 9 00:35:39.337000 audit: BPF prog-id=25 op=LOAD Oct 9 00:35:39.338000 audit: BPF prog-id=26 op=LOAD Oct 9 00:35:39.338000 audit: BPF prog-id=22 op=UNLOAD Oct 9 00:35:39.338000 audit: BPF prog-id=23 op=UNLOAD Oct 9 00:35:39.367000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 9 00:35:39.196428 systemd[1]: Queued start job for default target Multi-User System. Oct 9 00:35:37.298185 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3033.2.4 /usr/share/oem/torcx/store /var/lib/torcx/store/3033.2.4 /var/lib/torcx/store]" Oct 9 00:35:39.210627 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 9 00:35:37.298724 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 9 00:35:37.298746 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 9 00:35:37.298966 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 9 00:35:37.298977 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 9 00:35:37.299010 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 9 00:35:37.299024 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 9 00:35:37.299228 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 9 00:35:37.299261 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 9 00:35:37.299276 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 9 00:35:37.299774 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Oct 9 00:35:37.299808 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Oct 9 00:35:39.378512 systemd[1]: Started Journal Service. Oct 9 00:35:37.299830 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3033.2.4: no such file or directory" path=/usr/share/oem/torcx/store/3033.2.4 Oct 9 00:35:37.299845 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 9 00:35:37.299866 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3033.2.4: no such file or directory" path=/var/lib/torcx/store/3033.2.4 Oct 9 00:35:37.299881 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:37Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 9 00:35:39.002202 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:39Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 9 00:35:39.002502 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:39Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 9 00:35:39.002613 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:39Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 9 00:35:39.002735 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:39Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 9 00:35:39.002804 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:39Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 9 00:35:39.002862 /usr/lib/systemd/system-generators/torcx-generator[750]: time="2024-10-09T00:35:39Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Oct 9 00:35:39.379114 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 9 00:35:39.379298 systemd[1]: Finished Load Kernel Module fuse. Oct 9 00:35:39.380275 systemd[1]: Finished Remount Root and Kernel File Systems. Oct 9 00:35:39.381401 systemd[1]: Finished Apply Kernel Variables. Oct 9 00:35:39.384186 systemd[1]: Mounting FUSE Control File System... Oct 9 00:35:39.385866 systemd[1]: Mounting Kernel Configuration File System... Oct 9 00:35:39.386551 systemd[1]: Condition check resulted in Remount Root File System being skipped. Oct 9 00:35:39.388640 systemd[1]: Starting Rebuild Hardware Database... Oct 9 00:35:39.390305 systemd[1]: Starting Flush Journal to Persistent Storage... Oct 9 00:35:39.391180 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Oct 9 00:35:39.392275 systemd[1]: Starting Load/Save Random Seed... Oct 9 00:35:39.394160 systemd[1]: Starting Create System Users... Oct 9 00:35:39.397316 systemd[1]: Mounted FUSE Control File System. Oct 9 00:35:39.398195 systemd[1]: Mounted Kernel Configuration File System. Oct 9 00:35:39.401653 systemd-journald[800]: Time spent on flushing to /var/log/journal/7340d129bcaf47819d23f83be67500c6 is 9.223ms for 770 entries. Oct 9 00:35:39.401653 systemd-journald[800]: System Journal (/var/log/journal/7340d129bcaf47819d23f83be67500c6) is 8.0M, max 203.0M, 195.0M free. Oct 9 00:35:39.405726 systemd[1]: Finished Load/Save Random Seed. Oct 9 00:35:39.406863 systemd[1]: Finished Coldplug All udev Devices. Oct 9 00:35:39.407734 systemd[1]: Reached target First Boot Complete. Oct 9 00:35:39.415427 systemd[1]: Starting Wait for udev To Complete Device Initialization... Oct 9 00:35:39.418963 systemd[1]: Finished Flush Journal to Persistent Storage. Oct 9 00:35:39.424899 systemd-sysusers[812]: Creating group sgx with gid 999. Oct 9 00:35:39.425680 systemd-sysusers[812]: Creating group systemd-oom with gid 998. Oct 9 00:35:39.426272 systemd-sysusers[812]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Oct 9 00:35:39.426914 systemd-sysusers[812]: Creating group systemd-timesync with gid 997. Oct 9 00:35:39.427405 systemd-sysusers[812]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Oct 9 00:35:39.427963 systemd-sysusers[812]: Creating group systemd-coredump with gid 996. Oct 9 00:35:39.428432 systemd-sysusers[812]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Oct 9 00:35:39.443562 systemd[1]: Finished Create System Users. Oct 9 00:35:39.445397 systemd[1]: Starting Create Static Device Nodes in /dev... Oct 9 00:35:39.471722 systemd[1]: Finished Create Static Device Nodes in /dev. Oct 9 00:35:39.662997 systemd[1]: Finished Rebuild Hardware Database. Oct 9 00:35:39.670000 audit: BPF prog-id=27 op=LOAD Oct 9 00:35:39.670000 audit: BPF prog-id=28 op=LOAD Oct 9 00:35:39.670000 audit: BPF prog-id=29 op=LOAD Oct 9 00:35:39.670000 audit: BPF prog-id=13 op=UNLOAD Oct 9 00:35:39.670000 audit: BPF prog-id=14 op=UNLOAD Oct 9 00:35:39.671816 systemd[1]: Starting Rule-based Manager for Device Events and Files... Oct 9 00:35:39.722382 systemd[1]: Started Rule-based Manager for Device Events and Files. Oct 9 00:35:39.757000 audit: BPF prog-id=30 op=LOAD Oct 9 00:35:39.758941 systemd[1]: Starting Network Configuration... Oct 9 00:35:39.794296 systemd-udevd[824]: Using default interface naming scheme 'v249'. Oct 9 00:35:39.815400 udevadm[814]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 9 00:35:39.822004 systemd-networkd[837]: lo: Link UP Oct 9 00:35:39.822011 systemd-networkd[837]: lo: Gained carrier Oct 9 00:35:39.826093 systemd-networkd[837]: Enumeration completed Oct 9 00:35:39.826280 systemd[1]: Started Network Configuration. Oct 9 00:35:39.828325 systemd-networkd[837]: eth0: Link UP Oct 9 00:35:39.833429 systemd-networkd[837]: eth0: Gained carrier Oct 9 00:35:39.844531 systemd-networkd[837]: eth0: DHCPv4 address 10.0.0.2/16 via 10.0.0.1 Oct 9 00:35:39.871545 systemd[1]: Finished Wait for udev To Complete Device Initialization. Oct 9 00:35:39.879375 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 9 00:35:39.895084 lvm[845]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 9 00:35:39.916457 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 9 00:35:39.917444 systemd[1]: Reached target Local Encrypted Volumes. Oct 9 00:35:39.934475 systemd[1]: Starting Activation of LVM2 logical volumes... Oct 9 00:35:39.938234 lvm[846]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 9 00:35:39.966467 systemd[1]: Finished Activation of LVM2 logical volumes. Oct 9 00:35:39.967330 systemd[1]: Reached target Preparation for Local File Systems. Oct 9 00:35:39.968167 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Oct 9 00:35:39.968192 systemd[1]: Reached target Containers. Oct 9 00:35:39.984627 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Oct 9 00:35:40.001203 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Oct 9 00:35:40.018325 systemd[1]: Mounting /usr/share/oem... Oct 9 00:35:40.024370 kernel: BTRFS info (device vda6): disk space caching is enabled Oct 9 00:35:40.024438 kernel: BTRFS info (device vda6): has skinny extents Oct 9 00:35:40.026055 systemd[1]: Mounted /usr/share/oem. Oct 9 00:35:40.026778 systemd[1]: Reached target Local File Systems. Oct 9 00:35:40.028544 systemd[1]: Starting Rebuild Dynamic Linker Cache... Oct 9 00:35:40.029671 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 9 00:35:40.029713 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Oct 9 00:35:40.030894 systemd[1]: Starting Commit a transient machine-id on disk... Oct 9 00:35:40.032803 systemd[1]: Starting Create Volatile Files and Directories... Oct 9 00:35:40.038942 systemd-tmpfiles[871]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 9 00:35:40.039972 systemd-tmpfiles[871]: /usr/lib/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Oct 9 00:35:40.048185 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 9 00:35:40.048970 systemd[1]: Finished Commit a transient machine-id on disk. Oct 9 00:35:40.067887 systemd-tmpfiles[871]: Detected autofs mount point /boot during canonicalization of /boot. Oct 9 00:35:40.067898 systemd-tmpfiles[871]: Skipping /boot Oct 9 00:35:40.072742 systemd-tmpfiles[871]: Detected autofs mount point /boot during canonicalization of /boot. Oct 9 00:35:40.072758 systemd-tmpfiles[871]: Skipping /boot Oct 9 00:35:40.106647 systemd[1]: Finished Create Volatile Files and Directories. Oct 9 00:35:40.116727 systemd[1]: Starting Load Security Auditing Rules... Oct 9 00:35:40.118846 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Oct 9 00:35:40.120970 systemd[1]: Starting Rebuild Journal Catalog... Oct 9 00:35:40.122000 audit: BPF prog-id=31 op=LOAD Oct 9 00:35:40.123397 systemd[1]: Starting Network Name Resolution... Oct 9 00:35:40.124000 audit: BPF prog-id=32 op=LOAD Oct 9 00:35:40.126130 systemd[1]: Starting Network Time Synchronization... Oct 9 00:35:40.128257 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Oct 9 00:35:40.129865 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Oct 9 00:35:40.131063 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Oct 9 00:35:40.135453 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Oct 9 00:35:40.142801 systemd[1]: Finished Rebuild Journal Catalog. Oct 9 00:35:40.162000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 9 00:35:40.162854 augenrules[892]: No rules Oct 9 00:35:40.163708 systemd[1]: Finished Load Security Auditing Rules. Oct 9 00:35:40.179076 systemd-resolved[876]: Positive Trust Anchors: Oct 9 00:35:40.179310 systemd-resolved[876]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 9 00:35:40.179368 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 Oct 9 00:35:40.180450 systemd-resolved[876]: Defaulting to hostname 'linux'. Oct 9 00:35:40.183060 systemd[1]: Started Network Name Resolution. Oct 9 00:35:40.183790 systemd[1]: Reached target Network. Oct 9 00:35:40.184337 systemd[1]: Reached target Host and Network Name Lookups. Oct 9 00:35:40.185387 systemd[1]: Started Network Time Synchronization. Oct 9 00:35:40.185457 systemd-timesyncd[882]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Oct 9 00:35:40.186165 systemd[1]: Reached target System Time Set. Oct 9 00:35:40.199156 systemd[1]: Finished Rebuild Dynamic Linker Cache. Oct 9 00:35:40.209423 systemd[1]: Starting Update is Completed... Oct 9 00:35:40.214656 systemd[1]: Finished Update is Completed. Oct 9 00:35:40.215362 systemd[1]: Reached target System Initialization. Oct 9 00:35:40.216146 systemd[1]: Started Watch for update engine configuration changes. Oct 9 00:35:40.217091 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 9 00:35:40.218202 systemd[1]: Started Daily Log Rotation. Oct 9 00:35:40.219018 systemd[1]: Started Weekly check for MD array's redundancy information.. Oct 9 00:35:40.219907 systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 9 00:35:40.220680 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Oct 9 00:35:40.220713 systemd[1]: Reached target Path Units. Oct 9 00:35:40.221266 systemd[1]: Reached target Timer Units. Oct 9 00:35:40.222256 systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 9 00:35:40.224023 systemd[1]: Starting Docker Socket for the API... Oct 9 00:35:40.227194 systemd[1]: Listening on OpenSSH Server Socket. Oct 9 00:35:40.228338 systemd[1]: Listening on Docker Socket for the API. Oct 9 00:35:40.229063 systemd[1]: Reached target Socket Units. Oct 9 00:35:40.229653 systemd[1]: Reached target Basic System. Oct 9 00:35:40.230233 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Oct 9 00:35:40.230260 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Oct 9 00:35:40.231295 systemd[1]: Started D-Bus System Message Bus. Oct 9 00:35:40.234295 systemd[1]: Starting Extend Filesystems... Oct 9 00:35:40.235037 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Oct 9 00:35:40.236193 systemd[1]: Starting Generate /run/flatcar/motd... Oct 9 00:35:40.238034 systemd[1]: Starting Install an ssh key from /proc/cmdline... Oct 9 00:35:40.240513 systemd[1]: Starting Generate sshd host keys... Oct 9 00:35:40.241246 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Oct 9 00:35:40.241285 systemd[1]: Reached target Load system-provided cloud configs. Oct 9 00:35:40.245841 systemd[1]: Starting User Login Management... Oct 9 00:35:40.246966 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 9 00:35:40.248378 systemd[1]: Starting Update Engine... Oct 9 00:35:40.249015 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Oct 9 00:35:40.249052 systemd[1]: Reached target Load user-provided cloud configs. Oct 9 00:35:40.251038 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 9 00:35:40.251288 systemd[1]: Finished Install an ssh key from /proc/cmdline. Oct 9 00:35:40.254006 extend-filesystems[902]: Found vda Oct 9 00:35:40.254006 extend-filesystems[902]: Found vda1 Oct 9 00:35:40.255999 extend-filesystems[902]: Found vda2 Oct 9 00:35:40.255999 extend-filesystems[902]: Found vda3 Oct 9 00:35:40.255999 extend-filesystems[902]: Found usr Oct 9 00:35:40.255999 extend-filesystems[902]: Found vda4 Oct 9 00:35:40.255999 extend-filesystems[902]: Found vda6 Oct 9 00:35:40.255999 extend-filesystems[902]: Found vda7 Oct 9 00:35:40.255999 extend-filesystems[902]: Found vda9 Oct 9 00:35:40.255999 extend-filesystems[902]: Checking size of /dev/vda9 Oct 9 00:35:40.267324 systemd[1]: motdgen.service: Deactivated successfully. Oct 9 00:35:40.267600 systemd[1]: Finished Generate /run/flatcar/motd. Oct 9 00:35:40.278388 extend-filesystems[902]: Old size kept for /dev/vda9 Oct 9 00:35:40.286704 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 9 00:35:40.286982 systemd[1]: Finished Extend Filesystems. Oct 9 00:35:40.293590 systemd-logind[913]: Watching system buttons on /dev/input/event0 (Power Button) Oct 9 00:35:40.295421 systemd-logind[913]: New seat seat0. Oct 9 00:35:40.306104 systemd[1]: Started User Login Management. Oct 9 00:35:40.313845 update_engine[914]: I1009 00:35:40.311775 914 main.cc:89] Flatcar Update Engine starting Oct 9 00:35:40.316933 systemd[1]: Started Update Engine. Oct 9 00:35:40.317190 update_engine[914]: I1009 00:35:40.317142 914 update_check_scheduler.cc:74] Next update check in 10m10s Oct 9 00:35:40.329739 systemd[1]: Started Cluster reboot manager. Oct 9 00:35:40.373460 locksmithd[926]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 9 00:35:40.884612 systemd-networkd[837]: eth0: Gained IPv6LL Oct 9 00:35:41.126794 sshd_keygen[918]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Oct 9 00:35:41.148232 systemd[1]: Finished Generate sshd host keys. Oct 9 00:35:41.159725 systemd[1]: Starting Generate /run/issue... Oct 9 00:35:41.165101 systemd[1]: issuegen.service: Deactivated successfully. Oct 9 00:35:41.165374 systemd[1]: Finished Generate /run/issue. Oct 9 00:35:41.167820 systemd[1]: Starting Permit User Sessions... Oct 9 00:35:41.173362 systemd[1]: Finished Permit User Sessions. Oct 9 00:35:41.176050 systemd[1]: Started Getty on tty1. Oct 9 00:35:41.178895 systemd[1]: Started Serial Getty on ttyAMA0. Oct 9 00:35:41.180091 systemd[1]: Reached target Login Prompts. Oct 9 00:35:41.181002 systemd[1]: Reached target Multi-User System. Oct 9 00:35:41.183348 systemd[1]: Starting Record Runlevel Change in UTMP... Oct 9 00:35:41.189300 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 9 00:35:41.189643 systemd[1]: Finished Record Runlevel Change in UTMP. Oct 9 00:35:41.190721 systemd[1]: Startup finished in 684ms (kernel) + 2.593s (initrd) + 4.034s (userspace) = 7.313s. Oct 9 00:35:46.865455 systemd[1]: Created slice Slice /system/sshd. Oct 9 00:35:46.866566 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40692). Oct 9 00:35:46.928602 sshd[948]: Accepted publickey for core from 10.0.0.1 port 40692 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:46.930708 sshd[948]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:46.947873 systemd[1]: Created slice User Slice of UID 500. Oct 9 00:35:46.948972 systemd[1]: Starting User Runtime Directory /run/user/500... Oct 9 00:35:46.950474 systemd-logind[913]: New session 1 of user core. Oct 9 00:35:46.955506 systemd[1]: Finished User Runtime Directory /run/user/500. Oct 9 00:35:46.956821 systemd[1]: Starting User Manager for UID 500... Oct 9 00:35:46.959937 systemd[951]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:47.008783 systemd[951]: Queued start job for default target Main User Target. Oct 9 00:35:47.008952 systemd[951]: Reached target Paths. Oct 9 00:35:47.008967 systemd[951]: Reached target Sockets. Oct 9 00:35:47.008978 systemd[951]: Reached target Timers. Oct 9 00:35:47.008988 systemd[951]: Reached target Basic System. Oct 9 00:35:47.009095 systemd[1]: Started User Manager for UID 500. Oct 9 00:35:47.009651 systemd[951]: Reached target Main User Target. Oct 9 00:35:47.009758 systemd[951]: Startup finished in 45ms. Oct 9 00:35:47.019525 systemd[1]: Started Session 1 of User core. Oct 9 00:35:47.079408 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40700). Oct 9 00:35:47.112510 sshd[960]: Accepted publickey for core from 10.0.0.1 port 40700 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:47.113938 sshd[960]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:47.117160 systemd-logind[913]: New session 2 of user core. Oct 9 00:35:47.123553 systemd[1]: Started Session 2 of User core. Oct 9 00:35:47.178969 sshd[960]: pam_unix(sshd:session): session closed for user core Oct 9 00:35:47.187192 systemd[1]: sshd@1-10.0.0.2:22-10.0.0.1:40700.service: Deactivated successfully. Oct 9 00:35:47.187873 systemd[1]: session-2.scope: Deactivated successfully. Oct 9 00:35:47.188461 systemd-logind[913]: Session 2 logged out. Waiting for processes to exit. Oct 9 00:35:47.189516 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40702). Oct 9 00:35:47.190130 systemd-logind[913]: Removed session 2. Oct 9 00:35:47.223320 sshd[966]: Accepted publickey for core from 10.0.0.1 port 40702 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:47.224292 sshd[966]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:47.226933 systemd-logind[913]: New session 3 of user core. Oct 9 00:35:47.235586 systemd[1]: Started Session 3 of User core. Oct 9 00:35:47.284013 sshd[966]: pam_unix(sshd:session): session closed for user core Oct 9 00:35:47.293298 systemd[1]: sshd@2-10.0.0.2:22-10.0.0.1:40702.service: Deactivated successfully. Oct 9 00:35:47.293915 systemd[1]: session-3.scope: Deactivated successfully. Oct 9 00:35:47.294521 systemd-logind[913]: Session 3 logged out. Waiting for processes to exit. Oct 9 00:35:47.295503 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40708). Oct 9 00:35:47.296575 systemd-logind[913]: Removed session 3. Oct 9 00:35:47.328105 sshd[972]: Accepted publickey for core from 10.0.0.1 port 40708 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:47.329069 sshd[972]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:47.331384 systemd-logind[913]: New session 4 of user core. Oct 9 00:35:47.343495 systemd[1]: Started Session 4 of User core. Oct 9 00:35:47.394461 sshd[972]: pam_unix(sshd:session): session closed for user core Oct 9 00:35:47.410861 systemd[1]: sshd@3-10.0.0.2:22-10.0.0.1:40708.service: Deactivated successfully. Oct 9 00:35:47.411498 systemd[1]: session-4.scope: Deactivated successfully. Oct 9 00:35:47.412074 systemd-logind[913]: Session 4 logged out. Waiting for processes to exit. Oct 9 00:35:47.413213 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40722). Oct 9 00:35:47.414022 systemd-logind[913]: Removed session 4. Oct 9 00:35:47.445510 sshd[978]: Accepted publickey for core from 10.0.0.1 port 40722 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:47.446569 sshd[978]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:47.449400 systemd-logind[913]: New session 5 of user core. Oct 9 00:35:47.461558 systemd[1]: Started Session 5 of User core. Oct 9 00:35:47.524985 sudo[981]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Oct 9 00:35:47.525456 sudo[981]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 00:35:47.538892 sudo[981]: pam_unix(sudo:session): session closed for user root Oct 9 00:35:47.541811 sshd[978]: pam_unix(sshd:session): session closed for user core Oct 9 00:35:47.558855 dbus-daemon[901]: [system] Reloaded configuration Oct 9 00:35:47.559234 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40728). Oct 9 00:35:47.561321 systemd[1]: sshd@4-10.0.0.2:22-10.0.0.1:40722.service: Deactivated successfully. Oct 9 00:35:47.561967 systemd[1]: session-5.scope: Deactivated successfully. Oct 9 00:35:47.562603 systemd-logind[913]: Session 5 logged out. Waiting for processes to exit. Oct 9 00:35:47.563262 systemd-logind[913]: Removed session 5. Oct 9 00:35:47.592193 sshd[984]: Accepted publickey for core from 10.0.0.1 port 40728 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:47.593648 sshd[984]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:47.596246 systemd-logind[913]: New session 6 of user core. Oct 9 00:35:47.604555 systemd[1]: Started Session 6 of User core. Oct 9 00:35:47.655619 sudo[990]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 9 00:35:47.655824 sudo[990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 00:35:47.658030 sudo[990]: pam_unix(sudo:session): session closed for user root Oct 9 00:35:47.661459 sudo[989]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Oct 9 00:35:47.661661 sudo[989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 00:35:47.679319 systemd[1]: Stopping Load Security Auditing Rules... Oct 9 00:35:47.679000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 9 00:35:47.680857 kernel: kauditd_printk_skb: 11 callbacks suppressed Oct 9 00:35:47.680895 kernel: audit: type=1305 audit(1728434147.679:56): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 9 00:35:47.682285 auditctl[993]: No rules Oct 9 00:35:47.682479 systemd[1]: audit-rules.service: Deactivated successfully. Oct 9 00:35:47.682702 systemd[1]: Stopped Load Security Auditing Rules. Oct 9 00:35:47.683949 systemd[1]: Starting Load Security Auditing Rules... Oct 9 00:35:47.698076 augenrules[1010]: No rules Oct 9 00:35:47.698743 systemd[1]: Finished Load Security Auditing Rules. Oct 9 00:35:47.699517 sudo[989]: pam_unix(sudo:session): session closed for user root Oct 9 00:35:47.700665 sshd[984]: pam_unix(sshd:session): session closed for user core Oct 9 00:35:47.712109 systemd[1]: sshd@5-10.0.0.2:22-10.0.0.1:40728.service: Deactivated successfully. Oct 9 00:35:47.712613 systemd[1]: session-6.scope: Deactivated successfully. Oct 9 00:35:47.713175 systemd-logind[913]: Session 6 logged out. Waiting for processes to exit. Oct 9 00:35:47.714092 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40742). Oct 9 00:35:47.714672 systemd-logind[913]: Removed session 6. Oct 9 00:35:47.746299 sshd[1016]: Accepted publickey for core from 10.0.0.1 port 40742 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:47.747109 sshd[1016]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:47.748374 kernel: audit: type=1006 audit(1728434147.745:57): pid=1016 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Oct 9 00:35:47.749406 systemd-logind[913]: New session 7 of user core. Oct 9 00:35:47.758578 systemd[1]: Started Session 7 of User core. Oct 9 00:35:47.808622 sudo[1019]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/mkdir -p . Oct 9 00:35:47.808815 sudo[1019]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 00:35:47.810879 sudo[1019]: pam_unix(sudo:session): session closed for user root Oct 9 00:35:47.811804 sshd[1016]: pam_unix(sshd:session): session closed for user core Oct 9 00:35:47.823816 systemd[1]: sshd@6-10.0.0.2:22-10.0.0.1:40742.service: Deactivated successfully. Oct 9 00:35:47.824314 systemd[1]: session-7.scope: Deactivated successfully. Oct 9 00:35:47.824854 systemd-logind[913]: Session 7 logged out. Waiting for processes to exit. Oct 9 00:35:47.825741 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40746). Oct 9 00:35:47.826267 systemd-logind[913]: Removed session 7. Oct 9 00:35:47.858185 sshd[1023]: Accepted publickey for core from 10.0.0.1 port 40746 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:47.859247 sshd[1023]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:47.861397 kernel: audit: type=1006 audit(1728434147.857:58): pid=1023 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Oct 9 00:35:47.862012 systemd-logind[913]: New session 8 of user core. Oct 9 00:35:47.871511 systemd[1]: Started Session 8 of User core. Oct 9 00:35:47.927118 sudo[1026]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/install -m 0755 /dev/stdin kolet Oct 9 00:35:47.927326 sudo[1026]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 00:35:48.034900 sudo[1026]: pam_unix(sudo:session): session closed for user root Oct 9 00:35:48.036012 sshd[1023]: pam_unix(sshd:session): session closed for user core Oct 9 00:35:48.049023 systemd[1]: sshd@7-10.0.0.2:22-10.0.0.1:40746.service: Deactivated successfully. Oct 9 00:35:48.049562 systemd[1]: session-8.scope: Deactivated successfully. Oct 9 00:35:48.050160 systemd-logind[913]: Session 8 logged out. Waiting for processes to exit. Oct 9 00:35:48.051149 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40756). Oct 9 00:35:48.051824 systemd-logind[913]: Removed session 8. Oct 9 00:35:48.083595 sshd[1030]: Accepted publickey for core from 10.0.0.1 port 40756 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:48.084749 sshd[1030]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:48.086372 kernel: audit: type=1006 audit(1728434148.083:59): pid=1030 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=9 res=1 Oct 9 00:35:48.088135 systemd-logind[913]: New session 9 of user core. Oct 9 00:35:48.097495 systemd[1]: Started Session 9 of User core. Oct 9 00:35:48.148629 sudo[1033]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/mkdir -p /updates Oct 9 00:35:48.148835 sudo[1033]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 00:35:48.151264 sudo[1033]: pam_unix(sudo:session): session closed for user root Oct 9 00:35:48.152269 sshd[1030]: pam_unix(sshd:session): session closed for user core Oct 9 00:35:48.171325 systemd[1]: sshd@8-10.0.0.2:22-10.0.0.1:40756.service: Deactivated successfully. Oct 9 00:35:48.171852 systemd[1]: session-9.scope: Deactivated successfully. Oct 9 00:35:48.172480 systemd-logind[913]: Session 9 logged out. Waiting for processes to exit. Oct 9 00:35:48.173452 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40764). Oct 9 00:35:48.174275 systemd-logind[913]: Removed session 9. Oct 9 00:35:48.205560 sshd[1037]: Accepted publickey for core from 10.0.0.1 port 40764 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:48.206493 sshd[1037]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:48.208431 kernel: audit: type=1006 audit(1728434148.205:60): pid=1037 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=10 res=1 Oct 9 00:35:48.210204 systemd-logind[913]: New session 10 of user core. Oct 9 00:35:48.223019 systemd[1]: Started Session 10 of User core. Oct 9 00:35:48.278350 sudo[1040]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/install -m 0755 /dev/stdin /updates/update.gz Oct 9 00:35:48.278574 sudo[1040]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 00:35:49.410988 sudo[1040]: pam_unix(sudo:session): session closed for user root Oct 9 00:35:49.412978 sshd[1037]: pam_unix(sshd:session): session closed for user core Oct 9 00:35:49.422189 systemd[1]: sshd@9-10.0.0.2:22-10.0.0.1:40764.service: Deactivated successfully. Oct 9 00:35:49.422738 systemd[1]: session-10.scope: Deactivated successfully. Oct 9 00:35:49.422966 systemd[1]: session-10.scope: Consumed 1.163s CPU time. Oct 9 00:35:49.423710 systemd-logind[913]: Session 10 logged out. Waiting for processes to exit. Oct 9 00:35:49.425312 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40856). Oct 9 00:35:49.426332 systemd-logind[913]: Removed session 10. Oct 9 00:35:49.458221 sshd[1044]: Accepted publickey for core from 10.0.0.1 port 40856 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:49.459231 sshd[1044]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:49.460366 kernel: audit: type=1006 audit(1728434149.457:61): pid=1044 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=11 res=1 Oct 9 00:35:49.463498 systemd-logind[913]: New session 11 of user core. Oct 9 00:35:49.470792 systemd[1]: Started Session 11 of User core. Oct 9 00:35:49.522234 sudo[1047]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemd-run --quiet ./kolet run cl.update.docker-btrfs-compat Omaha Oct 9 00:35:49.522724 sudo[1047]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 00:35:49.540572 systemd[1]: Started /home/core/./kolet run cl.update.docker-btrfs-compat Omaha. Oct 9 00:35:49.541486 sudo[1047]: pam_unix(sudo:session): session closed for user root Oct 9 00:35:49.542730 sshd[1044]: pam_unix(sshd:session): session closed for user core Oct 9 00:35:49.546453 systemd[1]: sshd@10-10.0.0.2:22-10.0.0.1:40856.service: Deactivated successfully. Oct 9 00:35:49.547147 systemd[1]: session-11.scope: Deactivated successfully. Oct 9 00:35:49.548044 systemd-logind[913]: Session 11 logged out. Waiting for processes to exit. Oct 9 00:35:49.548792 systemd-logind[913]: Removed session 11. Oct 9 00:35:54.607835 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:41650). Oct 9 00:35:54.640085 sshd[1058]: Accepted publickey for core from 10.0.0.1 port 41650 ssh2: RSA SHA256:60k/UnDs2xCDM+iEzqxKwQzs737wmpdF/6B9zSTG41g Oct 9 00:35:54.641121 sshd[1058]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:35:54.642369 kernel: audit: type=1006 audit(1728434154.639:62): pid=1058 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=12 res=1 Oct 9 00:35:54.644642 systemd-logind[913]: New session 12 of user core. Oct 9 00:35:54.652523 systemd[1]: Started Session 12 of User core. Oct 9 00:35:54.742639 sshd[1058]: pam_unix(sshd:session): session closed for user core Oct 9 00:35:54.744781 systemd[1]: sshd@11-10.0.0.2:22-10.0.0.1:41650.service: Deactivated successfully. Oct 9 00:35:54.745514 systemd[1]: session-12.scope: Deactivated successfully. Oct 9 00:35:54.746164 systemd-logind[913]: Session 12 logged out. Waiting for processes to exit. Oct 9 00:35:54.746749 systemd-logind[913]: Removed session 12. Oct 9 00:36:25.885442 update_engine[914]: I1009 00:36:25.885385 914 update_attempter.cc:505] Updating boot flags...