Oct 19 09:23:23.800191 kernel: Linux version 6.18.45-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 15.3.0 p8) 15.3.0, GNU ld (Gentoo 2.46.1 p1) 2.46.1) #1 SMP PREEMPT_DYNAMIC Mon Oct 19 07:01:12 -00 2026 Oct 19 09:23:23.800236 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,115200n8 flatcar.first_boot=detected flatcar.oem.id=gce verity.usrhash=0afd667f618a8e27326d25715c0da0128cccb1492e26e9e72b0ec36f7345d045 Oct 19 09:23:23.800253 kernel: x86/CPU: Model not found in latest microcode list Oct 19 09:23:23.800266 kernel: BIOS-provided physical RAM map: Oct 19 09:23:23.800283 kernel: BIOS-e820: [mem 0x0000000000000000-0x0000000000000fff] reserved Oct 19 09:23:23.800297 kernel: BIOS-e820: [mem 0x0000000000001000-0x0000000000054fff] usable Oct 19 09:23:23.800316 kernel: BIOS-e820: [mem 0x0000000000055000-0x000000000005ffff] reserved Oct 19 09:23:23.800331 kernel: BIOS-e820: [mem 0x0000000000060000-0x0000000000097fff] usable Oct 19 09:23:23.800346 kernel: BIOS-e820: [mem 0x0000000000098000-0x000000000009ffff] reserved Oct 19 09:23:23.800361 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bd2effff] usable Oct 19 09:23:23.800377 kernel: BIOS-e820: [mem 0x00000000bd2f0000-0x00000000bd2f9fff] ACPI data Oct 19 09:23:23.800392 kernel: BIOS-e820: [mem 0x00000000bd2fa000-0x00000000bf8ecfff] usable Oct 19 09:23:23.800411 kernel: BIOS-e820: [mem 0x00000000bf8ed000-0x00000000bfb6cfff] reserved Oct 19 09:23:23.800427 kernel: BIOS-e820: [mem 0x00000000bfb6d000-0x00000000bfb7efff] ACPI data Oct 19 09:23:23.800446 kernel: BIOS-e820: [mem 0x00000000bfb7f000-0x00000000bfbfefff] ACPI NVS Oct 19 09:23:23.800463 kernel: BIOS-e820: [mem 0x00000000bfbff000-0x00000000bffdffff] usable Oct 19 09:23:23.800482 kernel: BIOS-e820: [mem 0x00000000bffe0000-0x00000000bfffffff] reserved Oct 19 09:23:23.800499 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000021fffffff] usable Oct 19 09:23:23.800516 kernel: NX (Execute Disable) protection: active Oct 19 09:23:23.800533 kernel: APIC: Static calls initialized Oct 19 09:23:23.800550 kernel: efi: EFI v2.7 by EDK II Oct 19 09:23:23.800567 kernel: efi: TPMFinalLog=0xbfbf7000 ACPI=0xbfb7e000 ACPI 2.0=0xbfb7e014 SMBIOS=0xbf9ca000 MEMATTR=0xbd2fa018 RNG=0xbfb73018 TPMEventLog=0xbd2f0018 Oct 19 09:23:23.800583 kernel: random: crng init done Oct 19 09:23:23.800600 kernel: secureboot: Secure boot disabled Oct 19 09:23:23.800616 kernel: SMBIOS 2.4 present. Oct 19 09:23:23.800634 kernel: DMI: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/16/2026 Oct 19 09:23:23.800650 kernel: DMI: Memory slots populated: 1/1 Oct 19 09:23:23.800670 kernel: Hypervisor detected: KVM Oct 19 09:23:23.800686 kernel: last_pfn = 0xbffe0 max_arch_pfn = 0x400000000 Oct 19 09:23:23.800703 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Oct 19 09:23:23.800719 kernel: kvm-clock: using sched offset of 11751304548 cycles Oct 19 09:23:23.800745 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 19 09:23:23.800763 kernel: tsc: Detected 2299.998 MHz processor Oct 19 09:23:23.800781 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 19 09:23:23.800799 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 19 09:23:23.800816 kernel: last_pfn = 0x220000 max_arch_pfn = 0x400000000 Oct 19 09:23:23.800837 kernel: MTRR map: 3 entries (2 fixed + 1 variable; max 18), built from 8 variable MTRRs Oct 19 09:23:23.800854 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 19 09:23:23.800872 kernel: last_pfn = 0xbffe0 max_arch_pfn = 0x400000000 Oct 19 09:23:23.800889 kernel: Using GB pages for direct mapping Oct 19 09:23:23.800913 kernel: ACPI: Early table checksum verification disabled Oct 19 09:23:23.800935 kernel: ACPI: RSDP 0x00000000BFB7E014 000024 (v02 Google) Oct 19 09:23:23.800953 kernel: ACPI: XSDT 0x00000000BFB7D0E8 00005C (v01 Google GOOGFACP 00000001 01000013) Oct 19 09:23:23.800971 kernel: ACPI: FACP 0x00000000BFB78000 000114 (v06 Google GOOGFACP 00000001 GOOG 00000001) Oct 19 09:23:23.800991 kernel: ACPI: DSDT 0x00000000BFB79000 001DED (v02 Google GOOGDSDT 00000001 GOOG 00000001) Oct 19 09:23:23.801009 kernel: ACPI: FACS 0x00000000BFBF2000 000040 Oct 19 09:23:23.801027 kernel: ACPI: SSDT 0x00000000BFB7C000 000316 (v02 GOOGLE Tpm2Tabl 00001000 INTL 20250807) Oct 19 09:23:23.801049 kernel: ACPI: TPM2 0x00000000BFB7B000 000034 (v04 GOOGLE 00000001 GOOG 00000001) Oct 19 09:23:23.801067 kernel: ACPI: SRAT 0x00000000BFB77000 0000C8 (v03 Google GOOGSRAT 00000001 GOOG 00000001) Oct 19 09:23:23.801085 kernel: ACPI: APIC 0x00000000BFB76000 000076 (v05 Google GOOGAPIC 00000001 GOOG 00000001) Oct 19 09:23:23.801103 kernel: ACPI: SSDT 0x00000000BFB75000 000914 (v02 Google GOOGSSDT 00000001 GOOG 00000001) Oct 19 09:23:23.801119 kernel: ACPI: WAET 0x00000000BFB74000 000028 (v01 Google GOOGWAET 00000001 GOOG 00000001) Oct 19 09:23:23.801136 kernel: ACPI: Reserving FACP table memory at [mem 0xbfb78000-0xbfb78113] Oct 19 09:23:23.802258 kernel: ACPI: Reserving DSDT table memory at [mem 0xbfb79000-0xbfb7adec] Oct 19 09:23:23.802298 kernel: ACPI: Reserving FACS table memory at [mem 0xbfbf2000-0xbfbf203f] Oct 19 09:23:23.802319 kernel: ACPI: Reserving SSDT table memory at [mem 0xbfb7c000-0xbfb7c315] Oct 19 09:23:23.802339 kernel: ACPI: Reserving TPM2 table memory at [mem 0xbfb7b000-0xbfb7b033] Oct 19 09:23:23.802360 kernel: ACPI: Reserving SRAT table memory at [mem 0xbfb77000-0xbfb770c7] Oct 19 09:23:23.802379 kernel: ACPI: Reserving APIC table memory at [mem 0xbfb76000-0xbfb76075] Oct 19 09:23:23.802400 kernel: ACPI: Reserving SSDT table memory at [mem 0xbfb75000-0xbfb75913] Oct 19 09:23:23.802417 kernel: ACPI: Reserving WAET table memory at [mem 0xbfb74000-0xbfb74027] Oct 19 09:23:23.802438 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x0009ffff] Oct 19 09:23:23.802455 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00100000-0xbfffffff] Oct 19 09:23:23.802473 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x21fffffff] Oct 19 09:23:23.802491 kernel: NUMA: Node 0 [mem 0x00001000-0x0009ffff] + [mem 0x00100000-0xbfffffff] -> [mem 0x00001000-0xbfffffff] Oct 19 09:23:23.802508 kernel: NUMA: Node 0 [mem 0x00001000-0xbfffffff] + [mem 0x100000000-0x21fffffff] -> [mem 0x00001000-0x21fffffff] Oct 19 09:23:23.802526 kernel: NODE_DATA(0) allocated [mem 0x21fff8d80-0x21fffffff] Oct 19 09:23:23.802544 kernel: Zone ranges: Oct 19 09:23:23.802562 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 19 09:23:23.802584 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Oct 19 09:23:23.802602 kernel: Normal [mem 0x0000000100000000-0x000000021fffffff] Oct 19 09:23:23.802622 kernel: Device empty Oct 19 09:23:23.802638 kernel: Movable zone start for each node Oct 19 09:23:23.802655 kernel: Early memory node ranges Oct 19 09:23:23.802673 kernel: node 0: [mem 0x0000000000001000-0x0000000000054fff] Oct 19 09:23:23.802690 kernel: node 0: [mem 0x0000000000060000-0x0000000000097fff] Oct 19 09:23:23.802712 kernel: node 0: [mem 0x0000000000100000-0x00000000bd2effff] Oct 19 09:23:23.802873 kernel: node 0: [mem 0x00000000bd2fa000-0x00000000bf8ecfff] Oct 19 09:23:23.802895 kernel: node 0: [mem 0x00000000bfbff000-0x00000000bffdffff] Oct 19 09:23:23.802914 kernel: node 0: [mem 0x0000000100000000-0x000000021fffffff] Oct 19 09:23:23.802933 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000021fffffff] Oct 19 09:23:23.802952 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 19 09:23:23.802971 kernel: On node 0, zone DMA: 11 pages in unavailable ranges Oct 19 09:23:23.802990 kernel: On node 0, zone DMA: 104 pages in unavailable ranges Oct 19 09:23:23.803013 kernel: On node 0, zone DMA32: 10 pages in unavailable ranges Oct 19 09:23:23.803033 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Oct 19 09:23:23.803052 kernel: On node 0, zone Normal: 32 pages in unavailable ranges Oct 19 09:23:23.803071 kernel: ACPI: PM-Timer IO Port: 0xb008 Oct 19 09:23:23.803090 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Oct 19 09:23:23.803108 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Oct 19 09:23:23.803127 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Oct 19 09:23:23.803149 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 19 09:23:23.803190 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Oct 19 09:23:23.803208 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Oct 19 09:23:23.803236 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 19 09:23:23.803255 kernel: CPU topo: Max. logical packages: 1 Oct 19 09:23:23.803274 kernel: CPU topo: Max. logical dies: 1 Oct 19 09:23:23.803293 kernel: CPU topo: Max. dies per package: 1 Oct 19 09:23:23.803315 kernel: CPU topo: Max. threads per core: 2 Oct 19 09:23:23.803333 kernel: CPU topo: Num. cores per package: 1 Oct 19 09:23:23.803351 kernel: CPU topo: Num. threads per package: 2 Oct 19 09:23:23.803369 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs Oct 19 09:23:23.803388 kernel: [mem 0xc0000000-0xffffffff] available for PCI devices Oct 19 09:23:23.803407 kernel: Booting paravirtualized kernel on KVM Oct 19 09:23:23.803426 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 19 09:23:23.803449 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Oct 19 09:23:23.803467 kernel: percpu: Embedded 56 pages/cpu s191128 r8192 d30056 u1048576 Oct 19 09:23:23.803486 kernel: pcpu-alloc: s191128 r8192 d30056 u1048576 alloc=1*2097152 Oct 19 09:23:23.803504 kernel: pcpu-alloc: [0] 0 1 Oct 19 09:23:23.803522 kernel: kvm-guest: PV spinlocks enabled Oct 19 09:23:23.803541 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Oct 19 09:23:23.803563 kernel: Kernel command line: rootflags=rw mount.usrflags=ro 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,115200n8 flatcar.first_boot=detected flatcar.oem.id=gce verity.usrhash=0afd667f618a8e27326d25715c0da0128cccb1492e26e9e72b0ec36f7345d045 Oct 19 09:23:23.803586 kernel: printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes Oct 19 09:23:23.803605 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) Oct 19 09:23:23.803624 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 19 09:23:23.803643 kernel: software IO TLB: area num 2. Oct 19 09:23:23.803662 kernel: Fallback order for Node 0: 0 Oct 19 09:23:23.803681 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1965136 Oct 19 09:23:23.803716 kernel: Policy zone: Normal Oct 19 09:23:23.803735 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 19 09:23:23.803755 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 19 09:23:23.803778 kernel: Kernel/User page tables isolation: enabled Oct 19 09:23:23.803797 kernel: ftrace: allocating 42928 entries in 168 pages Oct 19 09:23:23.803813 kernel: ftrace: allocated 168 pages with 3 groups Oct 19 09:23:23.803831 kernel: Dynamic Preempt: voluntary Oct 19 09:23:23.803849 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 19 09:23:23.803874 kernel: rcu: RCU event tracing is enabled. Oct 19 09:23:23.803894 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 19 09:23:23.803914 kernel: Trampoline variant of Tasks RCU enabled. Oct 19 09:23:23.803934 kernel: Rude variant of Tasks RCU enabled. Oct 19 09:23:23.803954 kernel: Tracing variant of Tasks RCU enabled. Oct 19 09:23:23.803974 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 19 09:23:23.803993 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 19 09:23:23.804017 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 19 09:23:23.804037 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 19 09:23:23.804056 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 19 09:23:23.804075 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16 Oct 19 09:23:23.804095 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 19 09:23:23.804289 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 19 09:23:23.804310 kernel: Console: colour dummy device 80x25 Oct 19 09:23:23.804334 kernel: printk: legacy console [ttyS0] enabled Oct 19 09:23:23.804352 kernel: ACPI: Core revision 20250807 Oct 19 09:23:23.804369 kernel: APIC: Switch to symmetric I/O mode setup Oct 19 09:23:23.804386 kernel: x2apic enabled Oct 19 09:23:23.804406 kernel: APIC: Switched APIC routing to: physical x2apic Oct 19 09:23:23.804425 kernel: ..TIMER: vector=0x30 apic1=0 pin1=0 apic2=-1 pin2=-1 Oct 19 09:23:23.804445 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x212733415c7, max_idle_ns: 440795236380 ns Oct 19 09:23:23.804469 kernel: Calibrating delay loop (skipped) preset value.. 4599.99 BogoMIPS (lpj=2299998) Oct 19 09:23:23.804489 kernel: Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024 Oct 19 09:23:23.804509 kernel: Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4 Oct 19 09:23:23.804526 kernel: mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto Oct 19 09:23:23.804545 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Oct 19 09:23:23.804565 kernel: Spectre V2 : Mitigation: IBRS Oct 19 09:23:23.804585 kernel: RETBleed: Mitigation: IBRS Oct 19 09:23:23.804609 kernel: ITS: Mitigation: Aligned branch/return thunks Oct 19 09:23:23.804629 kernel: Spectre V2 : User space: Mitigation: STIBP via prctl Oct 19 09:23:23.804649 kernel: MDS: Mitigation: Clear CPU buffers Oct 19 09:23:23.804669 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Oct 19 09:23:23.804689 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 19 09:23:23.804709 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Oct 19 09:23:23.804729 kernel: Spectre V2 : Enabling IBPB for BPF Oct 19 09:23:23.804753 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Oct 19 09:23:23.804773 kernel: active return thunk: its_return_thunk Oct 19 09:23:23.804794 kernel: Spectre V2 : Spectre BHI mitigation: SW BHB clearing on syscall and VM exit Oct 19 09:23:23.804814 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 19 09:23:23.804834 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 19 09:23:23.804854 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 19 09:23:23.804874 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 19 09:23:23.804897 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Oct 19 09:23:23.804918 kernel: Freeing SMP alternatives memory: 40K Oct 19 09:23:23.804938 kernel: pid_max: default: 32768 minimum: 301 Oct 19 09:23:23.804957 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 19 09:23:23.804978 kernel: landlock: Up and running. Oct 19 09:23:23.804998 kernel: SELinux: Initializing. Oct 19 09:23:23.805018 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 19 09:23:23.805042 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 19 09:23:23.805062 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU @ 2.30GHz (family: 0x6, model: 0x3f, stepping: 0x0) Oct 19 09:23:23.805082 kernel: Performance Events: unsupported CPU family 6 model 63 no PMU driver, software events only. Oct 19 09:23:23.805102 kernel: signal: max sigframe size: 1776 Oct 19 09:23:23.805122 kernel: rcu: Hierarchical SRCU implementation. Oct 19 09:23:23.805143 kernel: rcu: Max phase no-delay instances is 400. Oct 19 09:23:23.805176 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 19 09:23:23.805199 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Oct 19 09:23:23.805218 kernel: smp: Bringing up secondary CPUs ... Oct 19 09:23:23.805245 kernel: smpboot: x86: Booting SMP configuration: Oct 19 09:23:23.805265 kernel: .... node #0, CPUs: #1 Oct 19 09:23:23.805286 kernel: MDS CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/mds.html for more details. Oct 19 09:23:23.805307 kernel: MMIO Stale Data CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/processor_mmio_stale_data.html for more details. Oct 19 09:23:23.805326 kernel: smp: Brought up 1 node, 2 CPUs Oct 19 09:23:23.805350 kernel: smpboot: Total of 2 processors activated (9199.99 BogoMIPS) Oct 19 09:23:23.805371 kernel: Memory: 7517888K/7860544K available (14461K kernel code, 2497K rwdata, 33760K rodata, 16452K init, 1384K bss, 334736K reserved, 0K cma-reserved) Oct 19 09:23:23.805390 kernel: devtmpfs: initialized Oct 19 09:23:23.805409 kernel: x86/mm: Memory block size: 128MB Oct 19 09:23:23.805428 kernel: ACPI: PM: Registering ACPI NVS region [mem 0xbfb7f000-0xbfbfefff] (524288 bytes) Oct 19 09:23:23.805446 kernel: posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) Oct 19 09:23:23.805464 kernel: futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). Oct 19 09:23:23.805487 kernel: pinctrl core: initialized pinctrl subsystem Oct 19 09:23:23.805654 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 19 09:23:23.805674 kernel: audit: initializing netlink subsys (disabled) Oct 19 09:23:23.805693 kernel: audit: type=2000 audit(1792401798.730:1): state=initialized audit_enabled=0 res=1 Oct 19 09:23:23.805710 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 19 09:23:23.805728 kernel: cpuidle: using governor menu Oct 19 09:23:23.805748 kernel: efi: Freeing EFI boot services memory: 56352K Oct 19 09:23:23.805771 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 19 09:23:23.805790 kernel: dca service started, version 1.12.1 Oct 19 09:23:23.805809 kernel: PCI: Using configuration type 1 for base access Oct 19 09:23:23.805829 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 19 09:23:23.805848 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 19 09:23:23.805867 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Oct 19 09:23:23.805886 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 19 09:23:23.805907 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Oct 19 09:23:23.805927 kernel: ACPI: Added _OSI(Module Device) Oct 19 09:23:23.805945 kernel: ACPI: Added _OSI(Processor Device) Oct 19 09:23:23.805964 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 19 09:23:23.805983 kernel: ACPI: 3 ACPI AML tables successfully acquired and loaded Oct 19 09:23:23.806000 kernel: ACPI: Interpreter enabled Oct 19 09:23:23.806020 kernel: ACPI: PM: (supports S0 S3 S5) Oct 19 09:23:23.806041 kernel: ACPI: Using IOAPIC for interrupt routing Oct 19 09:23:23.806060 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 19 09:23:23.806079 kernel: PCI: Ignoring E820 reservations for host bridge windows Oct 19 09:23:23.806098 kernel: ACPI: Enabled 16 GPEs in block 00 to 0F Oct 19 09:23:23.806117 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 19 09:23:23.806510 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Oct 19 09:23:23.807522 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Oct 19 09:23:23.807863 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Oct 19 09:23:23.807894 kernel: PCI host bridge to bus 0000:00 Oct 19 09:23:23.808203 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Oct 19 09:23:23.808630 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0x0fff window] Oct 19 09:23:23.808886 kernel: pci_bus 0000:00: root bus resource [io 0xc000-0xffff window] Oct 19 09:23:23.809132 kernel: pci_bus 0000:00: root bus resource [io 0xa000-0xbfff window] Oct 19 09:23:23.809482 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Oct 19 09:23:23.809742 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfefff window] Oct 19 09:23:23.810088 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 19 09:23:23.810429 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint Oct 19 09:23:23.810732 kernel: pci 0000:00:01.0: [8086:7110] type 00 class 0x060100 conventional PCI endpoint Oct 19 09:23:23.811045 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint Oct 19 09:23:23.820444 kernel: pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI Oct 19 09:23:23.820758 kernel: pci 0000:00:03.0: [1af4:1004] type 00 class 0x000000 conventional PCI endpoint Oct 19 09:23:23.821035 kernel: pci 0000:00:03.0: BAR 0 [io 0xc040-0xc07f] Oct 19 09:23:23.821326 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc0001000-0xc000107f] Oct 19 09:23:23.821608 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Oct 19 09:23:23.822058 kernel: pci 0000:00:04.0: BAR 0 [io 0xc000-0xc03f] Oct 19 09:23:23.822356 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc0000000-0xc000007f] Oct 19 09:23:23.822559 kernel: pci 0000:00:05.0: [1af4:1002] type 00 class 0x00ff00 conventional PCI endpoint Oct 19 09:23:23.822753 kernel: pci 0000:00:05.0: BAR 0 [io 0xc0a0-0xc0bf] Oct 19 09:23:23.823003 kernel: pci 0000:00:06.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Oct 19 09:23:23.823646 kernel: pci 0000:00:06.0: BAR 0 [io 0xc080-0xc09f] Oct 19 09:23:23.823955 kernel: pci 0000:00:06.0: BAR 1 [mem 0xc0002000-0xc000203f] Oct 19 09:23:23.824261 kernel: pci_bus 0000:00: on NUMA node 0 Oct 19 09:23:23.824291 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Oct 19 09:23:23.824312 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Oct 19 09:23:23.824338 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Oct 19 09:23:23.824358 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Oct 19 09:23:23.824377 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Oct 19 09:23:23.824395 kernel: iommu: Default domain type: Translated Oct 19 09:23:23.824413 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 19 09:23:23.824433 kernel: efivars: Registered efivars operations Oct 19 09:23:23.824452 kernel: PCI: Using ACPI for IRQ routing Oct 19 09:23:23.824476 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 19 09:23:23.824496 kernel: e820: reserve RAM buffer [mem 0x00055000-0x0005ffff] Oct 19 09:23:23.824514 kernel: e820: reserve RAM buffer [mem 0x00098000-0x0009ffff] Oct 19 09:23:23.824533 kernel: e820: reserve RAM buffer [mem 0xbd2f0000-0xbfffffff] Oct 19 09:23:23.824553 kernel: e820: reserve RAM buffer [mem 0xbf8ed000-0xbfffffff] Oct 19 09:23:23.824571 kernel: e820: reserve RAM buffer [mem 0xbffe0000-0xbfffffff] Oct 19 09:23:23.824590 kernel: vgaarb: loaded Oct 19 09:23:23.824614 kernel: clocksource: Switched to clocksource kvm-clock Oct 19 09:23:23.824633 kernel: VFS: Disk quotas dquot_6.6.0 Oct 19 09:23:23.824653 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 19 09:23:23.824673 kernel: pnp: PnP ACPI init Oct 19 09:23:23.824693 kernel: pnp: PnP ACPI: found 7 devices Oct 19 09:23:23.824866 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 19 09:23:23.824889 kernel: NET: Registered PF_INET protocol family Oct 19 09:23:23.824910 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) Oct 19 09:23:23.824935 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) Oct 19 09:23:23.824955 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 19 09:23:23.824975 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 19 09:23:23.825009 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Oct 19 09:23:23.825029 kernel: TCP: Hash tables configured (established 65536 bind 65536) Oct 19 09:23:23.825049 kernel: UDP hash table entries: 4096 (order: 6, 262144 bytes, linear) Oct 19 09:23:23.825073 kernel: UDP-Lite hash table entries: 4096 (order: 6, 262144 bytes, linear) Oct 19 09:23:23.825091 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 19 09:23:23.825110 kernel: NET: Registered PF_XDP protocol family Oct 19 09:23:23.825427 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Oct 19 09:23:23.825679 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0x0fff window] Oct 19 09:23:23.825925 kernel: pci_bus 0000:00: resource 6 [io 0xc000-0xffff window] Oct 19 09:23:23.826355 kernel: pci_bus 0000:00: resource 7 [io 0xa000-0xbfff window] Oct 19 09:23:23.826614 kernel: pci_bus 0000:00: resource 8 [mem 0x000a0000-0x000bffff window] Oct 19 09:23:23.826862 kernel: pci_bus 0000:00: resource 9 [mem 0xc0000000-0xfebfefff window] Oct 19 09:23:23.827142 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Oct 19 09:23:23.827183 kernel: PCI: CLS 0 bytes, default 64 Oct 19 09:23:23.827204 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Oct 19 09:23:23.827223 kernel: software IO TLB: mapped [mem 0x00000000b7f7f000-0x00000000bbf7f000] (64MB) Oct 19 09:23:23.827256 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Oct 19 09:23:23.827276 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x212733415c7, max_idle_ns: 440795236380 ns Oct 19 09:23:23.827294 kernel: clocksource: Switched to clocksource tsc Oct 19 09:23:23.827312 kernel: Initialise system trusted keyrings Oct 19 09:23:23.827332 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 Oct 19 09:23:23.827351 kernel: Key type asymmetric registered Oct 19 09:23:23.827370 kernel: Asymmetric key parser 'x509' registered Oct 19 09:23:23.827393 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 19 09:23:23.827413 kernel: io scheduler mq-deadline registered Oct 19 09:23:23.827432 kernel: io scheduler kyber registered Oct 19 09:23:23.827451 kernel: io scheduler bfq registered Oct 19 09:23:23.827470 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 19 09:23:23.827490 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Oct 19 09:23:23.827953 kernel: virtio-pci 0000:00:03.0: virtio_pci: leaving for legacy driver Oct 19 09:23:23.827990 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 10 Oct 19 09:23:23.828306 kernel: virtio-pci 0000:00:04.0: virtio_pci: leaving for legacy driver Oct 19 09:23:23.828335 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Oct 19 09:23:23.828605 kernel: virtio-pci 0000:00:05.0: virtio_pci: leaving for legacy driver Oct 19 09:23:23.828633 kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 11 Oct 19 09:23:23.829060 kernel: virtio-pci 0000:00:06.0: virtio_pci: leaving for legacy driver Oct 19 09:23:23.829091 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 19 09:23:23.829116 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 19 09:23:23.829135 kernel: 00:04: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Oct 19 09:23:23.829177 kernel: 00:05: ttyS2 at I/O 0x3e8 (irq = 6, base_baud = 115200) is a 16550A Oct 19 09:23:23.829197 kernel: 00:06: ttyS3 at I/O 0x2e8 (irq = 7, base_baud = 115200) is a 16550A Oct 19 09:23:23.829497 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x9009, rev-id 0) Oct 19 09:23:23.829527 kernel: ACPI: bus type drm_connector registered Oct 19 09:23:23.829554 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Oct 19 09:23:23.829574 kernel: i8042: Warning: Keylock active Oct 19 09:23:23.829594 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Oct 19 09:23:23.829614 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Oct 19 09:23:23.829886 kernel: rtc_cmos 00:00: RTC can wake from S4 Oct 19 09:23:23.830138 kernel: rtc_cmos 00:00: registered as rtc0 Oct 19 09:23:23.840095 kernel: rtc_cmos 00:00: setting system clock to 2026-10-19T09:23:19 UTC (1792401799) Oct 19 09:23:23.840500 kernel: rtc_cmos 00:00: alarms up to one day, 114 bytes nvram Oct 19 09:23:23.840532 kernel: intel_pstate: CPU model not supported Oct 19 09:23:23.840554 kernel: pstore: Using crash dump compression: deflate Oct 19 09:23:23.840575 kernel: pstore: Registered efi_pstore as persistent store backend Oct 19 09:23:23.840604 kernel: NET: Registered PF_INET6 protocol family Oct 19 09:23:23.840625 kernel: Segment Routing with IPv6 Oct 19 09:23:23.840651 kernel: In-situ OAM (IOAM) with IPv6 Oct 19 09:23:23.840672 kernel: NET: Registered PF_PACKET protocol family Oct 19 09:23:23.840692 kernel: Key type dns_resolver registered Oct 19 09:23:23.840712 kernel: IPI shorthand broadcast: enabled Oct 19 09:23:23.840732 kernel: sched_clock: Marking stable (601004607, 140002703)->(753082028, -12074718) Oct 19 09:23:23.840753 kernel: registered taskstats version 1 Oct 19 09:23:23.840773 kernel: Loading compiled-in X.509 certificates Oct 19 09:23:23.840793 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Oct 19 09:23:23.840818 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.18.45-flatcar: d81c09012af5646e2fb7ee63f6f236a833dafb10' Oct 19 09:23:23.840838 kernel: Demotion targets for Node 0: null Oct 19 09:23:23.840858 kernel: Key type .fscrypt registered Oct 19 09:23:23.840878 kernel: Key type fscrypt-provisioning registered Oct 19 09:23:23.840897 kernel: ima: Allocated hash algorithm: sha1 Oct 19 09:23:23.840917 kernel: ima: Can not allocate sha384 (reason: -2) Oct 19 09:23:23.840938 kernel: ima: No architecture policies found Oct 19 09:23:23.840962 kernel: clk: Disabling unused clocks Oct 19 09:23:23.840983 kernel: Freeing unused kernel image (initmem) memory: 16452K Oct 19 09:23:23.841003 kernel: Write protecting the kernel read-only data: 51200k Oct 19 09:23:23.841023 kernel: Freeing unused kernel image (text/rodata gap) memory: 1920K Oct 19 09:23:23.841044 kernel: Freeing unused kernel image (rodata/data gap) memory: 1056K Oct 19 09:23:23.841090 kernel: Run /init as init process Oct 19 09:23:23.841114 kernel: with arguments: Oct 19 09:23:23.841138 kernel: /init Oct 19 09:23:23.841175 kernel: with environment: Oct 19 09:23:23.841195 kernel: HOME=/ Oct 19 09:23:23.841215 kernel: TERM=linux Oct 19 09:23:23.841242 kernel: SCSI subsystem initialized Oct 19 09:23:23.841548 kernel: virtio_scsi virtio0: 1/0/0 default/read/poll queues Oct 19 09:23:23.841856 kernel: scsi host0: Virtio SCSI HBA Oct 19 09:23:23.841885 kernel: blk-mq: reduced tag depth to 10240 Oct 19 09:23:23.842276 kernel: scsi 0:0:1:0: Direct-Access Google PersistentDisk 1 PQ: 0 ANSI: 6 Oct 19 09:23:23.842615 kernel: sd 0:0:1:0: [sda] 33554432 512-byte logical blocks: (17.2 GB/16.0 GiB) Oct 19 09:23:23.842933 kernel: sd 0:0:1:0: [sda] 4096-byte physical blocks Oct 19 09:23:23.843288 kernel: sd 0:0:1:0: [sda] Write Protect is off Oct 19 09:23:23.843605 kernel: sd 0:0:1:0: [sda] Mode Sense: 1f 00 00 08 Oct 19 09:23:23.843998 kernel: sd 0:0:1:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Oct 19 09:23:23.844031 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 19 09:23:23.844053 kernel: GPT:25804799 != 33554431 Oct 19 09:23:23.844073 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 19 09:23:23.844093 kernel: GPT:25804799 != 33554431 Oct 19 09:23:23.844119 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 19 09:23:23.844140 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 19 09:23:23.844532 kernel: sd 0:0:1:0: [sda] Attached SCSI disk Oct 19 09:23:23.844558 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 19 09:23:23.844579 kernel: device-mapper: uevent: version 1.0.3 Oct 19 09:23:23.844601 kernel: device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev Oct 19 09:23:23.844622 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:23.844648 kernel: raid6: avx2x4 gen() 18020 MB/s Oct 19 09:23:23.844669 kernel: raid6: avx2x2 gen() 18109 MB/s Oct 19 09:23:23.844689 kernel: raid6: avx2x1 gen() 14295 MB/s Oct 19 09:23:23.844710 kernel: raid6: using algorithm avx2x2 gen() 18109 MB/s Oct 19 09:23:23.844730 kernel: raid6: .... xor() 15963 MB/s, rmw enabled Oct 19 09:23:23.844748 kernel: raid6: using avx2x2 recovery algorithm Oct 19 09:23:23.844769 kernel: xor: automatically using best checksumming function avx Oct 19 09:23:23.844793 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 19 09:23:23.844814 kernel: BTRFS: device fsid 007f97bc-fba4-4742-8624-aa4d080f4ebc devid 1 transid 38 /dev/mapper/usr (254:0) scanned by mount (150) Oct 19 09:23:23.844835 kernel: BTRFS info (device dm-0): first mount of filesystem 007f97bc-fba4-4742-8624-aa4d080f4ebc Oct 19 09:23:23.844856 kernel: BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm Oct 19 09:23:23.844877 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Oct 19 09:23:23.844898 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Oct 19 09:23:23.844918 kernel: BTRFS info (device dm-0 state E): enabling free space tree Oct 19 09:23:23.844942 kernel: loop: module loaded Oct 19 09:23:23.844962 kernel: loop0: detected capacity change from 0 to 111936 Oct 19 09:23:23.844983 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 19 09:23:23.845003 kernel: fuse: init (API version 7.45) Oct 19 09:23:23.845026 systemd[1]: Successfully made /usr/ read-only. Oct 19 09:23:23.845052 systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Oct 19 09:23:23.845078 systemd[1]: Detected virtualization google. Oct 19 09:23:23.845098 systemd[1]: Detected architecture x86-64. Oct 19 09:23:23.845122 systemd[1]: Running in initrd. Oct 19 09:23:23.845143 systemd[1]: Initializing machine ID from random generator. Oct 19 09:23:23.845184 systemd[1]: No hostname configured, using default hostname. Oct 19 09:23:23.845205 systemd[1]: Hostname set to . Oct 19 09:23:23.845233 systemd[1]: Queued start job for default target initrd.target. Oct 19 09:23:23.845255 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 19 09:23:23.845276 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 19 09:23:23.845300 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 19 09:23:23.845321 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 19 09:23:23.845347 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 19 09:23:23.845370 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 19 09:23:23.845392 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 19 09:23:23.845414 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 19 09:23:23.845435 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 19 09:23:23.845461 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 19 09:23:23.845482 systemd[1]: Reached target paths.target - Path Units. Oct 19 09:23:23.845504 systemd[1]: Reached target slices.target - Slice Units. Oct 19 09:23:23.845525 systemd[1]: Reached target swap.target - Swaps. Oct 19 09:23:23.845547 systemd[1]: Reached target timers.target - Timer Units. Oct 19 09:23:23.845568 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 19 09:23:23.845590 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 19 09:23:23.845616 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 19 09:23:23.845638 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 19 09:23:23.845659 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 19 09:23:23.845681 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 19 09:23:23.845702 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 19 09:23:23.845724 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 19 09:23:23.845746 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 19 09:23:23.845771 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 19 09:23:23.845793 systemd[1]: Reached target sockets.target - Socket Units. Oct 19 09:23:23.845814 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 19 09:23:23.845837 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 19 09:23:23.845858 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 19 09:23:23.845880 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 19 09:23:23.845902 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Oct 19 09:23:23.845927 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 19 09:23:23.845950 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 19 09:23:23.846021 systemd-journald[280]: Collecting audit messages is enabled. Oct 19 09:23:23.846070 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 19 09:23:23.846093 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 09:23:23.846115 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 19 09:23:23.846144 systemd-journald[280]: Journal started Oct 19 09:23:23.846201 systemd-journald[280]: Runtime Journal (/run/log/journal/49c898893aac4aaeadd327d623cbd747) is 8M, max 148.4M, 140.4M free. Oct 19 09:23:23.793896 systemd-modules-load[282]: Using 2 probe threads Oct 19 09:23:23.874202 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 19 09:23:23.880786 systemd-modules-load[282]: Inserted module 'br_netfilter' Oct 19 09:23:23.882505 kernel: Bridge firewalling registered Oct 19 09:23:23.881000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:23.912405 systemd[1]: Started systemd-journald.service - Journal Service. Oct 19 09:23:23.912482 kernel: audit: type=1130 audit(1792401803.881:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:23.911000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:23.914985 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 19 09:23:23.933975 kernel: audit: type=1130 audit(1792401803.911:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:23.932000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:23.934235 kernel: audit: type=1130 audit(1792401803.932:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:23.935718 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 19 09:23:23.954000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:23.957359 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 19 09:23:23.977336 kernel: audit: type=1130 audit(1792401803.954:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:23.975000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:23.999205 kernel: audit: type=1130 audit(1792401803.975:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.001954 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 19 09:23:24.003196 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 19 09:23:24.007473 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 19 09:23:24.010373 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 19 09:23:24.010556 systemd-vconsole-setup[285]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 19 09:23:24.013292 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 19 09:23:24.040305 systemd-tmpfiles[293]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Oct 19 09:23:24.172000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.040486 systemd-tmpfiles[293]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 19 09:23:24.216000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.216000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.269475 kernel: audit: type=1130 audit(1792401804.172:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.154516 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 09:23:24.278000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.309365 kernel: audit: type=1130 audit(1792401804.216:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.174776 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 19 09:23:24.317314 kernel: audit: type=1131 audit(1792401804.216:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.174963 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 19 09:23:24.317482 kernel: audit: type=1130 audit(1792401804.278:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.259804 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 19 09:23:24.334000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.368392 kernel: audit: type=1130 audit(1792401804.334:11): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.302380 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 19 09:23:24.378000 audit: BPF prog-id=5 op=LOAD Oct 19 09:23:24.395381 kernel: audit: type=1334 audit(1792401804.378:12): prog-id=5 op=LOAD Oct 19 09:23:24.360386 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 19 09:23:24.381314 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 19 09:23:24.405366 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 19 09:23:24.448340 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 19 09:23:24.447000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.449228 systemd-resolved[300]: Positive Trust Anchors: Oct 19 09:23:24.449245 systemd-resolved[300]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 19 09:23:24.506862 kernel: audit: type=1130 audit(1792401804.447:13): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.449252 systemd-resolved[300]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 19 09:23:24.449320 systemd-resolved[300]: 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 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 19 09:23:24.507582 systemd-resolved[300]: Defaulting to hostname 'linux'. Oct 19 09:23:24.512000 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 19 09:23:24.512213 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 19 09:23:24.510000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.533197 kernel: audit: type=1130 audit(1792401804.510:14): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.553380 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 19 09:23:24.555000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.597459 kernel: audit: type=1130 audit(1792401804.555:15): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.559706 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 19 09:23:24.597849 dracut-cmdline[313]: dracut-112 Oct 19 09:23:24.618477 dracut-cmdline[313]: Using kernel command line parameters: SYSTEMD_SULOGIN_FORCE=1 rootflags=rw mount.usrflags=ro 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,115200n8 flatcar.first_boot=detected flatcar.oem.id=gce verity.usrhash=0afd667f618a8e27326d25715c0da0128cccb1492e26e9e72b0ec36f7345d045 Oct 19 09:23:24.725225 kernel: Loading iSCSI transport class v2.0-870. Oct 19 09:23:24.748184 kernel: iscsi: registered transport (tcp) Oct 19 09:23:24.781645 kernel: iscsi: registered transport (qla4xxx) Oct 19 09:23:24.781742 kernel: QLogic iSCSI HBA Driver Oct 19 09:23:24.811642 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 19 09:23:24.833513 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 19 09:23:24.832000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.870470 kernel: audit: type=1130 audit(1792401804.832:16): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.836404 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 19 09:23:24.888751 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 19 09:23:24.887000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.910000 audit: BPF prog-id=6 op=LOAD Oct 19 09:23:24.910000 audit: BPF prog-id=7 op=LOAD Oct 19 09:23:24.926532 kernel: audit: type=1130 audit(1792401804.887:17): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:24.912405 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 19 09:23:24.967373 systemd-udevd[447]: Using default interface naming scheme 'v261'. Oct 19 09:23:24.999503 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 19 09:23:25.009000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:25.015754 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 19 09:23:25.031000 audit: BPF prog-id=8 op=LOAD Oct 19 09:23:25.034579 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 19 09:23:25.051548 dracut-pre-trigger[467]: rd.md=0: removing MD RAID activation Oct 19 09:23:25.102820 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 19 09:23:25.112000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:25.107579 systemd-networkd[470]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Oct 19 09:23:25.117319 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 19 09:23:25.121593 systemd-networkd[470]: lo: Link UP Oct 19 09:23:25.168000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:25.121600 systemd-networkd[470]: lo: Gained carrier Oct 19 09:23:25.160525 systemd[1]: Started systemd-networkd.service - Network Management. Oct 19 09:23:25.170191 systemd[1]: Reached target network.target - Network. Oct 19 09:23:25.289057 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 19 09:23:25.288000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:25.291965 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 19 09:23:25.544851 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Oct 19 09:23:25.599088 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - PersistentDisk ROOT. Oct 19 09:23:25.643571 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - PersistentDisk EFI-SYSTEM. Oct 19 09:23:25.730856 systemd-networkd[470]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 19 09:23:25.734388 systemd-networkd[470]: eth0: Link UP Oct 19 09:23:25.735580 systemd-networkd[470]: eth0: Gained carrier Oct 19 09:23:25.740206 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - PersistentDisk OEM. Oct 19 09:23:25.742776 systemd-networkd[470]: eth0: Overlong DHCP hostname received, shortened from 'ci-9999-9-9-enable-nvidia-580-1-a631ab9e93aa77f8eac5.c.flatcar-212911.internal' to 'ci-9999-9-9-enable-nvidia-580-1-a631ab9e93aa77f8eac5' Oct 19 09:23:25.742789 systemd-networkd[470]: eth0: DHCPv4 address 10.128.0.92/32, gateway 10.128.0.1 acquired from 169.254.169.254 Oct 19 09:23:25.772580 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - PersistentDisk USR-A. Oct 19 09:23:25.808989 systemd[1]: Mounting oem.mount - /oem... Oct 19 09:23:25.868339 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (566) Oct 19 09:23:25.826558 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 19 09:23:25.896750 kernel: BTRFS info (device sda6): first mount of filesystem f4b1ad2a-639f-4218-aeb4-d1f36b4344b9 Oct 19 09:23:25.897494 kernel: BTRFS info (device sda6): using crc32c (crc32c-lib) checksum algorithm Oct 19 09:23:25.897674 kernel: BTRFS info (device sda6): enabling ssd optimizations Oct 19 09:23:25.897710 disk-uuid[569]: Primary Header is updated. Oct 19 09:23:25.897710 disk-uuid[569]: Secondary Entries is updated. Oct 19 09:23:25.897710 disk-uuid[569]: Secondary Header is updated. Oct 19 09:23:25.918000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:25.935350 kernel: BTRFS info (device sda6): turning on async discard Oct 19 09:23:25.904465 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 19 09:23:25.945322 kernel: BTRFS info (device sda6): enabling free space tree Oct 19 09:23:25.904674 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 09:23:25.920204 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 09:23:25.964861 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 09:23:25.995627 systemd[1]: Mounted oem.mount - /oem. Oct 19 09:23:26.008486 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 19 09:23:26.025345 systemd-vconsole-setup[590]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 19 09:23:26.047295 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 09:23:26.049000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:26.287018 ignition[599]: Ignition 2.27.0 Oct 19 09:23:26.287038 ignition[599]: Stage: fetch-offline Oct 19 09:23:26.293145 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 19 09:23:26.287066 ignition[599]: no config dir at "/run/ignition/base.d" Oct 19 09:23:26.317000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:26.287085 ignition[599]: no config dir at "/etc/ignition/base.d" Oct 19 09:23:26.333000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:26.318771 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 19 09:23:26.288421 ignition[599]: no config dir at "/usr/lib/ignition/base.d" Oct 19 09:23:26.288429 ignition[599]: no configs found in "base.d" across system config directories Oct 19 09:23:26.358005 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 19 09:23:26.288451 ignition[599]: no config dir at "/run/ignition/base.platform.d/gcp" Oct 19 09:23:26.368310 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 19 09:23:26.288463 ignition[599]: no config dir at "/etc/ignition/base.platform.d/gcp" Oct 19 09:23:26.440000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:26.386304 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 19 09:23:26.288479 ignition[599]: no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 19 09:23:26.387474 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 19 09:23:26.483000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:26.288486 ignition[599]: no configs found in "base.platform.d/gcp" across system config directories Oct 19 09:23:26.423344 unknown[626]: fetched base config from "system" Oct 19 09:23:26.288758 ignition[599]: reading system config file "/run/ignition/user.ign" Oct 19 09:23:26.423356 unknown[626]: fetched base config from "system" Oct 19 09:23:26.288772 ignition[599]: no config at "/run/ignition/user.ign" Oct 19 09:23:26.423367 unknown[626]: fetched user config from "gcp" Oct 19 09:23:26.288780 ignition[599]: reading system config file "/etc/ignition/user.ign" Oct 19 09:23:26.425193 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 19 09:23:26.288791 ignition[599]: no config at "/etc/ignition/user.ign" Oct 19 09:23:26.442446 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 19 09:23:26.288800 ignition[599]: reading system config file "/usr/lib/ignition/user.ign" Oct 19 09:23:26.474891 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 19 09:23:26.288838 ignition[599]: no config at "/usr/lib/ignition/user.ign" Oct 19 09:23:26.288850 ignition[599]: failed to fetch config: resource requires networking Oct 19 09:23:26.289137 ignition[599]: Ignition finished successfully Oct 19 09:23:26.412255 ignition[626]: Ignition 2.27.0 Oct 19 09:23:26.412269 ignition[626]: Stage: fetch Oct 19 09:23:26.412536 ignition[626]: no config dir at "/run/ignition/base.d" Oct 19 09:23:26.412549 ignition[626]: no config dir at "/etc/ignition/base.d" Oct 19 09:23:26.412568 ignition[626]: no config dir at "/usr/lib/ignition/base.d" Oct 19 09:23:26.412575 ignition[626]: no configs found in "base.d" across system config directories Oct 19 09:23:26.412589 ignition[626]: no config dir at "/run/ignition/base.platform.d/gcp" Oct 19 09:23:26.412598 ignition[626]: no config dir at "/etc/ignition/base.platform.d/gcp" Oct 19 09:23:26.412606 ignition[626]: no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 19 09:23:26.412610 ignition[626]: no configs found in "base.platform.d/gcp" across system config directories Oct 19 09:23:26.412752 ignition[626]: reading system config file "/run/ignition/user.ign" Oct 19 09:23:26.412769 ignition[626]: no config at "/run/ignition/user.ign" Oct 19 09:23:26.412777 ignition[626]: reading system config file "/etc/ignition/user.ign" Oct 19 09:23:26.412787 ignition[626]: no config at "/etc/ignition/user.ign" Oct 19 09:23:26.412794 ignition[626]: reading system config file "/usr/lib/ignition/user.ign" Oct 19 09:23:26.412808 ignition[626]: no config at "/usr/lib/ignition/user.ign" Oct 19 09:23:26.412845 ignition[626]: GET http://169.254.169.254/computeMetadata/v1/instance/attributes/user-data: attempt #1 Oct 19 09:23:26.416132 ignition[626]: GET result: OK Oct 19 09:23:26.416897 ignition[626]: parsing config with SHA512: e1dd81a5a55d434bbced9149847d0ddf8186185b253f9c7c67c5e59f4d7f0240d5192a97d88b4a01098368a0ee1a53d76610a1553bd4b79f6881b175c802f6e9 Oct 19 09:23:26.423549 ignition[626]: fetch: fetch complete Oct 19 09:23:26.423555 ignition[626]: fetch: fetch passed Oct 19 09:23:26.423606 ignition[626]: Ignition finished successfully Oct 19 09:23:26.472706 ignition[631]: Ignition 2.27.0 Oct 19 09:23:26.472715 ignition[631]: Stage: kargs Oct 19 09:23:26.472930 ignition[631]: no config dir at "/run/ignition/base.d" Oct 19 09:23:26.472938 ignition[631]: no config dir at "/etc/ignition/base.d" Oct 19 09:23:26.472951 ignition[631]: no config dir at "/usr/lib/ignition/base.d" Oct 19 09:23:26.472956 ignition[631]: no configs found in "base.d" across system config directories Oct 19 09:23:26.472966 ignition[631]: no config dir at "/run/ignition/base.platform.d/gcp" Oct 19 09:23:26.472973 ignition[631]: no config dir at "/etc/ignition/base.platform.d/gcp" Oct 19 09:23:26.472981 ignition[631]: no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 19 09:23:26.472986 ignition[631]: no configs found in "base.platform.d/gcp" across system config directories Oct 19 09:23:26.473614 ignition[631]: kargs: kargs passed Oct 19 09:23:26.473670 ignition[631]: Ignition finished successfully Oct 19 09:23:26.938894 disk-uuid[583]: Warning: The kernel is still using the old partition table. Oct 19 09:23:26.938894 disk-uuid[583]: The new table will be used at the next reboot or after you Oct 19 09:23:26.938894 disk-uuid[583]: run partprobe(8) or kpartx(8) Oct 19 09:23:26.938894 disk-uuid[583]: The operation has completed successfully. Oct 19 09:23:26.957000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:26.957000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:26.944900 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 19 09:23:26.945070 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 19 09:23:26.960144 systemd[1]: Mounting boot.mount - Boot partition... Oct 19 09:23:26.977131 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 19 09:23:27.022000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:27.021555 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 19 09:23:27.047000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:27.021711 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 19 09:23:27.066000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:27.024048 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 19 09:23:27.024220 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 19 09:23:27.100567 kernel: BTRFS info (device sda6): last unmount of filesystem f4b1ad2a-639f-4218-aeb4-d1f36b4344b9 Oct 19 09:23:27.048705 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 19 09:23:27.048904 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 19 09:23:27.068556 systemd[1]: Unmounting oem.mount - /oem... Oct 19 09:23:27.088186 systemd[1]: Mounted boot.mount - Boot partition. Oct 19 09:23:27.115851 systemd[1]: oem.mount: Deactivated successfully. Oct 19 09:23:27.116037 systemd[1]: Unmounted oem.mount - /oem. Oct 19 09:23:27.165198 ignition[649]: Ignition 2.27.0 Oct 19 09:23:27.165210 ignition[649]: Stage: disks Oct 19 09:23:27.165457 ignition[649]: no config dir at "/run/ignition/base.d" Oct 19 09:23:27.165469 ignition[649]: no config dir at "/etc/ignition/base.d" Oct 19 09:23:27.165490 ignition[649]: no config dir at "/usr/lib/ignition/base.d" Oct 19 09:23:27.165494 ignition[649]: no configs found in "base.d" across system config directories Oct 19 09:23:27.165504 ignition[649]: no config dir at "/run/ignition/base.platform.d/gcp" Oct 19 09:23:27.165511 ignition[649]: no config dir at "/etc/ignition/base.platform.d/gcp" Oct 19 09:23:27.165519 ignition[649]: no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 19 09:23:27.165523 ignition[649]: no configs found in "base.platform.d/gcp" across system config directories Oct 19 09:23:27.166235 ignition[649]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-label/ROOT] Oct 19 09:23:27.174740 ignition[649]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-label/ROOT] Oct 19 09:23:27.174896 ignition[649]: disks: createFilesystems: created device alias for "/dev/disk/by-label/ROOT": "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" -> "/dev/sda9" Oct 19 09:23:27.174961 ignition[649]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-label/ROOT" Oct 19 09:23:27.196905 ignition[649]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-label/ROOT" Oct 19 09:23:27.196914 ignition[649]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-label/ROOT" with uuid "2a59b53d-d8d6-487d-b952-f42f3028565d" and label "ROOT" Oct 19 09:23:27.197127 ignition[649]: disks: createFilesystems: op(3): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" Oct 19 09:23:27.197141 ignition[649]: disks: createFilesystems: op(3): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" Oct 19 09:23:27.222510 ignition[649]: disks: createFilesystems: op(3): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" Oct 19 09:23:27.222787 ignition[649]: disks: createFilesystems: op(4): [started] creating "btrfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" Oct 19 09:23:27.222813 ignition[649]: disks: createFilesystems: op(4): executing: "mkfs.btrfs" "--label=ROOT" "--uuid=9aa5237a-ab6b-458b-a7e8-f25e2baef1a3" "--force" "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" Oct 19 09:23:27.339518 ignition[649]: disks: createFilesystems: op(4): [finished] creating "btrfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" Oct 19 09:23:27.339602 ignition[649]: disks: createFilesystems: op(5): [started] waiting for triggered uevent Oct 19 09:23:27.339613 ignition[649]: disks: createFilesystems: op(5): executing: "udevadm" "trigger" "--settle" "/dev/sda9" Oct 19 09:23:27.429706 ignition[649]: disks: createFilesystems: op(5): [finished] waiting for triggered uevent Oct 19 09:23:27.429750 ignition[649]: disks: disks passed Oct 19 09:23:27.440000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:27.437971 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 19 09:23:27.429842 ignition[649]: Ignition finished successfully Oct 19 09:23:27.444756 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 19 09:23:27.464428 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 19 09:23:27.473509 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 19 09:23:27.489516 systemd[1]: Reached target sysinit.target - System Initialization. Oct 19 09:23:27.523462 systemd[1]: Reached target basic.target - Basic System. Oct 19 09:23:27.534178 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 19 09:23:27.559774 systemd-networkd[470]: eth0: Gained IPv6LL Oct 19 09:23:27.579000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:27.564778 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 19 09:23:27.582145 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 19 09:23:27.622850 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 19 09:23:27.621000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:27.625784 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 19 09:23:27.677573 kernel: BTRFS: device label ROOT devid 1 transid 8 /dev/sda9 (8:9) scanned by mount (681) Oct 19 09:23:27.677616 kernel: BTRFS info (device sda9): first mount of filesystem 9aa5237a-ab6b-458b-a7e8-f25e2baef1a3 Oct 19 09:23:27.677633 kernel: BTRFS info (device sda9): using crc32c (crc32c-lib) checksum algorithm Oct 19 09:23:27.689180 kernel: BTRFS info (device sda9): checking UUID tree Oct 19 09:23:27.689253 kernel: BTRFS info (device sda9): enabling ssd optimizations Oct 19 09:23:27.701176 kernel: BTRFS info (device sda9): turning on async discard Oct 19 09:23:27.701232 kernel: BTRFS info (device sda9): enabling free space tree Oct 19 09:23:27.709381 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 19 09:23:27.710299 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 19 09:23:27.740589 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 19 09:23:27.748894 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent skipped, no trigger condition checks were met. Oct 19 09:23:27.748953 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Oct 19 09:23:27.748990 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 19 09:23:27.770618 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 19 09:23:27.802257 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 19 09:23:28.018187 kernel: loop1: detected capacity change from 0 to 44505 Oct 19 09:23:28.030190 kernel: loop1: p1 p2 p3 Oct 19 09:23:28.069530 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:28.069610 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:28.078558 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:28.084637 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:28.084760 systemd-confext[772]: device-mapper: reload ioctl on loop1p1-12-verity (254:1) failed: Invalid argument Oct 19 09:23:28.104350 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:28.172266 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Oct 19 09:23:28.199196 kernel: loop2: detected capacity change from 0 to 44505 Oct 19 09:23:28.209206 kernel: loop2: p1 p2 p3 Oct 19 09:23:28.229182 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:28.229256 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:28.229284 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:28.238442 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:28.243982 (sd-merge)[782]: device-mapper: reload ioctl on loop2p1-16-verity (254:1) failed: Invalid argument Oct 19 09:23:28.262340 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:28.293191 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Oct 19 09:23:28.293988 (sd-merge)[782]: Using extensions '00-flatcar-default.raw'. Oct 19 09:23:28.295268 (sd-merge)[782]: Merged extensions into '/sysroot/etc'. Oct 19 09:23:28.303643 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 19 09:23:28.317000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:28.327507 initrd-setup-root[789]: /etc 00-flatcar-default Mon 2026-10-19 09:23:24 UTC Oct 19 09:23:28.320223 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 19 09:23:28.372797 ignition[793]: INFO : Ignition 2.27.0 Oct 19 09:23:28.372797 ignition[793]: INFO : Stage: mount Oct 19 09:23:28.387000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:28.394515 ignition[793]: INFO : no config dir at "/run/ignition/base.d" Oct 19 09:23:28.394515 ignition[793]: INFO : no config dir at "/etc/ignition/base.d" Oct 19 09:23:28.394515 ignition[793]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 19 09:23:28.394515 ignition[793]: INFO : no configs found in "base.d" across system config directories Oct 19 09:23:28.394515 ignition[793]: INFO : no config dir at "/run/ignition/base.platform.d/gcp" Oct 19 09:23:28.394515 ignition[793]: INFO : no config dir at "/etc/ignition/base.platform.d/gcp" Oct 19 09:23:28.394515 ignition[793]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 19 09:23:28.394515 ignition[793]: INFO : no configs found in "base.platform.d/gcp" across system config directories Oct 19 09:23:28.394515 ignition[793]: INFO : mount: mount passed Oct 19 09:23:28.394515 ignition[793]: INFO : Ignition finished successfully Oct 19 09:23:28.375739 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 19 09:23:28.570327 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (801) Oct 19 09:23:28.389567 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 19 09:23:28.579000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:28.589483 kernel: BTRFS info (device sda6): first mount of filesystem f4b1ad2a-639f-4218-aeb4-d1f36b4344b9 Oct 19 09:23:28.410674 systemd[1]: Mounting oem.mount - /oem... Oct 19 09:23:28.604345 kernel: BTRFS info (device sda6): using crc32c (crc32c-lib) checksum algorithm Oct 19 09:23:28.489821 systemd[1]: Mounted oem.mount - /oem. Oct 19 09:23:28.614000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:28.614000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:28.629383 kernel: BTRFS info (device sda6): enabling ssd optimizations Oct 19 09:23:28.491828 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 19 09:23:28.637331 kernel: BTRFS info (device sda6): turning on async discard Oct 19 09:23:28.637439 ignition[818]: INFO : Ignition 2.27.0 Oct 19 09:23:28.637439 ignition[818]: INFO : Stage: files Oct 19 09:23:28.637439 ignition[818]: INFO : no config dir at "/run/ignition/base.d" Oct 19 09:23:28.637439 ignition[818]: INFO : no config dir at "/etc/ignition/base.d" Oct 19 09:23:28.637439 ignition[818]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 19 09:23:28.637439 ignition[818]: INFO : no configs found in "base.d" across system config directories Oct 19 09:23:28.637439 ignition[818]: INFO : no config dir at "/run/ignition/base.platform.d/gcp" Oct 19 09:23:28.637439 ignition[818]: INFO : no config dir at "/etc/ignition/base.platform.d/gcp" Oct 19 09:23:28.637439 ignition[818]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 19 09:23:28.637439 ignition[818]: INFO : no configs found in "base.platform.d/gcp" across system config directories Oct 19 09:23:28.637439 ignition[818]: DEBUG : files: compiled without relabeling support, skipping Oct 19 09:23:28.637439 ignition[818]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 19 09:23:28.637439 ignition[818]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 19 09:23:28.637439 ignition[818]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 19 09:23:28.637439 ignition[818]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 19 09:23:28.637439 ignition[818]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 19 09:23:28.637439 ignition[818]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 19 09:23:28.637439 ignition[818]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 19 09:23:28.637439 ignition[818]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 19 09:23:28.637439 ignition[818]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 19 09:23:28.637439 ignition[818]: INFO : files: files passed Oct 19 09:23:28.637439 ignition[818]: INFO : Ignition finished successfully Oct 19 09:23:28.516579 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 19 09:23:29.018804 kernel: BTRFS info (device sda6): enabling free space tree Oct 19 09:23:28.563351 unknown[818]: wrote ssh authorized keys file for user: core Oct 19 09:23:29.026335 kernel: loop3: detected capacity change from 0 to 44505 Oct 19 09:23:28.565736 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 19 09:23:29.034361 kernel: loop3: p1 p2 p3 Oct 19 09:23:28.581444 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 19 09:23:29.043322 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.043363 initrd-setup-root-after-ignition[850]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 19 09:23:29.043363 initrd-setup-root-after-ignition[850]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 19 09:23:28.599193 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 19 09:23:29.087353 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:29.087393 initrd-setup-root-after-ignition[854]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 19 09:23:28.614833 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 19 09:23:29.108305 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:28.615039 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 19 09:23:29.123324 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:28.723682 systemd-confext[856]: device-mapper: reload ioctl on loop3p1-19-verity (254:2) failed: Invalid argument Oct 19 09:23:29.139347 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:28.850543 (sd-merge)[864]: device-mapper: reload ioctl on loop4p1-23-verity (254:2) failed: Invalid argument Oct 19 09:23:29.185936 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Oct 19 09:23:28.895393 (sd-merge)[864]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 19 09:23:29.199309 kernel: loop4: detected capacity change from 0 to 44505 Oct 19 09:23:28.990988 systemd-sysext[872]: device-mapper: reload ioctl on loop4p1-27-verity (254:2) failed: Invalid argument Oct 19 09:23:29.213269 kernel: loop4: p1 p2 p3 Oct 19 09:23:29.177387 systemd-sysext[872]: device-mapper: reload ioctl on loop5p1-31-verity (254:2) failed: Invalid argument Oct 19 09:23:29.226336 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.226381 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:29.226408 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:29.226435 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:29.226461 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.226487 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Oct 19 09:23:29.226511 kernel: loop4: detected capacity change from 0 to 431832 Oct 19 09:23:29.226539 kernel: loop4: p1 p2 p3 Oct 19 09:23:29.226562 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.226585 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:29.226607 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:29.226631 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:29.226654 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.226678 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 09:23:29.226703 kernel: loop5: detected capacity change from 0 to 158128 Oct 19 09:23:29.226733 kernel: loop5: p1 p2 p3 Oct 19 09:23:29.226758 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.226782 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:29.226808 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:29.226831 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:29.226856 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.262217 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 09:23:29.290195 kernel: loop6: detected capacity change from 0 to 169080 Oct 19 09:23:29.302692 kernel: loop6: p1 p2 p3 Oct 19 09:23:29.324449 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.324534 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:29.324564 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:29.339238 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:29.339271 systemd-sysext[872]: device-mapper: reload ioctl on loop6p1-35-verity (254:2) failed: Invalid argument Oct 19 09:23:29.357044 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.415182 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 09:23:29.444193 kernel: loop7: detected capacity change from 0 to 431832 Oct 19 09:23:29.455201 kernel: loop7: p1 p2 p3 Oct 19 09:23:29.475235 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.475396 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:29.475426 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:29.490040 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:29.490145 (sd-merge)[900]: device-mapper: reload ioctl on loop7p1-39-verity (254:2) failed: Invalid argument Oct 19 09:23:29.508415 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.561235 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 09:23:29.571188 kernel: loop1: detected capacity change from 0 to 158128 Oct 19 09:23:29.582254 kernel: loop1: p1 p2 p3 Oct 19 09:23:29.600136 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.600237 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:29.600266 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:29.608888 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:29.614832 (sd-merge)[900]: device-mapper: reload ioctl on loop1p1-43-verity (254:3) failed: Invalid argument Oct 19 09:23:29.632334 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.686187 kernel: erofs (device dm-3): mounted with root inode @ nid 39. Oct 19 09:23:29.693206 kernel: loop3: detected capacity change from 0 to 169080 Oct 19 09:23:29.702864 kernel: loop3: p1 p2 p3 Oct 19 09:23:29.720370 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.720589 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:29.720621 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:29.735257 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:29.735341 (sd-merge)[900]: device-mapper: reload ioctl on loop3p1-47-verity (254:4) failed: Invalid argument Oct 19 09:23:29.753310 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:29.799217 kernel: erofs (device dm-4): mounted with root inode @ nid 39. Oct 19 09:23:29.799569 (sd-merge)[900]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-gce-9999.9.9+enable-nvidia-580-1.raw'. Oct 19 09:23:29.801318 (sd-merge)[900]: Merged extensions into '/sysroot/usr'. Oct 19 09:23:29.821000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:29.856572 kernel: kauditd_printk_skb: 26 callbacks suppressed Oct 19 09:23:29.806665 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 19 09:23:29.877387 kernel: audit: type=1130 audit(1792401809.821:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:29.852116 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 19 09:23:29.884290 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 19 09:23:29.884448 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 19 09:23:29.904000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:29.904000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:29.905350 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Oct 19 09:23:29.974327 kernel: audit: type=1130 audit(1792401809.904:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:29.906134 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 19 09:23:29.994333 kernel: audit: type=1131 audit(1792401809.904:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:29.965788 systemd[1]: dracut-mount.service - dracut mount hook skipped, no trigger condition checks were met. Oct 19 09:23:29.967090 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 19 09:23:30.001361 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 19 09:23:30.025000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.056498 kernel: audit: type=1130 audit(1792401810.025:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.050231 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 19 09:23:30.077080 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 19 09:23:30.095456 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 19 09:23:30.112456 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 19 09:23:30.129470 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 19 09:23:30.129878 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 19 09:23:30.166520 systemd[1]: Stopped target timers.target - Timer Units. Oct 19 09:23:30.166889 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 19 09:23:30.167059 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Oct 19 09:23:30.197681 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 19 09:23:30.197855 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 19 09:23:30.222000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.253408 kernel: audit: type=1131 audit(1792401810.222:48): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.223818 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 19 09:23:30.262626 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 19 09:23:30.291424 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 19 09:23:30.291765 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 19 09:23:30.298000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.336435 kernel: audit: type=1131 audit(1792401810.298:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.299860 systemd[1]: Stopped target basic.target - Basic System. Oct 19 09:23:30.345607 systemd[1]: Stopped target paths.target - Path Units. Oct 19 09:23:30.352625 systemd[1]: Stopped target slices.target - Slice Units. Oct 19 09:23:30.380436 systemd[1]: Stopped target sockets.target - Socket Units. Oct 19 09:23:30.380833 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 19 09:23:30.411480 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 19 09:23:30.428400 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 19 09:23:30.429117 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 19 09:23:30.437724 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 19 09:23:30.458582 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 19 09:23:30.459107 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 19 09:23:30.493689 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 19 09:23:30.521493 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Oct 19 09:23:30.541483 systemd[1]: Stopped target swap.target - Swaps. Oct 19 09:23:30.554399 systemd[1]: iscsid.socket: Deactivated successfully. Oct 19 09:23:30.554779 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 19 09:23:30.562614 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 19 09:23:30.562762 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 19 09:23:30.578684 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Oct 19 09:23:30.578823 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Oct 19 09:23:30.626000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.656429 kernel: audit: type=1131 audit(1792401810.626:50): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.593800 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 19 09:23:30.665000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.695411 kernel: audit: type=1131 audit(1792401810.665:51): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.593987 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 19 09:23:30.703000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.733765 kernel: audit: type=1131 audit(1792401810.703:52): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.627819 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 19 09:23:30.750000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.782419 ignition[936]: INFO : Ignition 2.27.0 Oct 19 09:23:30.782419 ignition[936]: INFO : Stage: umount Oct 19 09:23:30.782419 ignition[936]: INFO : no config dir at "/run/ignition/base.d" Oct 19 09:23:30.782419 ignition[936]: INFO : no config dir at "/etc/ignition/base.d" Oct 19 09:23:30.782419 ignition[936]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 19 09:23:30.782419 ignition[936]: INFO : no configs found in "base.d" across system config directories Oct 19 09:23:30.782419 ignition[936]: INFO : no config dir at "/run/ignition/base.platform.d/gcp" Oct 19 09:23:30.782419 ignition[936]: INFO : no config dir at "/etc/ignition/base.platform.d/gcp" Oct 19 09:23:30.782419 ignition[936]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 19 09:23:30.782419 ignition[936]: INFO : no configs found in "base.platform.d/gcp" across system config directories Oct 19 09:23:30.782419 ignition[936]: INFO : umount: umount passed Oct 19 09:23:30.782419 ignition[936]: INFO : Ignition finished successfully Oct 19 09:23:30.791000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.807000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.823000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.841000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.866000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.883000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.900000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.963000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.969000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.986754 kernel: audit: type=1131 audit(1792401810.750:53): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.628137 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 19 09:23:30.996000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.996000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.666739 systemd[1]: ignition-files.service: Deactivated successfully. Oct 19 09:23:31.006000 audit: BPF prog-id=5 op=UNLOAD Oct 19 09:23:30.667017 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 19 09:23:30.705990 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 19 09:23:30.742342 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 19 09:23:30.742595 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 19 09:23:30.751683 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 19 09:23:31.107000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.751955 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 19 09:23:31.125000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.792830 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 19 09:23:30.793000 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 19 09:23:30.808546 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 19 09:23:30.808689 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 19 09:23:30.828101 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 19 09:23:30.828294 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 19 09:23:30.844328 systemd[1]: Stopped target network.target - Network. Oct 19 09:23:31.212000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.851561 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 19 09:23:31.228000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.851621 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 19 09:23:31.247000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.867575 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 19 09:23:30.867637 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 19 09:23:31.286000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.884548 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 19 09:23:31.305000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.884605 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 19 09:23:31.324000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.901681 systemd[1]: Stopping systemd-networkd.service - Network Management... Oct 19 09:23:31.343000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.901721 systemd-networkd[470]: eth0: DHCP lease lost Oct 19 09:23:31.352000 audit: BPF prog-id=8 op=UNLOAD Oct 19 09:23:31.363000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.918525 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 19 09:23:31.379000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:31.379000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:30.944935 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 19 09:23:30.945116 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 19 09:23:30.967418 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 19 09:23:30.967588 systemd[1]: Stopped systemd-networkd.service - Network Management. Oct 19 09:23:30.974117 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 19 09:23:30.974304 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 19 09:23:31.001396 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Oct 19 09:23:31.001508 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 19 09:23:31.491317 systemd-journald[280]: Received SIGTERM from PID 1 (systemd). Oct 19 09:23:31.017359 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 19 09:23:31.017485 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 19 09:23:31.017541 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Oct 19 09:23:31.044404 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 19 09:23:31.071054 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 19 09:23:31.090809 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 19 09:23:31.091378 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 19 09:23:31.108403 systemd[1]: systemd-udevd.service: Consumed 1.834s CPU time over 6.178s wall clock time. Oct 19 09:23:31.644296 kernel: SELinux: policy capability network_peer_controls=1 Oct 19 09:23:31.108794 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 19 09:23:31.649000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 19 09:23:31.658409 kernel: SELinux: policy capability open_perms=1 Oct 19 09:23:31.108941 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 19 09:23:31.666328 kernel: SELinux: policy capability extended_socket_class=1 Oct 19 09:23:31.127120 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 19 09:23:31.675308 kernel: SELinux: policy capability always_check_network=0 Oct 19 09:23:31.127276 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 19 09:23:31.684427 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 19 09:23:31.162503 systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully. Oct 19 09:23:31.684559 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 19 09:23:31.162629 systemd[1]: Closed systemd-udevd-varlink.socket - udev Varlink Socket. Oct 19 09:23:31.684640 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 19 09:23:31.188459 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 19 09:23:31.684701 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 19 09:23:31.188526 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 19 09:23:31.684766 kernel: SELinux: policy capability userspace_initial_context=0 Oct 19 09:23:31.213528 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 19 09:23:31.684824 kernel: SELinux: policy capability netlink_xperm=0 Oct 19 09:23:31.213593 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 19 09:23:31.684884 kernel: SELinux: policy capability netif_wildcard=0 Oct 19 09:23:31.229560 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 19 09:23:31.684946 kernel: SELinux: policy capability genfs_seclabel_wildcard=0 Oct 19 09:23:31.229631 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 19 09:23:31.685007 kernel: SELinux: policy capability functionfs_seclabel=0 Oct 19 09:23:31.258646 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 19 09:23:31.685079 systemd[1]: Successfully loaded SELinux policy in 120.210ms. Oct 19 09:23:31.276297 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 19 09:23:31.276386 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 19 09:23:31.287390 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 19 09:23:31.287467 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 19 09:23:31.306414 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 19 09:23:31.306485 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 19 09:23:31.325399 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 19 09:23:31.325469 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 19 09:23:31.344382 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 19 09:23:31.344457 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 09:23:31.364942 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 19 09:23:31.365109 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 19 09:23:31.381465 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 19 09:23:31.399283 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 19 09:23:31.427717 systemd[1]: Switching root. Oct 19 09:23:31.685950 systemd-journald[280]: Journal stopped Oct 19 09:23:35.308493 kernel: NET: Registered PF_VSOCK protocol family Oct 19 09:23:35.308545 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 12.844ms. Oct 19 09:23:35.308574 systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Oct 19 09:23:35.308604 systemd[1]: Detected virtualization google. Oct 19 09:23:35.308624 systemd[1]: Detected architecture x86-64. Oct 19 09:23:35.308645 systemd[1]: Detected first boot. Oct 19 09:23:35.308668 systemd[1]: Initializing machine ID from random generator. Oct 19 09:23:35.308691 zram_generator::config[976]: No configuration found. Oct 19 09:23:35.308718 systemd[1]: Applying preset policy. Oct 19 09:23:35.308754 systemd[1]: Created symlink '/etc/systemd/system/timers.target.wants/google-oslogin-cache.timer' → '/usr/lib/systemd/system/google-oslogin-cache.timer'. Oct 19 09:23:35.308776 systemd[1]: Populated /etc with preset unit settings. Oct 19 09:23:35.308797 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 19 09:23:35.308818 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 19 09:23:35.308839 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 19 09:23:35.308867 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 19 09:23:35.308890 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 19 09:23:35.308913 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 19 09:23:35.308935 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 19 09:23:35.308962 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 19 09:23:35.308985 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 19 09:23:35.309008 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 19 09:23:35.309031 systemd[1]: Created slice user.slice - User and Session Slice. Oct 19 09:23:35.309055 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 19 09:23:35.309078 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 19 09:23:35.309106 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 19 09:23:35.309129 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 19 09:23:35.309163 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 19 09:23:35.309186 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 19 09:23:35.309209 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 19 09:23:35.309232 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 19 09:23:35.309254 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 19 09:23:35.309280 systemd[1]: Reached target imports.target - Image Downloads. Oct 19 09:23:35.309302 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 19 09:23:35.309325 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 19 09:23:35.309349 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 19 09:23:35.309372 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 19 09:23:35.309394 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 19 09:23:35.309417 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 19 09:23:35.309444 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Oct 19 09:23:35.309467 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Oct 19 09:23:35.309495 systemd[1]: Reached target slices.target - Slice Units. Oct 19 09:23:35.309518 systemd[1]: Reached target swap.target - Swaps. Oct 19 09:23:35.309546 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 19 09:23:35.309570 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 19 09:23:35.309594 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 19 09:23:35.309619 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 19 09:23:35.309642 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Oct 19 09:23:35.309670 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 19 09:23:35.309693 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 19 09:23:35.309716 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Oct 19 09:23:35.309740 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Oct 19 09:23:35.309781 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Oct 19 09:23:35.309805 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Oct 19 09:23:35.309829 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 19 09:23:35.309856 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Oct 19 09:23:35.309880 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Oct 19 09:23:35.309903 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Oct 19 09:23:35.309927 systemd[1]: Listening on systemd-report-basic.socket - Report System Basic Metrics Socket. Oct 19 09:23:35.309951 systemd[1]: Listening on systemd-report-cgroup.socket - CGroup Report Varlink Socket. Oct 19 09:23:35.309974 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Oct 19 09:23:35.309998 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Oct 19 09:23:35.310024 systemd[1]: Listening on systemd-storage-block.socket - Simple Block Device Backed Storage Provider. Oct 19 09:23:35.310048 systemd[1]: Listening on systemd-storage-fs.socket - Simple File System Backed Storage Provider. Oct 19 09:23:35.310072 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 19 09:23:35.310095 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 19 09:23:35.310119 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 19 09:23:35.310144 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 19 09:23:35.310179 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 19 09:23:35.310206 systemd[1]: Mounting media.mount - External Media Directory... Oct 19 09:23:35.310230 systemd[1]: proc-xen.mount - /proc/xen skipped, unmet condition check ConditionVirtualization=xen Oct 19 09:23:35.310254 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 19 09:23:35.310277 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 19 09:23:35.310301 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Oct 19 09:23:35.310325 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 19 09:23:35.310352 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 19 09:23:35.310376 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Oct 19 09:23:35.310400 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 19 09:23:35.310424 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 19 09:23:35.310447 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Oct 19 09:23:35.310472 systemd[1]: modprobe@efi_pstore.service - Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore Oct 19 09:23:35.310496 systemd[1]: modprobe@fuse.service - Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse Oct 19 09:23:35.310523 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 19 09:23:35.310547 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Oct 19 09:23:35.310570 systemd[1]: Starting setup-oem.service - Setup OEM... Oct 19 09:23:35.310594 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 19 09:23:35.310617 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 19 09:23:35.310640 kernel: kauditd_printk_skb: 40 callbacks suppressed Oct 19 09:23:35.310668 kernel: audit: type=1131 audit(1792401815.155:94): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.310691 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 Oct 19 09:23:35.310714 kernel: audit: type=1334 audit(1792401815.203:95): prog-id=12 op=UNLOAD Oct 19 09:23:35.310735 kernel: audit: type=1334 audit(1792401815.203:96): prog-id=11 op=UNLOAD Oct 19 09:23:35.310762 kernel: audit: type=1334 audit(1792401815.204:97): prog-id=13 op=LOAD Oct 19 09:23:35.310783 kernel: audit: type=1334 audit(1792401815.210:98): prog-id=14 op=LOAD Oct 19 09:23:35.310809 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 19 09:23:35.310831 kernel: audit: type=1334 audit(1792401815.217:99): prog-id=15 op=LOAD Oct 19 09:23:35.310853 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 19 09:23:35.310876 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 19 09:23:35.310935 systemd-journald[1060]: Collecting audit messages is enabled. Oct 19 09:23:35.310985 kernel: audit: type=1305 audit(1792401815.300:100): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 19 09:23:35.311011 systemd-journald[1060]: Journal started Oct 19 09:23:35.311054 systemd-journald[1060]: Runtime Journal (/run/log/journal/fbc5b74eb7c84b65a9d0ab98a4d7fd09) is 8M, max 148.4M, 140.4M free. Oct 19 09:23:34.444000 audit[1]: EVENT_LISTENER pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 Oct 19 09:23:35.155000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.203000 audit: BPF prog-id=12 op=UNLOAD Oct 19 09:23:35.203000 audit: BPF prog-id=11 op=UNLOAD Oct 19 09:23:35.204000 audit: BPF prog-id=13 op=LOAD Oct 19 09:23:35.210000 audit: BPF prog-id=14 op=LOAD Oct 19 09:23:35.217000 audit: BPF prog-id=15 op=LOAD Oct 19 09:23:35.300000 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 19 09:23:33.758020 systemd[1]: Queued start job for default target multi-user.target. Oct 19 09:23:35.300000 audit[1060]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=3 a1=7ffd0f6a4730 a2=4000 a3=0 items=0 ppid=1 pid=1060 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 19 09:23:33.768008 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Oct 19 09:23:35.319582 kernel: audit: type=1300 audit(1792401815.300:100): arch=c000003e syscall=46 success=yes exit=60 a0=3 a1=7ffd0f6a4730 a2=4000 a3=0 items=0 ppid=1 pid=1060 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 19 09:23:33.768694 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 19 09:23:35.279669 systemd-modules-load[1062]: Using 2 probe threads Oct 19 09:23:35.300000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 19 09:23:35.361948 kernel: audit: type=1327 audit(1792401815.300:100): proctitle="/usr/lib/systemd/systemd-journald" Oct 19 09:23:35.376199 systemd[1]: Reached target time-set.target - System Time Set. Oct 19 09:23:35.395189 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 19 09:23:35.417310 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 19 09:23:35.440193 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 19 09:23:35.465211 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer skipped, unmet condition check ConditionVirtualization=xen Oct 19 09:23:35.480207 systemd[1]: Started systemd-journald.service - Journal Service. Oct 19 09:23:35.487000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.489860 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 19 09:23:35.512310 kernel: audit: type=1130 audit(1792401815.487:101): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.521589 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 19 09:23:35.532560 systemd[1]: Mounted media.mount - External Media Directory. Oct 19 09:23:35.541557 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 19 09:23:35.550544 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 19 09:23:35.561545 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 19 09:23:35.570883 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 19 09:23:35.581840 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 19 09:23:35.580000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.591000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.592868 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 19 09:23:35.593328 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 19 09:23:35.602000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.602000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.603853 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 19 09:23:35.617798 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 19 09:23:35.627000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.628968 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 19 09:23:35.638000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.641418 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 19 09:23:35.651000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.652797 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 19 09:23:35.662000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.665294 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 19 09:23:35.674000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.675732 systemd[1]: Finished setup-oem.service - Setup OEM. Oct 19 09:23:35.682000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=setup-oem comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.693864 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 19 09:23:35.703880 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 19 09:23:35.715746 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 19 09:23:35.726291 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Oct 19 09:23:35.728446 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 19 09:23:35.742433 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 19 09:23:35.752475 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Oct 19 09:23:35.757287 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 19 09:23:35.762273 systemd-journald[1060]: Time spent on flushing to /var/log/journal/fbc5b74eb7c84b65a9d0ab98a4d7fd09 is 97.479ms for 1230 entries. Oct 19 09:23:35.762273 systemd-journald[1060]: System Journal (/var/log/journal/fbc5b74eb7c84b65a9d0ab98a4d7fd09) is 8M, max 632M, 624M free. Oct 19 09:23:35.853000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.806428 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 19 09:23:35.915558 systemd-journald[1060]: Received client request to flush runtime journal. Oct 19 09:23:35.818437 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 19 09:23:35.915842 systemd-journald[1060]: Creating journal file /var/log/journal/fbc5b74eb7c84b65a9d0ab98a4d7fd09/system.journal on a btrfs file system, and copy-on-write is enabled. This is likely to slow down journal access substantially, please consider turning off the copy-on-write file attribute on the journal directory, using chattr +C. Oct 19 09:23:35.832632 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 19 09:23:35.843732 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 19 09:23:35.858552 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 19 09:23:35.908788 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 19 09:23:35.917000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.919960 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 19 09:23:35.930000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.933521 systemd-tmpfiles[1091]: ACLs are not supported, ignoring. Oct 19 09:23:35.933561 systemd-tmpfiles[1091]: ACLs are not supported, ignoring. Oct 19 09:23:35.940338 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 19 09:23:35.949000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:35.955295 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 19 09:23:36.018785 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 19 09:23:36.026000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:36.031637 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Oct 19 09:23:36.041000 audit: BPF prog-id=16 op=LOAD Oct 19 09:23:36.041000 audit: BPF prog-id=17 op=LOAD Oct 19 09:23:36.041000 audit: BPF prog-id=18 op=LOAD Oct 19 09:23:36.045307 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Oct 19 09:23:36.055000 audit: BPF prog-id=19 op=LOAD Oct 19 09:23:36.058410 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 19 09:23:36.070409 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 19 09:23:36.081175 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 19 09:23:36.098340 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Oct 19 09:23:36.108000 audit: BPF prog-id=20 op=LOAD Oct 19 09:23:36.108000 audit: BPF prog-id=21 op=LOAD Oct 19 09:23:36.108000 audit: BPF prog-id=22 op=LOAD Oct 19 09:23:36.111249 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 19 09:23:36.116667 systemd-tmpfiles[1104]: ACLs are not supported, ignoring. Oct 19 09:23:36.118228 systemd-tmpfiles[1104]: ACLs are not supported, ignoring. Oct 19 09:23:36.129319 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 19 09:23:36.138000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:36.139715 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 19 09:23:36.150528 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Oct 19 09:23:36.156374 kernel: tun: Universal TUN/TAP device driver, 1.6 Oct 19 09:23:36.158525 systemd[1]: modprobe@tun.service: Deactivated successfully. Oct 19 09:23:36.159016 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Oct 19 09:23:36.167000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:36.167000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:36.168694 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1106 ((systemd-userd)) Oct 19 09:23:36.169000 audit: BPF prog-id=23 op=LOAD Oct 19 09:23:36.170000 audit: BPF prog-id=24 op=LOAD Oct 19 09:23:36.170000 audit: BPF prog-id=25 op=LOAD Oct 19 09:23:36.174918 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Oct 19 09:23:36.472634 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Oct 19 09:23:36.483297 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Oct 19 09:23:36.483363 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 19 09:23:36.492338 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Oct 19 09:23:36.502761 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 19 09:23:36.515054 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 19 09:23:36.527432 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Oct 19 09:23:36.539699 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 19 09:23:36.554385 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Oct 19 09:23:36.567442 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Oct 19 09:23:36.588138 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Oct 19 09:23:36.594622 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 19 09:23:36.597224 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 19 09:23:36.606000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:36.608224 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Oct 19 09:23:36.617000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdb-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:36.639192 kernel: loop4: detected capacity change from 0 to 44505 Oct 19 09:23:36.652175 kernel: loop4: p1 p2 p3 Oct 19 09:23:36.669126 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 19 09:23:36.677000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdbd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:36.686818 systemd-nsresourced[1110]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Oct 19 09:23:36.699973 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:36.700089 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:36.709013 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Oct 19 09:23:36.718265 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:36.718369 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:36.718309 systemd-confext[1117]: device-mapper: reload ioctl on loop4p1-51-verity (254:5) failed: Invalid argument Oct 19 09:23:36.733000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-nsresourced comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:36.734635 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:36.840562 systemd-oomd[1102]: No swap; memory pressure usage will be degraded Oct 19 09:23:36.843933 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Oct 19 09:23:36.848873 systemd-resolved[1103]: Positive Trust Anchors: Oct 19 09:23:36.849469 systemd-resolved[1103]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 19 09:23:36.849588 systemd-resolved[1103]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 19 09:23:36.849728 systemd-resolved[1103]: 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 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 19 09:23:36.853000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-oomd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:36.864078 systemd-resolved[1103]: Defaulting to hostname 'linux'. Oct 19 09:23:36.866185 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 19 09:23:36.875000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:36.876806 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 19 09:23:36.886000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:36.888410 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 19 09:23:36.897000 audit: BPF prog-id=7 op=UNLOAD Oct 19 09:23:36.897000 audit: BPF prog-id=6 op=UNLOAD Oct 19 09:23:36.898000 audit: BPF prog-id=26 op=LOAD Oct 19 09:23:36.898000 audit: BPF prog-id=27 op=LOAD Oct 19 09:23:36.900449 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 19 09:23:36.961923 systemd-udevd[1139]: Using default interface naming scheme 'v261'. Oct 19 09:23:37.033808 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 19 09:23:37.043000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:37.045000 audit: BPF prog-id=28 op=LOAD Oct 19 09:23:37.050332 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 19 09:23:37.129146 systemd[1]: modprobe@fuse.service - Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse Oct 19 09:23:37.225525 systemd[1]: Condition check resulted in dev-tpmrm0.device - /dev/tpmrm0 being skipped. Oct 19 09:23:37.225595 systemd[1]: Expecting device dev-tpm0.device - /dev/tpm0... Oct 19 09:23:37.245663 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 19 09:23:37.269655 systemd-networkd[1141]: lo: Link UP Oct 19 09:23:37.269671 systemd-networkd[1141]: lo: Gained carrier Oct 19 09:23:37.273675 systemd[1]: Started systemd-networkd.service - Network Management. Oct 19 09:23:37.282000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:37.291786 systemd[1]: Reached target network.target - Network. Oct 19 09:23:37.302649 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 19 09:23:37.317270 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Oct 19 09:23:37.393243 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 19 09:23:37.395263 systemd-networkd[1141]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 19 09:23:37.395937 systemd-networkd[1141]: eth0: Link UP Oct 19 09:23:37.396456 systemd-networkd[1141]: eth0: Gained carrier Oct 19 09:23:37.402000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-persistent-storage comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:37.405605 systemd-networkd[1141]: eth0: Overlong DHCP hostname received, shortened from 'ci-9999-9-9-enable-nvidia-580-1-a631ab9e93aa77f8eac5.c.flatcar-212911.internal' to 'ci-9999-9-9-enable-nvidia-580-1-a631ab9e93aa77f8eac5' Oct 19 09:23:37.405628 systemd-networkd[1141]: eth0: DHCPv4 address 10.128.0.92/32, gateway 10.128.0.1 acquired from 169.254.169.254 Oct 19 09:23:37.454188 kernel: mousedev: PS/2 mouse device common for all mice Oct 19 09:23:37.478288 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Oct 19 09:23:37.487205 kernel: ACPI: button: Power Button [PWRF] Oct 19 09:23:37.505191 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input4 Oct 19 09:23:37.557236 kernel: piix4_smbus 0000:00:01.3: SMBus base address uninitialized - upgrade BIOS or use force_addr=0xaddr Oct 19 09:23:37.580422 systemd[1]: Condition check resulted in dev-tpm0.device - /dev/tpm0 being skipped. Oct 19 09:23:37.581936 systemd[1]: Reached target tpm2.target - Trusted Platform Module. Oct 19 09:23:37.710194 kernel: ACPI: button: Sleep Button [SLPF] Oct 19 09:23:37.738197 kernel: EDAC MC: Ver: 3.0.0 Oct 19 09:23:37.759858 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - PersistentDisk OEM. Oct 19 09:23:37.805309 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 19 09:23:37.828553 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 09:23:37.885587 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 19 09:23:37.895000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-OEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:37.945680 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Oct 19 09:23:37.984192 kernel: loop4: detected capacity change from 0 to 44505 Oct 19 09:23:37.994940 kernel: loop4: p1 p2 p3 Oct 19 09:23:37.997208 systemd-vconsole-setup[1206]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 19 09:23:38.000850 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 09:23:38.018564 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.018688 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:38.028634 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:38.036044 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:38.039000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:38.044235 (sd-merge)[1214]: device-mapper: reload ioctl on loop4p1-56-verity (254:5) failed: Invalid argument Oct 19 09:23:38.055772 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.090280 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Oct 19 09:23:38.091049 (sd-merge)[1214]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 19 09:23:38.094191 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Oct 19 09:23:38.103000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-confext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:38.112292 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 19 09:23:38.137190 kernel: loop4: detected capacity change from 0 to 169080 Oct 19 09:23:38.146249 kernel: loop4: p1 p2 p3 Oct 19 09:23:38.162191 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.162310 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:38.178808 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:38.179283 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:38.185244 systemd-sysext[1223]: device-mapper: reload ioctl on loop4p1-60-verity (254:5) failed: Invalid argument Oct 19 09:23:38.196200 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.238195 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 09:23:38.267202 kernel: loop4: detected capacity change from 0 to 158128 Oct 19 09:23:38.278607 kernel: loop4: p1 p2 p3 Oct 19 09:23:38.297322 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.297457 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:38.297493 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:38.312439 systemd-sysext[1223]: device-mapper: reload ioctl on loop4p1-65-verity (254:5) failed: Invalid argument Oct 19 09:23:38.313196 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:38.322185 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.367266 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 09:23:38.396193 kernel: loop4: detected capacity change from 0 to 431832 Oct 19 09:23:38.406175 kernel: loop4: p1 p2 p3 Oct 19 09:23:38.429874 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.430037 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:38.430090 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:38.444701 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:38.444779 systemd-sysext[1223]: device-mapper: reload ioctl on loop4p1-70-verity (254:5) failed: Invalid argument Oct 19 09:23:38.452195 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.502285 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 09:23:38.535198 kernel: loop4: detected capacity change from 0 to 169080 Oct 19 09:23:38.548176 kernel: loop4: p1 p2 p3 Oct 19 09:23:38.567890 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.568012 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:38.577476 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:38.588032 (sd-merge)[1248]: device-mapper: reload ioctl on loop4p1-75-verity (254:5) failed: Invalid argument Oct 19 09:23:38.588640 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:38.602242 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.639239 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 09:23:38.647826 kernel: loop5: detected capacity change from 0 to 158128 Oct 19 09:23:38.657190 kernel: loop5: p1 p2 p3 Oct 19 09:23:38.676256 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.676374 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:38.685263 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:38.691409 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:38.691541 (sd-merge)[1248]: device-mapper: reload ioctl on loop5p1-79-verity (254:6) failed: Invalid argument Oct 19 09:23:38.699303 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.699380 systemd-networkd[1141]: eth0: Gained IPv6LL Oct 19 09:23:38.704532 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Oct 19 09:23:38.714000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:38.718994 systemd[1]: Reached target network-online.target - Network is Online. Oct 19 09:23:38.754182 kernel: erofs (device dm-6): mounted with root inode @ nid 39. Oct 19 09:23:38.763202 kernel: loop6: detected capacity change from 0 to 431832 Oct 19 09:23:38.773179 kernel: loop6: p1 p2 p3 Oct 19 09:23:38.793730 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.793848 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:23:38.802854 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:23:38.802986 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:23:38.808952 (sd-merge)[1248]: device-mapper: reload ioctl on loop6p1-83-verity (254:7) failed: Invalid argument Oct 19 09:23:38.817255 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:23:38.860215 kernel: erofs (device dm-7): mounted with root inode @ nid 39. Oct 19 09:23:38.862788 (sd-merge)[1248]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 19 09:23:38.865457 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 19 09:23:38.874000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:38.881296 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 19 09:23:38.927529 systemd-tmpfiles[1273]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 19 09:23:38.928045 systemd-tmpfiles[1273]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 19 09:23:38.928409 systemd-tmpfiles[1273]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 19 09:23:38.930614 systemd-tmpfiles[1273]: ACLs are not supported, ignoring. Oct 19 09:23:38.930796 systemd-tmpfiles[1273]: ACLs are not supported, ignoring. Oct 19 09:23:38.936944 systemd-tmpfiles[1273]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 19 09:23:38.937090 systemd-tmpfiles[1273]: Skipping /boot Oct 19 09:23:38.946988 systemd-tmpfiles[1273]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 19 09:23:38.947175 systemd-tmpfiles[1273]: Skipping /boot Oct 19 09:23:38.966578 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 19 09:23:38.976000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:38.981589 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 19 09:23:38.995745 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 19 09:23:39.009316 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 19 09:23:39.023413 systemd[1]: Starting oem-gce-enable-oslogin.service - Enable GCE OS Login... Oct 19 09:23:39.036382 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 19 09:23:39.049293 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 19 09:23:39.102000 audit[1289]: AUDIT1127 pid=1289 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' Oct 19 09:23:39.123483 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 19 09:23:39.133000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:39.154339 systemd[1]: Finished oem-gce-enable-oslogin.service - Enable GCE OS Login. Oct 19 09:23:39.155000 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 19 09:23:39.155000 audit[1312]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffe337da0e0 a2=420 a3=0 items=0 ppid=1276 pid=1312 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 19 09:23:39.155000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 19 09:23:39.158269 augenrules[1312]: No rules Oct 19 09:23:39.166039 systemd[1]: audit-rules.service: Deactivated successfully. Oct 19 09:23:39.166639 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 19 09:23:39.176027 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 19 09:23:39.186989 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 19 09:23:39.200080 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt skipped, unmet condition check ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt Oct 19 09:23:39.814746 ldconfig[1278]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 19 09:23:39.821326 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 19 09:23:39.832112 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 19 09:23:39.854276 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 19 09:23:39.863569 systemd[1]: Reached target sysinit.target - System Initialization. Oct 19 09:23:39.872407 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 19 09:23:39.882360 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 19 09:23:39.892284 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Oct 19 09:23:39.902531 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 19 09:23:39.911557 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 19 09:23:39.921469 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Oct 19 09:23:39.931613 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Oct 19 09:23:39.940330 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 19 09:23:39.950313 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Oct 19 09:23:39.950382 systemd[1]: Reached target paths.target - Path Units. Oct 19 09:23:39.958308 systemd[1]: Reached target timers.target - Timer Units. Oct 19 09:23:39.967984 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 19 09:23:39.978980 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 19 09:23:39.990256 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 19 09:23:40.008057 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 19 09:23:40.018389 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Oct 19 09:23:40.028711 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 19 09:23:40.040172 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 19 09:23:40.050491 systemd[1]: Reached target sockets.target - Socket Units. Oct 19 09:23:40.059301 systemd[1]: Reached target basic.target - Basic System. Oct 19 09:23:40.068368 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Oct 19 09:23:40.068421 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Oct 19 09:23:40.069953 systemd[1]: Starting containerd.service - containerd container runtime... Oct 19 09:23:40.084575 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 19 09:23:40.092446 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 19 09:23:40.104774 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 19 09:23:40.118308 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 19 09:23:40.125653 jq[1328]: false Oct 19 09:23:40.127317 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Oct 19 09:23:40.131319 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Oct 19 09:23:40.141127 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 19 09:23:40.149639 extend-filesystems[1329]: Found /dev/sda6 Oct 19 09:23:40.153757 systemd[1]: Started ntpd.service - Network Time Service. Oct 19 09:23:40.157295 oslogin_cache_refresh[1330]: Refreshing passwd entry cache Oct 19 09:23:40.159012 google_oslogin_nss_cache[1330]: oslogin_cache_refresh[1330]: Refreshing passwd entry cache Oct 19 09:23:40.162206 extend-filesystems[1329]: Found /dev/sda9 Oct 19 09:23:40.176835 extend-filesystems[1329]: Checking size of /dev/sda9 Oct 19 09:23:40.171651 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 19 09:23:40.194864 motdgen[1348]: /oem/oem-release: line 2: Compute: command not found Oct 19 09:23:40.185214 oslogin_cache_refresh[1330]: Failure getting users, quitting Oct 19 09:23:40.195109 google_oslogin_nss_cache[1330]: oslogin_cache_refresh[1330]: Failure getting users, quitting Oct 19 09:23:40.195109 google_oslogin_nss_cache[1330]: oslogin_cache_refresh[1330]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Oct 19 09:23:40.195109 google_oslogin_nss_cache[1330]: oslogin_cache_refresh[1330]: Refreshing group entry cache Oct 19 09:23:40.190662 systemd[1]: Starting oem-gce.service - GCE Linux Agent... Oct 19 09:23:40.185242 oslogin_cache_refresh[1330]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Oct 19 09:23:40.185321 oslogin_cache_refresh[1330]: Refreshing group entry cache Oct 19 09:23:40.197188 extend-filesystems[1329]: Resized partition /dev/sda9 Oct 19 09:23:40.207357 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 19 09:23:40.219722 google_oslogin_nss_cache[1330]: oslogin_cache_refresh[1330]: Failure getting groups, quitting Oct 19 09:23:40.219714 oslogin_cache_refresh[1330]: Failure getting groups, quitting Oct 19 09:23:40.219934 google_oslogin_nss_cache[1330]: oslogin_cache_refresh[1330]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Oct 19 09:23:40.219753 oslogin_cache_refresh[1330]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Oct 19 09:23:40.231362 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 19 09:23:40.248595 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 19 09:23:40.258315 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionSecurity=!tpm2 Oct 19 09:23:40.262218 systemd[1]: Starting update-engine.service - Update Engine... Oct 19 09:23:40.267233 ntpd[1336]: ntpd 4.2.8p18@1.4062-o Mon Oct 19 06:55:58 UTC 2026 (1): Starting Oct 19 09:23:40.273781 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: ntpd 4.2.8p18@1.4062-o Mon Oct 19 06:55:58 UTC 2026 (1): Starting Oct 19 09:23:40.273781 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 19 09:23:40.273781 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: ---------------------------------------------------- Oct 19 09:23:40.273781 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: ntp-4 is maintained by Network Time Foundation, Oct 19 09:23:40.273781 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 19 09:23:40.273781 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: corporation. Support and training for ntp-4 are Oct 19 09:23:40.273781 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: available at https://www.nwtime.org/support Oct 19 09:23:40.273781 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: ---------------------------------------------------- Oct 19 09:23:40.273123 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 19 09:23:40.267332 ntpd[1336]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 19 09:23:40.267349 ntpd[1336]: ---------------------------------------------------- Oct 19 09:23:40.267363 ntpd[1336]: ntp-4 is maintained by Network Time Foundation, Oct 19 09:23:40.267378 ntpd[1336]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 19 09:23:40.267391 ntpd[1336]: corporation. Support and training for ntp-4 are Oct 19 09:23:40.267406 ntpd[1336]: available at https://www.nwtime.org/support Oct 19 09:23:40.267422 ntpd[1336]: ---------------------------------------------------- Oct 19 09:23:40.285347 ntpd[1336]: proto: precision = 0.104 usec (-23) Oct 19 09:23:40.290639 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: proto: precision = 0.104 usec (-23) Oct 19 09:23:40.290639 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: basedate set to 2026-10-07 Oct 19 09:23:40.290639 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: gps base set to 2026-10-11 (week 2440) Oct 19 09:23:40.290639 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: Listen and drop on 0 v6wildcard [::]:123 Oct 19 09:23:40.290639 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 19 09:23:40.290639 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: Listen normally on 2 lo 127.0.0.1:123 Oct 19 09:23:40.290639 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: Listen normally on 3 eth0 10.128.0.92:123 Oct 19 09:23:40.290639 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: Listen normally on 4 lo [::1]:123 Oct 19 09:23:40.290639 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: Listen normally on 5 eth0 [fe80::4001:aff:fe80:5c%2]:123 Oct 19 09:23:40.290639 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: Listening on routing socket on fd #22 for interface updates Oct 19 09:23:40.285693 ntpd[1336]: basedate set to 2026-10-07 Oct 19 09:23:40.285712 ntpd[1336]: gps base set to 2026-10-11 (week 2440) Oct 19 09:23:40.285895 ntpd[1336]: Listen and drop on 0 v6wildcard [::]:123 Oct 19 09:23:40.285935 ntpd[1336]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 19 09:23:40.286187 ntpd[1336]: Listen normally on 2 lo 127.0.0.1:123 Oct 19 09:23:40.286227 ntpd[1336]: Listen normally on 3 eth0 10.128.0.92:123 Oct 19 09:23:40.286272 ntpd[1336]: Listen normally on 4 lo [::1]:123 Oct 19 09:23:40.286312 ntpd[1336]: Listen normally on 5 eth0 [fe80::4001:aff:fe80:5c%2]:123 Oct 19 09:23:40.286349 ntpd[1336]: Listening on routing socket on fd #22 for interface updates Oct 19 09:23:40.297383 init.sh[1345]: + '[' -e /etc/default/instance_configs.cfg.template ']' Oct 19 09:23:40.297383 init.sh[1345]: + echo -e '[InstanceSetup]\nset_host_keys = false' Oct 19 09:23:40.297383 init.sh[1345]: + /usr/bin/google_instance_setup Oct 19 09:23:40.294833 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 19 09:23:40.295302 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 19 09:23:40.304399 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 09:23:40.304399 ntpd[1336]: 19 Oct 09:23:40 ntpd[1336]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 09:23:40.304014 ntpd[1336]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 09:23:40.295784 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Oct 19 09:23:40.304054 ntpd[1336]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 09:23:40.297255 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Oct 19 09:23:40.306738 systemd[1]: motdgen.service: Deactivated successfully. Oct 19 09:23:40.308088 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 19 09:23:40.317954 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 19 09:23:40.321628 jq[1364]: true Oct 19 09:23:40.319635 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 19 09:23:40.356774 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 19 09:23:40.399909 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 19 09:23:40.421968 update_engine[1361]: I20261019 09:23:40.421537 1361 main.cc:92] Flatcar Update Engine starting Oct 19 09:23:40.466959 jq[1373]: true Oct 19 09:23:40.530989 kernel: BTRFS info (device sda9): resizing devid 1 Oct 19 09:23:40.586297 kernel: BTRFS info (device sda9): resize device /dev/sda9 (devid 1) from 6627000320 to 10666094592 Oct 19 09:23:40.662277 extend-filesystems[1392]: Resize device id 1 (/dev/sda9) from 6.17GiB to max Oct 19 09:23:40.671353 extend-filesystems[1329]: Resized filesystem in /dev/sda9 Oct 19 09:23:40.665398 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 19 09:23:40.665838 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 19 09:23:40.696234 bash[1406]: Updated "/home/core/.ssh/authorized_keys" Oct 19 09:23:40.700773 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 19 09:23:40.718064 systemd[1]: Starting sshkeys.service... Oct 19 09:23:40.766646 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Oct 19 09:23:40.773052 systemd-logind[1360]: Watching system buttons on /dev/input/event2 (Power Button) Oct 19 09:23:40.773096 systemd-logind[1360]: Watching system buttons on /dev/input/event3 (Sleep Button) Oct 19 09:23:40.773146 systemd-logind[1360]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Oct 19 09:23:40.778577 systemd-logind[1360]: New seat seat0. Oct 19 09:23:40.787676 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Oct 19 09:23:40.798790 systemd[1]: Started systemd-logind.service - User Login Management. Oct 19 09:23:40.945976 dbus-daemon[1327]: [system] SELinux support is enabled Oct 19 09:23:40.946365 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 19 09:23:40.956004 systemd[1]: system-cloudinit@usr-share-coreos-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/coreos/cloud-config.yml skipped, unmet condition check ConditionFileNotEmpty=/usr/share/coreos/cloud-config.yml Oct 19 09:23:40.958045 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 19 09:23:40.968465 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline skipped, unmet condition check ConditionKernelCommandLine=cloud-config-url Oct 19 09:23:40.968693 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 19 09:23:41.002984 dbus-daemon[1327]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1141 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Oct 19 09:23:41.070739 systemd[1]: Started update-engine.service - Update Engine. Oct 19 09:23:41.074811 dbus-daemon[1327]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 19 09:23:41.075492 update_engine[1361]: I20261019 09:23:41.071048 1361 update_check_scheduler.cc:74] Next update check in 3m23s Oct 19 09:23:41.096291 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Oct 19 09:23:41.115640 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 19 09:23:41.160186 coreos-metadata[1415]: Oct 19 09:23:41.159 INFO Fetching http://169.254.169.254/computeMetadata/v1/instance/attributes/sshKeys: Attempt #1 Oct 19 09:23:41.170749 coreos-metadata[1415]: Oct 19 09:23:41.170 INFO Fetch failed with 404: resource not found Oct 19 09:23:41.170749 coreos-metadata[1415]: Oct 19 09:23:41.170 INFO Fetching http://169.254.169.254/computeMetadata/v1/instance/attributes/ssh-keys: Attempt #1 Oct 19 09:23:41.174562 coreos-metadata[1415]: Oct 19 09:23:41.173 INFO Fetch successful Oct 19 09:23:41.174562 coreos-metadata[1415]: Oct 19 09:23:41.174 INFO Fetching http://169.254.169.254/computeMetadata/v1/instance/attributes/block-project-ssh-keys: Attempt #1 Oct 19 09:23:41.178616 coreos-metadata[1415]: Oct 19 09:23:41.178 INFO Fetch failed with 404: resource not found Oct 19 09:23:41.178616 coreos-metadata[1415]: Oct 19 09:23:41.178 INFO Fetching http://169.254.169.254/computeMetadata/v1/project/attributes/sshKeys: Attempt #1 Oct 19 09:23:41.180435 coreos-metadata[1415]: Oct 19 09:23:41.180 INFO Fetch failed with 404: resource not found Oct 19 09:23:41.180435 coreos-metadata[1415]: Oct 19 09:23:41.180 INFO Fetching http://169.254.169.254/computeMetadata/v1/project/attributes/ssh-keys: Attempt #1 Oct 19 09:23:41.185066 coreos-metadata[1415]: Oct 19 09:23:41.182 INFO Fetch successful Oct 19 09:23:41.213342 unknown[1415]: wrote ssh authorized keys file for user: core Oct 19 09:23:41.311824 containerd[1375]: time="2026-10-19T09:23:41Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Oct 19 09:23:41.311824 containerd[1375]: time="2026-10-19T09:23:41Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="30.104µs" Oct 19 09:23:41.313671 containerd[1375]: time="2026-10-19T09:23:41.313367321Z" level=info msg="starting containerd" revision=1294c24a7da8e5a793ed378161673abe94118892 version=v2.3.5 Oct 19 09:23:41.324183 containerd[1375]: time="2026-10-19T09:23:41.320362615Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 19 09:23:41.324183 containerd[1375]: time="2026-10-19T09:23:41.320879902Z" level=warning msg="failed check for fsverity support" error="enable fsverity failed: operation not supported" path=/var/lib/containerd/io.containerd.content.v1.content Oct 19 09:23:41.324183 containerd[1375]: time="2026-10-19T09:23:41.320911726Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 19 09:23:41.324183 containerd[1375]: time="2026-10-19T09:23:41.320944135Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 19 09:23:41.324183 containerd[1375]: time="2026-10-19T09:23:41.321100170Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 19 09:23:41.324183 containerd[1375]: time="2026-10-19T09:23:41.321119620Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 19 09:23:41.324183 containerd[1375]: time="2026-10-19T09:23:41.322487420Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Oct 19 09:23:41.324183 containerd[1375]: time="2026-10-19T09:23:41.322522903Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 19 09:23:41.324183 containerd[1375]: time="2026-10-19T09:23:41.322635233Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 19 09:23:41.324183 containerd[1375]: time="2026-10-19T09:23:41.322656767Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 19 09:23:41.327324 containerd[1375]: time="2026-10-19T09:23:41.325246671Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 19 09:23:41.327324 containerd[1375]: time="2026-10-19T09:23:41.325288029Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 19 09:23:41.327324 containerd[1375]: time="2026-10-19T09:23:41.325305172Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 19 09:23:41.327324 containerd[1375]: time="2026-10-19T09:23:41.325680285Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 19 09:23:41.327324 containerd[1375]: time="2026-10-19T09:23:41.325756259Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 19 09:23:41.327324 containerd[1375]: time="2026-10-19T09:23:41.326034965Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 19 09:23:41.327324 containerd[1375]: time="2026-10-19T09:23:41.326086989Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 19 09:23:41.327324 containerd[1375]: time="2026-10-19T09:23:41.326105807Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 19 09:23:41.329652 containerd[1375]: time="2026-10-19T09:23:41.328089545Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 19 09:23:41.333124 containerd[1375]: time="2026-10-19T09:23:41.330218193Z" level=info msg="metadata content store policy set" policy=shared Oct 19 09:23:41.352728 update-ssh-keys[1433]: Updated "/home/core/.ssh/authorized_keys" Oct 19 09:23:41.353566 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Oct 19 09:23:41.355290 containerd[1375]: time="2026-10-19T09:23:41.354842637Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 19 09:23:41.355290 containerd[1375]: time="2026-10-19T09:23:41.354932275Z" level=info msg="loading plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Oct 19 09:23:41.355290 containerd[1375]: time="2026-10-19T09:23:41.354958284Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Oct 19 09:23:41.355290 containerd[1375]: time="2026-10-19T09:23:41.354972613Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 19 09:23:41.355290 containerd[1375]: time="2026-10-19T09:23:41.354991963Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 19 09:23:41.355290 containerd[1375]: time="2026-10-19T09:23:41.355005952Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 19 09:23:41.355290 containerd[1375]: time="2026-10-19T09:23:41.355023064Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 19 09:23:41.355290 containerd[1375]: time="2026-10-19T09:23:41.355036224Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 19 09:23:41.355685 containerd[1375]: time="2026-10-19T09:23:41.355394986Z" level=info msg="built-in NRI default validator is disabled" Oct 19 09:23:41.355685 containerd[1375]: time="2026-10-19T09:23:41.355417290Z" level=info msg="runtime interface created" Oct 19 09:23:41.355685 containerd[1375]: time="2026-10-19T09:23:41.355425950Z" level=info msg="created NRI interface" Oct 19 09:23:41.355685 containerd[1375]: time="2026-10-19T09:23:41.355442864Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 19 09:23:41.355685 containerd[1375]: time="2026-10-19T09:23:41.355464606Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 19 09:23:41.355685 containerd[1375]: time="2026-10-19T09:23:41.355501915Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 19 09:23:41.355685 containerd[1375]: time="2026-10-19T09:23:41.355519879Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 19 09:23:41.371119 systemd[1]: Finished sshkeys.service. Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.375461451Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.375903717Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.375940190Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.375960797Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.376002522Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.376019798Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.376034971Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.376106370Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.376133918Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.376286204Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.376313111Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.376331086Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.376346197Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 19 09:23:41.376643 containerd[1375]: time="2026-10-19T09:23:41.376361044Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 19 09:23:41.377368 containerd[1375]: time="2026-10-19T09:23:41.376375942Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 19 09:23:41.377368 containerd[1375]: time="2026-10-19T09:23:41.376392173Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 19 09:23:41.377368 containerd[1375]: time="2026-10-19T09:23:41.376408720Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 19 09:23:41.377368 containerd[1375]: time="2026-10-19T09:23:41.376425443Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 19 09:23:41.377368 containerd[1375]: time="2026-10-19T09:23:41.376441030Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Oct 19 09:23:41.377368 containerd[1375]: time="2026-10-19T09:23:41.376454892Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 19 09:23:41.377368 containerd[1375]: time="2026-10-19T09:23:41.376473084Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 19 09:23:41.377368 containerd[1375]: time="2026-10-19T09:23:41.376487177Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 19 09:23:41.377368 containerd[1375]: time="2026-10-19T09:23:41.376546338Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 19 09:23:41.392463 containerd[1375]: time="2026-10-19T09:23:41.389887492Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 19 09:23:41.392579 containerd[1375]: time="2026-10-19T09:23:41.392494483Z" level=info msg="Start snapshots syncer" Oct 19 09:23:41.396425 containerd[1375]: time="2026-10-19T09:23:41.396277502Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 19 09:23:41.400176 containerd[1375]: time="2026-10-19T09:23:41.398510732Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"statsCollectPeriod\":\"\",\"statsRetentionPeriod\":\"\",\"enableCRIU\":true,\"enableExperimentalRestoreViaCreate\":false,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Oct 19 09:23:41.400432 containerd[1375]: time="2026-10-19T09:23:41.398623491Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 19 09:23:41.405542 containerd[1375]: time="2026-10-19T09:23:41.405497195Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406530423Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406577245Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406595491Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406615173Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406632469Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406650222Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406675420Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406694625Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406708032Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406722205Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406752802Z" level=info msg="Connect containerd service" Oct 19 09:23:41.407726 containerd[1375]: time="2026-10-19T09:23:41.406794060Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 19 09:23:41.433176 containerd[1375]: time="2026-10-19T09:23:41.431457185Z" level=warning msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Oct 19 09:23:41.555142 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Oct 19 09:23:41.556493 dbus-daemon[1327]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 19 09:23:41.557562 dbus-daemon[1327]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1426 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Oct 19 09:23:41.611656 systemd[1]: Starting polkit.service - Authorization Manager... Oct 19 09:23:41.699556 locksmithd[1427]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 19 09:23:41.867818 containerd[1375]: time="2026-10-19T09:23:41.867691674Z" level=info msg="loading plugin" id=io.containerd.server.v1.ttrpc type=io.containerd.server.v1 Oct 19 09:23:41.867949 containerd[1375]: time="2026-10-19T09:23:41.867834515Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 19 09:23:41.867949 containerd[1375]: time="2026-10-19T09:23:41.867888757Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-prometheus type=io.containerd.metrics.v1 Oct 19 09:23:41.868076 containerd[1375]: time="2026-10-19T09:23:41.867959077Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-otel type=io.containerd.metrics.v1 Oct 19 09:23:41.868076 containerd[1375]: time="2026-10-19T09:23:41.868000444Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc type=io.containerd.server.v1 Oct 19 09:23:41.869341 containerd[1375]: time="2026-10-19T09:23:41.869278130Z" level=info msg="Start subscribing containerd event" Oct 19 09:23:41.869465 containerd[1375]: time="2026-10-19T09:23:41.869361327Z" level=info msg="Start stats collector" Oct 19 09:23:41.869465 containerd[1375]: time="2026-10-19T09:23:41.869375260Z" level=info msg="Start recovering state" Oct 19 09:23:41.869565 containerd[1375]: time="2026-10-19T09:23:41.869501283Z" level=info msg="Start event monitor" Oct 19 09:23:41.869565 containerd[1375]: time="2026-10-19T09:23:41.869532704Z" level=info msg="Start cni network conf syncer for default" Oct 19 09:23:41.869565 containerd[1375]: time="2026-10-19T09:23:41.869544781Z" level=info msg="Start streaming server" Oct 19 09:23:41.869565 containerd[1375]: time="2026-10-19T09:23:41.869557699Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 19 09:23:41.869710 containerd[1375]: time="2026-10-19T09:23:41.869571028Z" level=info msg="runtime interface starting up..." Oct 19 09:23:41.869710 containerd[1375]: time="2026-10-19T09:23:41.869581526Z" level=info msg="starting plugins..." Oct 19 09:23:41.869710 containerd[1375]: time="2026-10-19T09:23:41.869601427Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 19 09:23:41.912185 containerd[1375]: time="2026-10-19T09:23:41.909820588Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Oct 19 09:23:41.912185 containerd[1375]: time="2026-10-19T09:23:41.909886151Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Oct 19 09:23:41.912185 containerd[1375]: time="2026-10-19T09:23:41.909921409Z" level=info msg="loading plugin" id=io.containerd.http.v1.pprof type=io.containerd.http.v1 Oct 19 09:23:41.912185 containerd[1375]: time="2026-10-19T09:23:41.910005531Z" level=info msg="loading plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Oct 19 09:23:41.912185 containerd[1375]: time="2026-10-19T09:23:41.910024236Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Oct 19 09:23:41.912185 containerd[1375]: time="2026-10-19T09:23:41.910220370Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 19 09:23:41.912185 containerd[1375]: time="2026-10-19T09:23:41.910255299Z" level=info msg="starting GRPC server" address=/run/containerd/containerd.sock gid=0 uid=0 Oct 19 09:23:41.912185 containerd[1375]: time="2026-10-19T09:23:41.910389688Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 19 09:23:41.912185 containerd[1375]: time="2026-10-19T09:23:41.911004138Z" level=info msg="containerd successfully booted in 0.621259s" Oct 19 09:23:41.910829 systemd[1]: Started containerd.service - containerd container runtime. Oct 19 09:23:41.927377 polkitd[1452]: Started polkitd version 126 Oct 19 09:23:41.944419 polkitd[1452]: Loading rules from directory /etc/polkit-1/rules.d Oct 19 09:23:41.945252 polkitd[1452]: Loading rules from directory /run/polkit-1/rules.d Oct 19 09:23:41.945380 polkitd[1452]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Oct 19 09:23:41.945480 polkitd[1452]: Loading rules from directory /usr/local/share/polkit-1/rules.d Oct 19 09:23:41.945559 polkitd[1452]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Oct 19 09:23:41.947220 polkitd[1452]: Loading rules from directory /usr/share/polkit-1/rules.d Oct 19 09:23:41.950410 polkitd[1452]: Finished loading, compiling and executing 5 rules Oct 19 09:23:41.950899 systemd[1]: Started polkit.service - Authorization Manager. Oct 19 09:23:41.951688 dbus-daemon[1327]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 19 09:23:41.952348 polkitd[1452]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Oct 19 09:23:41.986623 systemd-hostnamed[1426]: Hostname set to (transient) Oct 19 09:23:41.988291 systemd-resolved[1103]: System hostname changed to 'ci-9999-9-9-enable-nvidia-580-1-a631ab9e93aa77f8eac5'. Oct 19 09:23:42.154840 instance-setup[1368]: INFO Running google_set_multiqueue. Oct 19 09:23:42.166382 instance-setup[1368]: INFO Machine type: projects/558272734166/machineTypes/n1-standard-2 Oct 19 09:23:42.173377 instance-setup[1368]: INFO Interface: 0/ Oct 19 09:23:42.185920 instance-setup[1368]: INFO physical-nic-id NOT found in interface 0/ Oct 19 09:23:42.220258 instance-setup[1368]: INFO Setting /proc/irq/31/smp_affinity_list to 0 for device virtio1. Oct 19 09:23:42.222431 instance-setup[1368]: INFO /proc/irq/31/smp_affinity_list: real affinity 0 Oct 19 09:23:42.223032 instance-setup[1368]: INFO Setting /proc/irq/32/smp_affinity_list to 0 for device virtio1. Oct 19 09:23:42.225273 instance-setup[1368]: INFO /proc/irq/32/smp_affinity_list: real affinity 0 Oct 19 09:23:42.225546 instance-setup[1368]: INFO Setting /proc/irq/33/smp_affinity_list to 1 for device virtio1. Oct 19 09:23:42.227491 instance-setup[1368]: INFO /proc/irq/33/smp_affinity_list: real affinity 1 Oct 19 09:23:42.228023 instance-setup[1368]: INFO Setting /proc/irq/34/smp_affinity_list to 1 for device virtio1. Oct 19 09:23:42.229977 instance-setup[1368]: INFO /proc/irq/34/smp_affinity_list: real affinity 1 Oct 19 09:23:42.305062 init.sh[1345]: + /usr/bin/google_metadata_script_runner --script-type startup Oct 19 09:23:42.489422 startup-script[1530]: INFO Starting startup scripts. Oct 19 09:23:42.497741 startup-script[1530]: INFO No startup scripts found in metadata. Oct 19 09:23:42.497808 startup-script[1530]: INFO Finished running startup scripts. Oct 19 09:23:42.506437 sshd_keygen[1374]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Oct 19 09:23:42.524056 init.sh[1345]: + trap 'stopping=1 ; kill "${daemon_pids[@]}" || :' SIGTERM Oct 19 09:23:42.524056 init.sh[1345]: + daemon_pids=() Oct 19 09:23:42.524265 init.sh[1345]: + for d in accounts clock_skew network Oct 19 09:23:42.525301 init.sh[1345]: + daemon_pids+=($!) Oct 19 09:23:42.525301 init.sh[1345]: + for d in accounts clock_skew network Oct 19 09:23:42.525301 init.sh[1345]: + daemon_pids+=($!) Oct 19 09:23:42.525301 init.sh[1345]: + for d in accounts clock_skew network Oct 19 09:23:42.525301 init.sh[1345]: + daemon_pids+=($!) Oct 19 09:23:42.525301 init.sh[1345]: + NOTIFY_SOCKET=/run/systemd/notify Oct 19 09:23:42.525301 init.sh[1345]: + /usr/bin/systemd-notify --ready Oct 19 09:23:42.525639 init.sh[1540]: + /usr/bin/google_network_daemon Oct 19 09:23:42.526389 init.sh[1538]: + /usr/bin/google_accounts_daemon Oct 19 09:23:42.528194 init.sh[1539]: + /usr/bin/google_clock_skew_daemon Oct 19 09:23:42.536899 systemd[1]: Started oem-gce.service - GCE Linux Agent. Oct 19 09:23:42.551294 init.sh[1345]: + wait -n 1538 1539 1540 Oct 19 09:23:42.589364 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 19 09:23:42.603347 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 19 09:23:42.614624 systemd[1]: Started sshd@0-1-10.128.0.92:22-20.31.226.197:34306.service - OpenSSH per-connection server daemon (20.31.226.197:34306). Oct 19 09:23:42.635569 systemd[1]: issuegen.service: Deactivated successfully. Oct 19 09:23:42.636421 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 19 09:23:42.650526 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 19 09:23:42.706285 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 19 09:23:42.723655 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 19 09:23:42.734706 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 19 09:23:42.743825 systemd[1]: Reached target getty.target - Login Prompts. Oct 19 09:23:42.753690 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 19 09:23:42.762451 systemd[1]: Startup finished in 2.699s (kernel) + 9.913s (initrd) + 11.232s (userspace) = 23.846s. Oct 19 09:23:42.862075 google-networking[1540]: INFO Starting Google Networking daemon. Oct 19 09:23:42.935946 google-clock-skew[1539]: INFO Starting Google Clock Skew daemon. Oct 19 09:23:42.944534 google-clock-skew[1539]: INFO Clock drift token has changed: 0. Oct 19 09:23:43.011682 groupadd[1567]: group added to /etc/group: name=google-sudoers, GID=1000 Oct 19 09:23:43.014814 groupadd[1567]: group added to /etc/gshadow: name=google-sudoers Oct 19 09:23:43.034420 init.sh[1570]: [sss_cache] [sss_tool_confdb_init] (0x0010): Can't access '/var/lib/sss/db/config.ldb', probably SSSD isn't configured Oct 19 09:23:43.034420 init.sh[1570]: Can't find configuration db, was SSSD configured and run? Oct 19 09:23:43.034882 groupadd[1567]: new group: name=google-sudoers, GID=1000 Oct 19 09:23:43.039690 init.sh[1572]: [sss_cache] [sss_tool_confdb_init] (0x0010): Can't access '/var/lib/sss/db/config.ldb', probably SSSD isn't configured Oct 19 09:23:43.039690 init.sh[1572]: Can't find configuration db, was SSSD configured and run? Oct 19 09:23:43.067097 google-accounts[1538]: INFO Starting Google Accounts daemon. Oct 19 09:23:43.090560 google-accounts[1538]: WARNING OS Login not installed. Oct 19 09:23:43.096314 google-accounts[1538]: INFO Creating a new user account for 0. Oct 19 09:23:43.100404 init.sh[1575]: useradd: invalid user name '0' Oct 19 09:23:43.100961 google-accounts[1538]: WARNING Could not create user 0. Command '['useradd', '-m', '-s', '/bin/bash', '-p', '*', '0']' returned non-zero exit status 19.. Oct 19 09:23:43.306141 sshd[1548]: Accepted publickey for core from 20.31.226.197 port 34306 ssh2: RSA SHA256:srHaBxLjG0SNRqDzWguINIzBbCKihN43Un9NYeFcGbk Oct 19 09:23:43.309111 sshd-session[1548]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:23:43.319812 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 19 09:23:43.321670 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 19 09:23:43.000147 systemd-resolved[1103]: Clock change detected. Flushing caches. Oct 19 09:23:43.015061 systemd-logind[1360]: New session '1' of user 'core' with class 'user' and type 'tty'. Oct 19 09:23:43.027886 systemd-journald[1060]: Time jumped backwards, rotating. Oct 19 09:23:43.001992 google-clock-skew[1539]: INFO Synced system time with hardware clock. Oct 19 09:23:43.040567 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 19 09:23:43.047075 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 19 09:23:43.074772 (systemd)[1582]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:23:43.078944 systemd-logind[1360]: New session '2' of user 'core' with class 'manager-early' and type 'unspecified'. Oct 19 09:23:43.359934 systemd[1582]: Queued start job for default target default.target. Oct 19 09:23:43.366129 systemd[1582]: Created slice app.slice - User Application Slice. Oct 19 09:23:43.366181 systemd[1582]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Oct 19 09:23:43.366213 systemd[1582]: Reached target machines.target - Virtual Machines and Containers. Oct 19 09:23:43.366451 systemd[1582]: Reached target paths.target - Paths. Oct 19 09:23:43.366550 systemd[1582]: Reached target timers.target - Timers. Oct 19 09:23:43.368165 systemd[1582]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 19 09:23:43.371286 systemd[1582]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 19 09:23:43.371596 systemd[1582]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 19 09:23:43.373528 systemd[1582]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 19 09:23:43.373988 systemd[1582]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 19 09:23:43.376169 systemd[1582]: Listening on systemd-storage-fs.socket - Simple File System Backed Storage Provider. Oct 19 09:23:43.384885 systemd[1582]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Oct 19 09:23:43.396506 systemd[1582]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 19 09:23:43.396648 systemd[1582]: Reached target sockets.target - Sockets. Oct 19 09:23:43.405017 systemd[1582]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Oct 19 09:23:43.405295 systemd[1582]: Reached target basic.target - Basic System. Oct 19 09:23:43.405494 systemd[1582]: Reached target default.target - Main User Target. Oct 19 09:23:43.405677 systemd[1582]: Startup finished in 319ms. Oct 19 09:23:43.405837 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 19 09:23:43.410022 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 19 09:23:43.733993 systemd[1]: Started sshd@1-2-10.128.0.92:22-20.31.226.197:42304.service - OpenSSH per-connection server daemon (20.31.226.197:42304). Oct 19 09:23:44.314245 sshd[1597]: Accepted publickey for core from 20.31.226.197 port 42304 ssh2: RSA SHA256:srHaBxLjG0SNRqDzWguINIzBbCKihN43Un9NYeFcGbk Oct 19 09:23:44.316092 sshd-session[1597]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:23:44.324251 systemd-logind[1360]: New session '3' of user 'core' with class 'user' and type 'tty'. Oct 19 09:23:44.329002 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 19 09:23:44.626113 sshd[1601]: Connection closed by 20.31.226.197 port 42304 Oct 19 09:23:44.628346 sshd-session[1597]: pam_unix(sshd:session): session closed for user core Oct 19 09:23:44.632177 systemd[1]: sshd@1-2-10.128.0.92:22-20.31.226.197:42304.service: Deactivated successfully. Oct 19 09:23:44.634629 systemd[1]: session-3.scope: Deactivated successfully. Oct 19 09:23:44.635929 systemd-logind[1360]: Session 3 logged out. Waiting for processes to exit. Oct 19 09:23:44.637963 systemd-logind[1360]: Removed session 3. Oct 19 09:23:44.737071 systemd[1]: Started sshd@2-3-10.128.0.92:22-20.31.226.197:42310.service - OpenSSH per-connection server daemon (20.31.226.197:42310). Oct 19 09:23:45.313499 sshd[1607]: Accepted publickey for core from 20.31.226.197 port 42310 ssh2: RSA SHA256:srHaBxLjG0SNRqDzWguINIzBbCKihN43Un9NYeFcGbk Oct 19 09:23:45.314466 sshd-session[1607]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:23:45.322551 systemd-logind[1360]: New session '4' of user 'core' with class 'user' and type 'tty'. Oct 19 09:23:45.332999 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 19 09:23:45.621039 sshd[1611]: Connection closed by 20.31.226.197 port 42310 Oct 19 09:23:45.622241 sshd-session[1607]: pam_unix(sshd:session): session closed for user core Oct 19 09:23:45.627003 systemd[1]: sshd@2-3-10.128.0.92:22-20.31.226.197:42310.service: Deactivated successfully. Oct 19 09:23:45.629555 systemd[1]: session-4.scope: Deactivated successfully. Oct 19 09:23:45.631521 systemd-logind[1360]: Session 4 logged out. Waiting for processes to exit. Oct 19 09:23:45.633595 systemd-logind[1360]: Removed session 4. Oct 19 09:23:45.736679 systemd[1]: Started sshd@3-4-10.128.0.92:22-20.31.226.197:42324.service - OpenSSH per-connection server daemon (20.31.226.197:42324). Oct 19 09:23:46.330014 sshd[1617]: Accepted publickey for core from 20.31.226.197 port 42324 ssh2: RSA SHA256:srHaBxLjG0SNRqDzWguINIzBbCKihN43Un9NYeFcGbk Oct 19 09:23:46.332037 sshd-session[1617]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:23:46.340483 systemd-logind[1360]: New session '5' of user 'core' with class 'user' and type 'tty'. Oct 19 09:23:46.342133 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 19 09:23:46.650699 sshd[1621]: Connection closed by 20.31.226.197 port 42324 Oct 19 09:23:46.651598 sshd-session[1617]: pam_unix(sshd:session): session closed for user core Oct 19 09:23:46.656456 systemd[1]: sshd@3-4-10.128.0.92:22-20.31.226.197:42324.service: Deactivated successfully. Oct 19 09:23:46.658814 systemd[1]: session-5.scope: Deactivated successfully. Oct 19 09:23:46.660090 systemd-logind[1360]: Session 5 logged out. Waiting for processes to exit. Oct 19 09:23:46.662338 systemd-logind[1360]: Removed session 5. Oct 19 09:23:46.764778 systemd[1]: Started sshd@4-4097-10.128.0.92:22-20.31.226.197:42340.service - OpenSSH per-connection server daemon (20.31.226.197:42340). Oct 19 09:23:47.354428 sshd[1627]: Accepted publickey for core from 20.31.226.197 port 42340 ssh2: RSA SHA256:srHaBxLjG0SNRqDzWguINIzBbCKihN43Un9NYeFcGbk Oct 19 09:23:47.356216 sshd-session[1627]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:23:47.364461 systemd-logind[1360]: New session '6' of user 'core' with class 'user' and type 'tty'. Oct 19 09:23:47.370072 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 19 09:23:47.594558 sudo[1632]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 19 09:23:47.595132 sudo[1632]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 19 09:23:47.608285 sudo[1632]: pam_unix(sudo:session): session closed for user root Oct 19 09:23:47.713501 sshd[1631]: Connection closed by 20.31.226.197 port 42340 Oct 19 09:23:47.715029 sshd-session[1627]: pam_unix(sshd:session): session closed for user core Oct 19 09:23:47.720280 systemd[1]: sshd@4-4097-10.128.0.92:22-20.31.226.197:42340.service: Deactivated successfully. Oct 19 09:23:47.722713 systemd[1]: session-6.scope: Deactivated successfully. Oct 19 09:23:47.724843 systemd-logind[1360]: Session 6 logged out. Waiting for processes to exit. Oct 19 09:23:47.726463 systemd-logind[1360]: Removed session 6. Oct 19 09:23:47.824182 systemd[1]: Started sshd@5-5-10.128.0.92:22-20.31.226.197:42350.service - OpenSSH per-connection server daemon (20.31.226.197:42350). Oct 19 09:23:48.399409 sshd[1639]: Accepted publickey for core from 20.31.226.197 port 42350 ssh2: RSA SHA256:srHaBxLjG0SNRqDzWguINIzBbCKihN43Un9NYeFcGbk Oct 19 09:23:48.401318 sshd-session[1639]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:23:48.409469 systemd-logind[1360]: New session '7' of user 'core' with class 'user' and type 'tty'. Oct 19 09:23:48.414021 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 19 09:23:48.618993 sudo[1645]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 19 09:23:48.619525 sudo[1645]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 19 09:23:48.621831 sudo[1645]: pam_unix(sudo:session): session closed for user root Oct 19 09:23:48.636880 sudo[1644]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 19 09:23:48.637409 sudo[1644]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 19 09:23:48.646026 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 19 09:23:48.705000 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 19 09:23:48.720971 kernel: kauditd_printk_skb: 54 callbacks suppressed Oct 19 09:23:48.721013 augenrules[1669]: No rules Oct 19 09:23:48.721432 kernel: audit: type=1305 audit(1792401828.705:154): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 19 09:23:48.705000 audit[1669]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffd2901a1a0 a2=420 a3=0 items=0 ppid=1650 pid=1669 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 19 09:23:48.735725 systemd[1]: audit-rules.service: Deactivated successfully. Oct 19 09:23:48.736152 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 19 09:23:48.765363 kernel: audit: type=1300 audit(1792401828.705:154): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffd2901a1a0 a2=420 a3=0 items=0 ppid=1650 pid=1669 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 19 09:23:48.766541 sudo[1644]: pam_unix(sudo:session): session closed for user root Oct 19 09:23:48.705000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 19 09:23:48.734000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:48.780763 kernel: audit: type=1327 audit(1792401828.705:154): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 19 09:23:48.780806 kernel: audit: type=1130 audit(1792401828.734:155): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:48.734000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:48.823930 kernel: audit: type=1131 audit(1792401828.734:156): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:48.765000 audit[1644]: AUDIT1106 pid=1644 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:48.824140 kernel: audit: type=1106 audit(1792401828.765:157): pid=1644 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:48.765000 audit[1644]: AUDIT1104 pid=1644 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:48.848906 kernel: audit: type=1104 audit(1792401828.765:158): pid=1644 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:48.872025 sshd[1643]: Connection closed by 20.31.226.197 port 42350 Oct 19 09:23:48.872905 sshd-session[1639]: pam_unix(sshd:session): session closed for user core Oct 19 09:23:48.871000 audit[1639]: AUDIT1106 pid=1639 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_mkhomedir,pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:48.871000 audit[1639]: AUDIT1104 pid=1639 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_oslogin_login acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:48.912825 systemd[1]: sshd@5-5-10.128.0.92:22-20.31.226.197:42350.service: Deactivated successfully. Oct 19 09:23:48.916186 systemd[1]: session-7.scope: Deactivated successfully. Oct 19 09:23:48.921352 systemd-logind[1360]: Session 7 logged out. Waiting for processes to exit. Oct 19 09:23:48.923697 systemd-logind[1360]: Removed session 7. Oct 19 09:23:48.935749 kernel: audit: type=1106 audit(1792401828.871:159): pid=1639 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_mkhomedir,pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:48.911000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-5-10.128.0.92:22-20.31.226.197:42350 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:48.935935 kernel: audit: type=1104 audit(1792401828.871:160): pid=1639 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_oslogin_login acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:48.935966 kernel: audit: type=1131 audit(1792401828.911:161): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-5-10.128.0.92:22-20.31.226.197:42350 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:48.988000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4098-10.128.0.92:22-20.31.226.197:42366 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:48.989713 systemd[1]: Started sshd@6-4098-10.128.0.92:22-20.31.226.197:42366.service - OpenSSH per-connection server daemon (20.31.226.197:42366). Oct 19 09:23:49.584000 audit[1678]: AUDIT1101 pid=1678 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_oslogin_admin,pam_access,pam_time,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:49.585891 sshd[1678]: Accepted publickey for core from 20.31.226.197 port 42366 ssh2: RSA SHA256:srHaBxLjG0SNRqDzWguINIzBbCKihN43Un9NYeFcGbk Oct 19 09:23:49.585000 audit[1678]: AUDIT1103 pid=1678 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_oslogin_login acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:49.585000 audit[1678]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7ffed2913020 a2=3 a3=0 items=0 ppid=1 pid=1678 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=8 comm="sshd-session" exe="/usr/lib64/misc/sshd-session" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 19 09:23:49.585000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B706F7374617574685D Oct 19 09:23:49.587280 sshd-session[1678]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:23:49.595776 systemd-logind[1360]: New session '8' of user 'core' with class 'user' and type 'tty'. Oct 19 09:23:49.600008 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 19 09:23:49.603000 audit[1678]: AUDIT1105 pid=1678 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_mkhomedir,pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:49.605000 audit[1682]: AUDIT1103 pid=1682 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_oslogin_login acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:49.810000 audit[1683]: AUDIT1101 pid=1683 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:49.811020 sudo[1683]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s UUID -o value /dev/disk/by-label/ROOT Oct 19 09:23:49.811576 sudo[1683]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 19 09:23:49.810000 audit[1683]: AUDIT1110 pid=1683 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:49.810000 audit[1683]: AUDIT1105 pid=1683 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:49.817903 sudo[1683]: pam_unix(sudo:session): session closed for user root Oct 19 09:23:49.817000 audit[1683]: AUDIT1106 pid=1683 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:49.817000 audit[1683]: AUDIT1104 pid=1683 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:49.923324 sshd[1682]: Connection closed by 20.31.226.197 port 42366 Oct 19 09:23:49.925098 sshd-session[1678]: pam_unix(sshd:session): session closed for user core Oct 19 09:23:49.925000 audit[1678]: AUDIT1106 pid=1678 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_mkhomedir,pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:49.925000 audit[1678]: AUDIT1104 pid=1678 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_oslogin_login acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:49.929562 systemd[1]: sshd@6-4098-10.128.0.92:22-20.31.226.197:42366.service: Deactivated successfully. Oct 19 09:23:49.929000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4098-10.128.0.92:22-20.31.226.197:42366 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:49.932010 systemd[1]: session-8.scope: Deactivated successfully. Oct 19 09:23:49.933296 systemd-logind[1360]: Session 8 logged out. Waiting for processes to exit. Oct 19 09:23:49.935514 systemd-logind[1360]: Removed session 8. Oct 19 09:23:50.037000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-4099-10.128.0.92:22-20.31.226.197:59726 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:50.037870 systemd[1]: Started sshd@7-4099-10.128.0.92:22-20.31.226.197:59726.service - OpenSSH per-connection server daemon (20.31.226.197:59726). Oct 19 09:23:50.629000 audit[1690]: AUDIT1101 pid=1690 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_oslogin_admin,pam_access,pam_time,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:50.631678 sshd[1690]: Accepted publickey for core from 20.31.226.197 port 59726 ssh2: RSA SHA256:srHaBxLjG0SNRqDzWguINIzBbCKihN43Un9NYeFcGbk Oct 19 09:23:50.631000 audit[1690]: AUDIT1103 pid=1690 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_oslogin_login acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:50.631000 audit[1690]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7ffc7cb0d380 a2=3 a3=0 items=0 ppid=1 pid=1690 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=9 comm="sshd-session" exe="/usr/lib64/misc/sshd-session" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 19 09:23:50.631000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B706F7374617574685D Oct 19 09:23:50.633640 sshd-session[1690]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:23:50.641590 systemd-logind[1360]: New session '9' of user 'core' with class 'user' and type 'tty'. Oct 19 09:23:50.643002 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 19 09:23:50.645000 audit[1690]: AUDIT1105 pid=1690 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_mkhomedir,pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:50.647000 audit[1694]: AUDIT1103 pid=1694 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_oslogin_login acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:50.854000 audit[1695]: AUDIT1101 pid=1695 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:50.856032 sudo[1695]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s TYPE -o value /dev/disk/by-label/ROOT Oct 19 09:23:50.854000 audit[1695]: AUDIT1110 pid=1695 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:50.854000 audit[1695]: AUDIT1105 pid=1695 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:50.856596 sudo[1695]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 19 09:23:50.859135 sudo[1695]: pam_unix(sudo:session): session closed for user root Oct 19 09:23:50.857000 audit[1695]: AUDIT1106 pid=1695 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:50.857000 audit[1695]: AUDIT1104 pid=1695 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 19 09:23:50.963604 sshd[1694]: Connection closed by 20.31.226.197 port 59726 Oct 19 09:23:50.965034 sshd-session[1690]: pam_unix(sshd:session): session closed for user core Oct 19 09:23:50.964000 audit[1690]: AUDIT1106 pid=1690 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_mkhomedir,pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:50.964000 audit[1690]: AUDIT1104 pid=1690 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_oslogin_login acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:50.969967 systemd[1]: sshd@7-4099-10.128.0.92:22-20.31.226.197:59726.service: Deactivated successfully. Oct 19 09:23:50.968000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-4099-10.128.0.92:22-20.31.226.197:59726 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:50.972541 systemd[1]: session-9.scope: Deactivated successfully. Oct 19 09:23:50.974937 systemd-logind[1360]: Session 9 logged out. Waiting for processes to exit. Oct 19 09:23:50.976354 systemd-logind[1360]: Removed session 9. Oct 19 09:23:51.079000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-6-10.128.0.92:22-20.31.226.197:59732 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:51.080028 systemd[1]: Started sshd@8-6-10.128.0.92:22-20.31.226.197:59732.service - OpenSSH per-connection server daemon (20.31.226.197:59732). Oct 19 09:23:51.677000 audit[1702]: AUDIT1101 pid=1702 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_oslogin_admin,pam_access,pam_time,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:51.678932 sshd[1702]: Accepted publickey for core from 20.31.226.197 port 59732 ssh2: RSA SHA256:srHaBxLjG0SNRqDzWguINIzBbCKihN43Un9NYeFcGbk Oct 19 09:23:51.679000 audit[1702]: AUDIT1103 pid=1702 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_oslogin_login acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:51.679000 audit[1702]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7fff5dc82380 a2=3 a3=0 items=0 ppid=1 pid=1702 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=10 comm="sshd-session" exe="/usr/lib64/misc/sshd-session" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 19 09:23:51.679000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B706F7374617574685D Oct 19 09:23:51.680930 sshd-session[1702]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:23:51.689109 systemd-logind[1360]: New session '10' of user 'core' with class 'user' and type 'tty'. Oct 19 09:23:51.699034 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 19 09:23:51.702000 audit[1702]: AUDIT1105 pid=1702 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_mkhomedir,pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:51.704000 audit[1706]: AUDIT1103 pid=1706 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_oslogin_login acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:51.997620 sshd[1706]: Connection closed by 20.31.226.197 port 59732 Oct 19 09:23:51.999028 sshd-session[1702]: pam_unix(sshd:session): session closed for user core Oct 19 09:23:51.999000 audit[1702]: AUDIT1106 pid=1702 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_mkhomedir,pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:51.999000 audit[1702]: AUDIT1104 pid=1702 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_oslogin_login acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 19 09:23:52.003511 systemd[1]: sshd@8-6-10.128.0.92:22-20.31.226.197:59732.service: Deactivated successfully. Oct 19 09:23:52.003000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-6-10.128.0.92:22-20.31.226.197:59732 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:23:52.005970 systemd[1]: session-10.scope: Deactivated successfully. Oct 19 09:23:52.007277 systemd-logind[1360]: Session 10 logged out. Waiting for processes to exit. Oct 19 09:23:52.009537 systemd-logind[1360]: Removed session 10.