Oct 21 16:50:39.712040 kernel: Linux version 6.12.113-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 15.2.1_p20260214 p5) 15.2.1 20260214, GNU ld (Gentoo 2.46.0 p1) 2.46.0) #1 SMP PREEMPT_DYNAMIC Wed Oct 21 13:31:47 -00 2026 Oct 21 16:50:39.712115 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=f9c4131fb5c44666f45d1763dbb5d9bab6fc31b20ca6f6f66c17cc9a3d769067 Oct 21 16:50:39.712134 kernel: BIOS-provided physical RAM map: Oct 21 16:50:39.712148 kernel: BIOS-e820: [mem 0x0000000000000000-0x0000000000000fff] reserved Oct 21 16:50:39.712168 kernel: BIOS-e820: [mem 0x0000000000001000-0x0000000000054fff] usable Oct 21 16:50:39.712180 kernel: BIOS-e820: [mem 0x0000000000055000-0x000000000005ffff] reserved Oct 21 16:50:39.712195 kernel: BIOS-e820: [mem 0x0000000000060000-0x0000000000097fff] usable Oct 21 16:50:39.712208 kernel: BIOS-e820: [mem 0x0000000000098000-0x000000000009ffff] reserved Oct 21 16:50:39.712221 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bd2f6fff] usable Oct 21 16:50:39.712237 kernel: BIOS-e820: [mem 0x00000000bd2f7000-0x00000000bd300fff] ACPI data Oct 21 16:50:39.712252 kernel: BIOS-e820: [mem 0x00000000bd301000-0x00000000bf8ecfff] usable Oct 21 16:50:39.712267 kernel: BIOS-e820: [mem 0x00000000bf8ed000-0x00000000bfb6cfff] reserved Oct 21 16:50:39.712288 kernel: BIOS-e820: [mem 0x00000000bfb6d000-0x00000000bfb7efff] ACPI data Oct 21 16:50:39.712303 kernel: BIOS-e820: [mem 0x00000000bfb7f000-0x00000000bfbfefff] ACPI NVS Oct 21 16:50:39.712323 kernel: BIOS-e820: [mem 0x00000000bfbff000-0x00000000bffdffff] usable Oct 21 16:50:39.712340 kernel: BIOS-e820: [mem 0x00000000bffe0000-0x00000000bfffffff] reserved Oct 21 16:50:39.712361 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000021fffffff] usable Oct 21 16:50:39.712379 kernel: NX (Execute Disable) protection: active Oct 21 16:50:39.712397 kernel: APIC: Static calls initialized Oct 21 16:50:39.712415 kernel: efi: EFI v2.7 by EDK II Oct 21 16:50:39.712433 kernel: efi: TPMFinalLog=0xbfbf7000 ACPI=0xbfb7e000 ACPI 2.0=0xbfb7e014 SMBIOS=0xbf9ca000 MEMATTR=0xbd301018 RNG=0xbfb73018 TPMEventLog=0xbd2f7018 Oct 21 16:50:39.712452 kernel: random: crng init done Oct 21 16:50:39.712469 kernel: secureboot: Secure boot disabled Oct 21 16:50:39.712486 kernel: SMBIOS 2.4 present. Oct 21 16:50:39.712503 kernel: DMI: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/16/2026 Oct 21 16:50:39.712521 kernel: DMI: Memory slots populated: 1/1 Oct 21 16:50:39.712537 kernel: Hypervisor detected: KVM Oct 21 16:50:39.712557 kernel: last_pfn = 0xbffe0 max_arch_pfn = 0x400000000 Oct 21 16:50:39.712571 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Oct 21 16:50:39.712587 kernel: kvm-clock: using sched offset of 12088705296 cycles Oct 21 16:50:39.712605 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 21 16:50:39.712623 kernel: tsc: Detected 2299.998 MHz processor Oct 21 16:50:39.712642 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 21 16:50:39.712659 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 21 16:50:39.712677 kernel: last_pfn = 0x220000 max_arch_pfn = 0x400000000 Oct 21 16:50:39.712700 kernel: MTRR map: 3 entries (2 fixed + 1 variable; max 18), built from 8 variable MTRRs Oct 21 16:50:39.712718 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 21 16:50:39.712736 kernel: last_pfn = 0xbffe0 max_arch_pfn = 0x400000000 Oct 21 16:50:39.712753 kernel: Using GB pages for direct mapping Oct 21 16:50:39.712781 kernel: ACPI: Early table checksum verification disabled Oct 21 16:50:39.712806 kernel: ACPI: RSDP 0x00000000BFB7E014 000024 (v02 Google) Oct 21 16:50:39.712830 kernel: ACPI: XSDT 0x00000000BFB7D0E8 00005C (v01 Google GOOGFACP 00000001 01000013) Oct 21 16:50:39.712848 kernel: ACPI: FACP 0x00000000BFB78000 000114 (v06 Google GOOGFACP 00000001 GOOG 00000001) Oct 21 16:50:39.712867 kernel: ACPI: DSDT 0x00000000BFB79000 001DED (v02 Google GOOGDSDT 00000001 GOOG 00000001) Oct 21 16:50:39.712885 kernel: ACPI: FACS 0x00000000BFBF2000 000040 Oct 21 16:50:39.712918 kernel: ACPI: SSDT 0x00000000BFB7C000 000316 (v02 GOOGLE Tpm2Tabl 00001000 INTL 20250807) Oct 21 16:50:39.712943 kernel: ACPI: TPM2 0x00000000BFB7B000 000034 (v04 GOOGLE 00000001 GOOG 00000001) Oct 21 16:50:39.712962 kernel: ACPI: SRAT 0x00000000BFB77000 0000C8 (v03 Google GOOGSRAT 00000001 GOOG 00000001) Oct 21 16:50:39.712981 kernel: ACPI: APIC 0x00000000BFB76000 000076 (v05 Google GOOGAPIC 00000001 GOOG 00000001) Oct 21 16:50:39.713000 kernel: ACPI: SSDT 0x00000000BFB75000 000914 (v02 Google GOOGSSDT 00000001 GOOG 00000001) Oct 21 16:50:39.713018 kernel: ACPI: WAET 0x00000000BFB74000 000028 (v01 Google GOOGWAET 00000001 GOOG 00000001) Oct 21 16:50:39.713037 kernel: ACPI: Reserving FACP table memory at [mem 0xbfb78000-0xbfb78113] Oct 21 16:50:39.713055 kernel: ACPI: Reserving DSDT table memory at [mem 0xbfb79000-0xbfb7adec] Oct 21 16:50:39.713078 kernel: ACPI: Reserving FACS table memory at [mem 0xbfbf2000-0xbfbf203f] Oct 21 16:50:39.713097 kernel: ACPI: Reserving SSDT table memory at [mem 0xbfb7c000-0xbfb7c315] Oct 21 16:50:39.713115 kernel: ACPI: Reserving TPM2 table memory at [mem 0xbfb7b000-0xbfb7b033] Oct 21 16:50:39.713134 kernel: ACPI: Reserving SRAT table memory at [mem 0xbfb77000-0xbfb770c7] Oct 21 16:50:39.713153 kernel: ACPI: Reserving APIC table memory at [mem 0xbfb76000-0xbfb76075] Oct 21 16:50:39.713171 kernel: ACPI: Reserving SSDT table memory at [mem 0xbfb75000-0xbfb75913] Oct 21 16:50:39.713195 kernel: ACPI: Reserving WAET table memory at [mem 0xbfb74000-0xbfb74027] Oct 21 16:50:39.713210 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x0009ffff] Oct 21 16:50:39.713286 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00100000-0xbfffffff] Oct 21 16:50:39.713306 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x21fffffff] Oct 21 16:50:39.713325 kernel: NUMA: Node 0 [mem 0x00001000-0x0009ffff] + [mem 0x00100000-0xbfffffff] -> [mem 0x00001000-0xbfffffff] Oct 21 16:50:39.713342 kernel: NUMA: Node 0 [mem 0x00001000-0xbfffffff] + [mem 0x100000000-0x21fffffff] -> [mem 0x00001000-0x21fffffff] Oct 21 16:50:39.713358 kernel: NODE_DATA(0) allocated [mem 0x21fff8dc0-0x21fffffff] Oct 21 16:50:39.713374 kernel: Zone ranges: Oct 21 16:50:39.713391 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 21 16:50:39.713415 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Oct 21 16:50:39.713434 kernel: Normal [mem 0x0000000100000000-0x000000021fffffff] Oct 21 16:50:39.713452 kernel: Device empty Oct 21 16:50:39.713470 kernel: Movable zone start for each node Oct 21 16:50:39.713488 kernel: Early memory node ranges Oct 21 16:50:39.713506 kernel: node 0: [mem 0x0000000000001000-0x0000000000054fff] Oct 21 16:50:39.713522 kernel: node 0: [mem 0x0000000000060000-0x0000000000097fff] Oct 21 16:50:39.713539 kernel: node 0: [mem 0x0000000000100000-0x00000000bd2f6fff] Oct 21 16:50:39.713560 kernel: node 0: [mem 0x00000000bd301000-0x00000000bf8ecfff] Oct 21 16:50:39.713577 kernel: node 0: [mem 0x00000000bfbff000-0x00000000bffdffff] Oct 21 16:50:39.713594 kernel: node 0: [mem 0x0000000100000000-0x000000021fffffff] Oct 21 16:50:39.713611 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000021fffffff] Oct 21 16:50:39.713629 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 21 16:50:39.713645 kernel: On node 0, zone DMA: 11 pages in unavailable ranges Oct 21 16:50:39.713662 kernel: On node 0, zone DMA: 104 pages in unavailable ranges Oct 21 16:50:39.713682 kernel: On node 0, zone DMA32: 10 pages in unavailable ranges Oct 21 16:50:39.713699 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Oct 21 16:50:39.713716 kernel: On node 0, zone Normal: 32 pages in unavailable ranges Oct 21 16:50:39.713732 kernel: ACPI: PM-Timer IO Port: 0xb008 Oct 21 16:50:39.713750 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Oct 21 16:50:39.713775 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Oct 21 16:50:39.713792 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Oct 21 16:50:39.713815 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 21 16:50:39.713832 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Oct 21 16:50:39.713848 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Oct 21 16:50:39.713866 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 21 16:50:39.713884 kernel: CPU topo: Max. logical packages: 1 Oct 21 16:50:39.713933 kernel: CPU topo: Max. logical dies: 1 Oct 21 16:50:39.713951 kernel: CPU topo: Max. dies per package: 1 Oct 21 16:50:39.713974 kernel: CPU topo: Max. threads per core: 2 Oct 21 16:50:39.714001 kernel: CPU topo: Num. cores per package: 1 Oct 21 16:50:39.714019 kernel: CPU topo: Num. threads per package: 2 Oct 21 16:50:39.714036 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs Oct 21 16:50:39.714053 kernel: [mem 0xc0000000-0xffffffff] available for PCI devices Oct 21 16:50:39.714086 kernel: Booting paravirtualized kernel on KVM Oct 21 16:50:39.714104 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 21 16:50:39.714121 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Oct 21 16:50:39.714144 kernel: percpu: Embedded 60 pages/cpu s208408 r8192 d29160 u1048576 Oct 21 16:50:39.714162 kernel: pcpu-alloc: s208408 r8192 d29160 u1048576 alloc=1*2097152 Oct 21 16:50:39.714180 kernel: pcpu-alloc: [0] 0 1 Oct 21 16:50:39.714197 kernel: kvm-guest: PV spinlocks enabled Oct 21 16:50:39.714215 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Oct 21 16:50:39.714241 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=f9c4131fb5c44666f45d1763dbb5d9bab6fc31b20ca6f6f66c17cc9a3d769067 Oct 21 16:50:39.714269 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) Oct 21 16:50:39.714287 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 21 16:50:39.714305 kernel: Fallback order for Node 0: 0 Oct 21 16:50:39.714324 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1965136 Oct 21 16:50:39.714342 kernel: Policy zone: Normal Oct 21 16:50:39.714360 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 21 16:50:39.714378 kernel: software IO TLB: area num 2. Oct 21 16:50:39.714416 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 21 16:50:39.714435 kernel: Kernel/User page tables isolation: enabled Oct 21 16:50:39.714454 kernel: ftrace: allocating 41514 entries in 164 pages Oct 21 16:50:39.714476 kernel: ftrace: allocated 164 pages with 3 groups Oct 21 16:50:39.714495 kernel: Dynamic Preempt: voluntary Oct 21 16:50:39.714514 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 21 16:50:39.714536 kernel: rcu: RCU event tracing is enabled. Oct 21 16:50:39.714556 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 21 16:50:39.714579 kernel: Trampoline variant of Tasks RCU enabled. Oct 21 16:50:39.714596 kernel: Rude variant of Tasks RCU enabled. Oct 21 16:50:39.714613 kernel: Tracing variant of Tasks RCU enabled. Oct 21 16:50:39.714631 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 21 16:50:39.714650 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 21 16:50:39.714669 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 21 16:50:39.714693 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 21 16:50:39.714712 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 21 16:50:39.714732 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16 Oct 21 16:50:39.714751 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 21 16:50:39.714776 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 21 16:50:39.714795 kernel: Console: colour dummy device 80x25 Oct 21 16:50:39.714814 kernel: printk: legacy console [ttyS0] enabled Oct 21 16:50:39.714838 kernel: ACPI: Core revision 20240827 Oct 21 16:50:39.714855 kernel: APIC: Switch to symmetric I/O mode setup Oct 21 16:50:39.714872 kernel: x2apic enabled Oct 21 16:50:39.714890 kernel: APIC: Switched APIC routing to: physical x2apic Oct 21 16:50:39.714921 kernel: ..TIMER: vector=0x30 apic1=0 pin1=0 apic2=-1 pin2=-1 Oct 21 16:50:39.714941 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x212733415c7, max_idle_ns: 440795236380 ns Oct 21 16:50:39.714961 kernel: Calibrating delay loop (skipped) preset value.. 4599.99 BogoMIPS (lpj=2299998) Oct 21 16:50:39.714987 kernel: Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024 Oct 21 16:50:39.715007 kernel: Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4 Oct 21 16:50:39.715027 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 21 16:50:39.715048 kernel: Spectre V2 : Spectre BHI mitigation: SW BHB clearing on syscall and VM exit Oct 21 16:50:39.715065 kernel: Spectre V2 : Mitigation: IBRS Oct 21 16:50:39.715085 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Oct 21 16:50:39.715101 kernel: Spectre V2 : Enabling IBPB for BPF Oct 21 16:50:39.715123 kernel: RETBleed: Mitigation: IBRS Oct 21 16:50:39.715142 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Oct 21 16:50:39.715158 kernel: Spectre V2 : User space: Mitigation: STIBP via prctl Oct 21 16:50:39.715178 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Oct 21 16:50:39.715197 kernel: MDS: Mitigation: Clear CPU buffers Oct 21 16:50:39.715217 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Oct 21 16:50:39.715237 kernel: active return thunk: its_return_thunk Oct 21 16:50:39.715262 kernel: ITS: Mitigation: Aligned branch/return thunks Oct 21 16:50:39.715282 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 21 16:50:39.715302 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 21 16:50:39.715322 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 21 16:50:39.715342 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 21 16:50:39.715360 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Oct 21 16:50:39.715378 kernel: Freeing SMP alternatives memory: 36K Oct 21 16:50:39.715394 kernel: pid_max: default: 32768 minimum: 301 Oct 21 16:50:39.715417 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 21 16:50:39.715436 kernel: landlock: Up and running. Oct 21 16:50:39.715455 kernel: SELinux: Initializing. Oct 21 16:50:39.715473 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 21 16:50:39.715494 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 21 16:50:39.715514 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU @ 2.30GHz (family: 0x6, model: 0x3f, stepping: 0x0) Oct 21 16:50:39.715534 kernel: Performance Events: unsupported p6 CPU model 63 no PMU driver, software events only. Oct 21 16:50:39.715558 kernel: signal: max sigframe size: 1776 Oct 21 16:50:39.715578 kernel: rcu: Hierarchical SRCU implementation. Oct 21 16:50:39.715597 kernel: rcu: Max phase no-delay instances is 400. Oct 21 16:50:39.715616 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 21 16:50:39.715635 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Oct 21 16:50:39.715654 kernel: smp: Bringing up secondary CPUs ... Oct 21 16:50:39.715673 kernel: smpboot: x86: Booting SMP configuration: Oct 21 16:50:39.715698 kernel: .... node #0, CPUs: #1 Oct 21 16:50:39.715717 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 21 16:50:39.715737 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 21 16:50:39.715754 kernel: smp: Brought up 1 node, 2 CPUs Oct 21 16:50:39.715785 kernel: smpboot: Total of 2 processors activated (9199.99 BogoMIPS) Oct 21 16:50:39.715804 kernel: Memory: 7523996K/7860544K available (14336K kernel code, 2476K rwdata, 32660K rodata, 16140K init, 1888K bss, 330672K reserved, 0K cma-reserved) Oct 21 16:50:39.715827 kernel: devtmpfs: initialized Oct 21 16:50:39.715845 kernel: x86/mm: Memory block size: 128MB Oct 21 16:50:39.715862 kernel: ACPI: PM: Registering ACPI NVS region [mem 0xbfb7f000-0xbfbfefff] (524288 bytes) Oct 21 16:50:39.715881 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 21 16:50:39.715928 kernel: pinctrl core: initialized pinctrl subsystem Oct 21 16:50:39.715947 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 21 16:50:39.715965 kernel: audit: initializing netlink subsys (disabled) Oct 21 16:50:39.715989 kernel: audit: type=2000 audit(1792601434.189:1): state=initialized audit_enabled=0 res=1 Oct 21 16:50:39.716006 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 21 16:50:39.716023 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 21 16:50:39.716040 kernel: cpuidle: using governor menu Oct 21 16:50:39.716954 kernel: efi: Freeing EFI boot services memory: 56352K Oct 21 16:50:39.717364 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 21 16:50:39.717838 kernel: dca service started, version 1.12.1 Oct 21 16:50:39.719964 kernel: PCI: Using configuration type 1 for base access Oct 21 16:50:39.719998 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 21 16:50:39.720020 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 21 16:50:39.720041 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Oct 21 16:50:39.720061 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 21 16:50:39.720082 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Oct 21 16:50:39.720102 kernel: ACPI: Added _OSI(Module Device) Oct 21 16:50:39.720122 kernel: ACPI: Added _OSI(Processor Device) Oct 21 16:50:39.720147 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 21 16:50:39.720167 kernel: ACPI: 3 ACPI AML tables successfully acquired and loaded Oct 21 16:50:39.720187 kernel: ACPI: Interpreter enabled Oct 21 16:50:39.720207 kernel: ACPI: PM: (supports S0 S3 S5) Oct 21 16:50:39.720227 kernel: ACPI: Using IOAPIC for interrupt routing Oct 21 16:50:39.720247 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 21 16:50:39.720267 kernel: PCI: Ignoring E820 reservations for host bridge windows Oct 21 16:50:39.720292 kernel: ACPI: Enabled 16 GPEs in block 00 to 0F Oct 21 16:50:39.720312 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 21 16:50:39.720812 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Oct 21 16:50:39.721196 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Oct 21 16:50:39.721532 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Oct 21 16:50:39.721565 kernel: PCI host bridge to bus 0000:00 Oct 21 16:50:39.723941 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Oct 21 16:50:39.724347 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0x0fff window] Oct 21 16:50:39.724662 kernel: pci_bus 0000:00: root bus resource [io 0xc000-0xffff window] Oct 21 16:50:39.725101 kernel: pci_bus 0000:00: root bus resource [io 0xa000-0xbfff window] Oct 21 16:50:39.728103 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Oct 21 16:50:39.728488 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfefff window] Oct 21 16:50:39.728798 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 21 16:50:39.729185 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint Oct 21 16:50:39.729539 kernel: pci 0000:00:01.0: [8086:7110] type 00 class 0x060100 conventional PCI endpoint Oct 21 16:50:39.729940 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint Oct 21 16:50:39.730318 kernel: pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI Oct 21 16:50:39.730667 kernel: pci 0000:00:03.0: [1af4:1004] type 00 class 0x000000 conventional PCI endpoint Oct 21 16:50:39.731036 kernel: pci 0000:00:03.0: BAR 0 [io 0xc040-0xc07f] Oct 21 16:50:39.731539 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc0001000-0xc000107f] Oct 21 16:50:39.731952 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Oct 21 16:50:39.732386 kernel: pci 0000:00:04.0: BAR 0 [io 0xc000-0xc03f] Oct 21 16:50:39.732737 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc0000000-0xc000007f] Oct 21 16:50:39.733111 kernel: pci 0000:00:05.0: [1af4:1002] type 00 class 0x00ff00 conventional PCI endpoint Oct 21 16:50:39.733454 kernel: pci 0000:00:05.0: BAR 0 [io 0xc0a0-0xc0bf] Oct 21 16:50:39.733802 kernel: pci 0000:00:06.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Oct 21 16:50:39.734762 kernel: pci 0000:00:06.0: BAR 0 [io 0xc080-0xc09f] Oct 21 16:50:39.735122 kernel: pci 0000:00:06.0: BAR 1 [mem 0xc0002000-0xc000203f] Oct 21 16:50:39.735439 kernel: pci_bus 0000:00: on NUMA node 0 Oct 21 16:50:39.735466 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Oct 21 16:50:39.735487 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Oct 21 16:50:39.735506 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Oct 21 16:50:39.735525 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Oct 21 16:50:39.735551 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Oct 21 16:50:39.735571 kernel: iommu: Default domain type: Translated Oct 21 16:50:39.735591 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 21 16:50:39.735611 kernel: efivars: Registered efivars operations Oct 21 16:50:39.735630 kernel: PCI: Using ACPI for IRQ routing Oct 21 16:50:39.735649 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 21 16:50:39.735668 kernel: e820: reserve RAM buffer [mem 0x00055000-0x0005ffff] Oct 21 16:50:39.735687 kernel: e820: reserve RAM buffer [mem 0x00098000-0x0009ffff] Oct 21 16:50:39.735711 kernel: e820: reserve RAM buffer [mem 0xbd2f7000-0xbfffffff] Oct 21 16:50:39.735730 kernel: e820: reserve RAM buffer [mem 0xbf8ed000-0xbfffffff] Oct 21 16:50:39.735749 kernel: e820: reserve RAM buffer [mem 0xbffe0000-0xbfffffff] Oct 21 16:50:39.735769 kernel: vgaarb: loaded Oct 21 16:50:39.735788 kernel: clocksource: Switched to clocksource kvm-clock Oct 21 16:50:39.735807 kernel: VFS: Disk quotas dquot_6.6.0 Oct 21 16:50:39.735826 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 21 16:50:39.735850 kernel: pnp: PnP ACPI init Oct 21 16:50:39.735870 kernel: pnp: PnP ACPI: found 7 devices Oct 21 16:50:39.735889 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 21 16:50:39.735922 kernel: NET: Registered PF_INET protocol family Oct 21 16:50:39.735941 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) Oct 21 16:50:39.735961 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) Oct 21 16:50:39.735980 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 21 16:50:39.736004 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 21 16:50:39.736023 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Oct 21 16:50:39.736043 kernel: TCP: Hash tables configured (established 65536 bind 65536) Oct 21 16:50:39.736062 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) Oct 21 16:50:39.736081 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) Oct 21 16:50:39.736100 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 21 16:50:39.736119 kernel: NET: Registered PF_XDP protocol family Oct 21 16:50:39.736434 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Oct 21 16:50:39.736734 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0x0fff window] Oct 21 16:50:39.737043 kernel: pci_bus 0000:00: resource 6 [io 0xc000-0xffff window] Oct 21 16:50:39.737348 kernel: pci_bus 0000:00: resource 7 [io 0xa000-0xbfff window] Oct 21 16:50:39.737652 kernel: pci_bus 0000:00: resource 8 [mem 0x000a0000-0x000bffff window] Oct 21 16:50:39.737961 kernel: pci_bus 0000:00: resource 9 [mem 0xc0000000-0xfebfefff window] Oct 21 16:50:39.738318 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Oct 21 16:50:39.738344 kernel: PCI: CLS 0 bytes, default 64 Oct 21 16:50:39.738364 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Oct 21 16:50:39.738383 kernel: software IO TLB: mapped [mem 0x00000000b7f7f000-0x00000000bbf7f000] (64MB) Oct 21 16:50:39.738403 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Oct 21 16:50:39.738423 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x212733415c7, max_idle_ns: 440795236380 ns Oct 21 16:50:39.738448 kernel: clocksource: Switched to clocksource tsc Oct 21 16:50:39.738468 kernel: Initialise system trusted keyrings Oct 21 16:50:39.738488 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 Oct 21 16:50:39.738507 kernel: Key type asymmetric registered Oct 21 16:50:39.738526 kernel: Asymmetric key parser 'x509' registered Oct 21 16:50:39.738546 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 21 16:50:39.738565 kernel: io scheduler mq-deadline registered Oct 21 16:50:39.738590 kernel: io scheduler kyber registered Oct 21 16:50:39.738609 kernel: io scheduler bfq registered Oct 21 16:50:39.738629 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 21 16:50:39.738650 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Oct 21 16:50:39.738994 kernel: virtio-pci 0000:00:03.0: virtio_pci: leaving for legacy driver Oct 21 16:50:39.739020 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 10 Oct 21 16:50:39.739352 kernel: virtio-pci 0000:00:04.0: virtio_pci: leaving for legacy driver Oct 21 16:50:39.739388 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Oct 21 16:50:39.739716 kernel: virtio-pci 0000:00:05.0: virtio_pci: leaving for legacy driver Oct 21 16:50:39.739740 kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 11 Oct 21 16:50:39.740076 kernel: virtio-pci 0000:00:06.0: virtio_pci: leaving for legacy driver Oct 21 16:50:39.740101 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 21 16:50:39.740121 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 21 16:50:39.740140 kernel: 00:04: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Oct 21 16:50:39.740165 kernel: 00:05: ttyS2 at I/O 0x3e8 (irq = 6, base_baud = 115200) is a 16550A Oct 21 16:50:39.740184 kernel: 00:06: ttyS3 at I/O 0x2e8 (irq = 7, base_baud = 115200) is a 16550A Oct 21 16:50:39.740536 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x9009, rev-id 0) Oct 21 16:50:39.740563 kernel: ACPI: bus type drm_connector registered Oct 21 16:50:39.740584 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Oct 21 16:50:39.740604 kernel: i8042: Warning: Keylock active Oct 21 16:50:39.740629 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Oct 21 16:50:39.740648 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Oct 21 16:50:39.740987 kernel: rtc_cmos 00:00: RTC can wake from S4 Oct 21 16:50:39.741300 kernel: rtc_cmos 00:00: registered as rtc0 Oct 21 16:50:39.741599 kernel: rtc_cmos 00:00: setting system clock to 2026-10-21T16:50:36 UTC (1792601436) Oct 21 16:50:39.741930 kernel: rtc_cmos 00:00: alarms up to one day, 114 bytes nvram Oct 21 16:50:39.741957 kernel: intel_pstate: CPU model not supported Oct 21 16:50:39.741999 kernel: pstore: Using crash dump compression: deflate Oct 21 16:50:39.742020 kernel: pstore: Registered efi_pstore as persistent store backend Oct 21 16:50:39.742041 kernel: NET: Registered PF_INET6 protocol family Oct 21 16:50:39.742061 kernel: Segment Routing with IPv6 Oct 21 16:50:39.742079 kernel: In-situ OAM (IOAM) with IPv6 Oct 21 16:50:39.742095 kernel: NET: Registered PF_PACKET protocol family Oct 21 16:50:39.742115 kernel: Key type dns_resolver registered Oct 21 16:50:39.742140 kernel: IPI shorthand broadcast: enabled Oct 21 16:50:39.742157 kernel: sched_clock: Marking stable (2076004102, 242717692)->(2429548879, -110827085) Oct 21 16:50:39.742176 kernel: registered taskstats version 1 Oct 21 16:50:39.742194 kernel: Loading compiled-in X.509 certificates Oct 21 16:50:39.742214 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.113-flatcar: 069df3df9235389fc6745cd485f12d23895978c1' Oct 21 16:50:39.742233 kernel: Demotion targets for Node 0: null Oct 21 16:50:39.742253 kernel: Key type .fscrypt registered Oct 21 16:50:39.742292 kernel: Key type fscrypt-provisioning registered Oct 21 16:50:39.742311 kernel: ima: Allocated hash algorithm: sha1 Oct 21 16:50:39.742331 kernel: ima: Can not allocate sha384 (reason: -2) Oct 21 16:50:39.742352 kernel: ima: No architecture policies found Oct 21 16:50:39.742372 kernel: clk: Disabling unused clocks Oct 21 16:50:39.742391 kernel: Freeing unused kernel image (initmem) memory: 16140K Oct 21 16:50:39.742411 kernel: Write protecting the kernel read-only data: 47104k Oct 21 16:50:39.742436 kernel: Freeing unused kernel image (rodata/data gap) memory: 108K Oct 21 16:50:39.742455 kernel: Run /init as init process Oct 21 16:50:39.742475 kernel: with arguments: Oct 21 16:50:39.742494 kernel: /init Oct 21 16:50:39.742513 kernel: with environment: Oct 21 16:50:39.742537 kernel: HOME=/ Oct 21 16:50:39.742584 kernel: TERM=linux Oct 21 16:50:39.742613 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 Oct 21 16:50:39.742633 kernel: SCSI subsystem initialized Oct 21 16:50:39.743048 kernel: virtio_scsi virtio0: 1/0/0 default/read/poll queues Oct 21 16:50:39.743435 kernel: scsi host0: Virtio SCSI HBA Oct 21 16:50:39.743468 kernel: blk-mq: reduced tag depth to 10240 Oct 21 16:50:39.743866 kernel: scsi 0:0:1:0: Direct-Access Google PersistentDisk 1 PQ: 0 ANSI: 6 Oct 21 16:50:39.744293 kernel: sd 0:0:1:0: [sda] 33554432 512-byte logical blocks: (17.2 GB/16.0 GiB) Oct 21 16:50:39.745860 kernel: sd 0:0:1:0: [sda] 4096-byte physical blocks Oct 21 16:50:39.746284 kernel: sd 0:0:1:0: [sda] Write Protect is off Oct 21 16:50:39.746664 kernel: sd 0:0:1:0: [sda] Mode Sense: 1f 00 00 08 Oct 21 16:50:39.747075 kernel: sd 0:0:1:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Oct 21 16:50:39.747114 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 21 16:50:39.747135 kernel: GPT:25804799 != 33554431 Oct 21 16:50:39.747156 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 21 16:50:39.747177 kernel: GPT:25804799 != 33554431 Oct 21 16:50:39.747198 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 21 16:50:39.747219 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 21 16:50:39.747629 kernel: sd 0:0:1:0: [sda] Attached SCSI disk Oct 21 16:50:39.747665 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 21 16:50:39.747686 kernel: device-mapper: uevent: version 1.0.3 Oct 21 16:50:39.747707 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 21 16:50:39.747728 kernel: device-mapper: verity: sha256 using shash "sha256-generic" Oct 21 16:50:39.747749 kernel: raid6: avx2x4 gen() 17849 MB/s Oct 21 16:50:39.747769 kernel: raid6: avx2x2 gen() 17935 MB/s Oct 21 16:50:39.747790 kernel: raid6: avx2x1 gen() 13691 MB/s Oct 21 16:50:39.747815 kernel: raid6: using algorithm avx2x2 gen() 17935 MB/s Oct 21 16:50:39.747836 kernel: raid6: .... xor() 17597 MB/s, rmw enabled Oct 21 16:50:39.747856 kernel: raid6: using avx2x2 recovery algorithm Oct 21 16:50:39.747877 kernel: xor: automatically using best checksumming function avx Oct 21 16:50:39.747914 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 21 16:50:39.747932 kernel: BTRFS: device fsid 29288385-46e1-46ef-9bf5-e87d7a4fd0c8 devid 1 transid 41 /dev/mapper/usr (254:0) scanned by mount (155) Oct 21 16:50:39.747950 kernel: BTRFS info (device dm-0): first mount of filesystem 29288385-46e1-46ef-9bf5-e87d7a4fd0c8 Oct 21 16:50:39.747976 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Oct 21 16:50:39.747996 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Oct 21 16:50:39.748015 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Oct 21 16:50:39.748033 kernel: BTRFS info (device dm-0 state E): enabling free space tree Oct 21 16:50:39.748053 kernel: loop: module loaded Oct 21 16:50:39.748074 kernel: loop0: detected capacity change from 0 to 109736 Oct 21 16:50:39.748093 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 21 16:50:39.748119 kernel: fuse: init (API version 7.41) Oct 21 16:50:39.748142 systemd[1]: Successfully made /usr/ read-only. Oct 21 16:50:39.748169 systemd[1]: systemd 260.4 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 21 16:50:39.748191 systemd[1]: Detected virtualization google. Oct 21 16:50:39.748210 systemd[1]: Detected architecture x86-64. Oct 21 16:50:39.748231 systemd[1]: Running in initrd. Oct 21 16:50:39.748259 systemd[1]: Initializing machine ID from random generator. Oct 21 16:50:39.748292 systemd[1]: No hostname configured, using default hostname. Oct 21 16:50:39.748313 systemd[1]: Hostname set to . Oct 21 16:50:39.748338 systemd[1]: Queued start job for default target initrd.target. Oct 21 16:50:39.748364 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 21 16:50:39.748387 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 21 16:50:39.748409 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 21 16:50:39.748431 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 21 16:50:39.748453 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 21 16:50:39.748474 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 21 16:50:39.748499 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 21 16:50:39.748519 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 21 16:50:39.748540 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 21 16:50:39.748561 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 21 16:50:39.748580 systemd[1]: Reached target paths.target - Path Units. Oct 21 16:50:39.748601 systemd[1]: Reached target slices.target - Slice Units. Oct 21 16:50:39.748626 systemd[1]: Reached target swap.target - Swaps. Oct 21 16:50:39.748649 systemd[1]: Reached target timers.target - Timer Units. Oct 21 16:50:39.748672 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 21 16:50:39.748694 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 21 16:50:39.748717 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 21 16:50:39.748739 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 21 16:50:39.748762 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 21 16:50:39.748790 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 21 16:50:39.748814 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 21 16:50:39.748837 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 21 16:50:39.748860 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 21 16:50:39.748885 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 21 16:50:39.748931 systemd[1]: Reached target sockets.target - Socket Units. Oct 21 16:50:39.748955 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 21 16:50:39.748986 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 21 16:50:39.749010 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 21 16:50:39.749034 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 21 16:50:39.749058 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Oct 21 16:50:39.749081 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 21 16:50:39.749109 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 21 16:50:39.749133 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 21 16:50:39.749156 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 21 16:50:39.749179 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 21 16:50:39.749289 systemd-journald[268]: Collecting audit messages is enabled. Oct 21 16:50:39.749337 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 21 16:50:39.749359 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 21 16:50:39.749382 kernel: Bridge firewalling registered Oct 21 16:50:39.749404 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 21 16:50:39.749437 systemd-journald[268]: Journal started Oct 21 16:50:39.749481 systemd-journald[268]: Runtime Journal (/run/log/journal/3f51105a10f04b5e8678921294d6265b) is 8M, max 148.4M, 140.4M free. Oct 21 16:50:39.609927 systemd-modules-load[269]: Using 2 probe threads Oct 21 16:50:39.732391 systemd-modules-load[269]: Inserted module 'br_netfilter' Oct 21 16:50:39.749000 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 21 16:50:39.766143 systemd[1]: Started systemd-journald.service - Journal Service. Oct 21 16:50:39.766199 kernel: audit: type=1130 audit(1792601439.749:2): 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 21 16:50:39.781000 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 21 16:50:39.785069 kernel: audit: type=1130 audit(1792601439.781: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 21 16:50:39.795988 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 21 16:50:39.808305 systemd-vconsole-setup[271]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 21 16:50:39.813261 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 21 16:50:39.876478 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 16:50:39.890626 systemd-tmpfiles[279]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Oct 21 16:50:39.893000 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 21 16:50:39.930466 kernel: audit: type=1130 audit(1792601439.893:4): 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 21 16:50:39.890806 systemd-tmpfiles[279]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 21 16:50:39.939000 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 21 16:50:39.976408 kernel: audit: type=1130 audit(1792601439.939:5): 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 21 16:50:39.917161 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 21 16:50:39.983000 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 21 16:50:39.983000 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 21 16:50:40.037456 kernel: audit: type=1130 audit(1792601439.983:6): 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 21 16:50:39.942496 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 21 16:50:40.046000 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 21 16:50:40.076263 kernel: audit: type=1131 audit(1792601439.983:7): 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 21 16:50:39.942692 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 21 16:50:40.085000 audit: BPF prog-id=5 op=LOAD Oct 21 16:50:40.094718 kernel: audit: type=1130 audit(1792601440.046:8): 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 21 16:50:40.006804 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 21 16:50:40.110388 kernel: audit: type=1334 audit(1792601440.085:9): prog-id=5 op=LOAD Oct 21 16:50:40.054257 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 21 16:50:40.090341 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 21 16:50:40.115258 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 21 16:50:40.169610 systemd-resolved[286]: Positive Trust Anchors: Oct 21 16:50:40.169632 systemd-resolved[286]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 21 16:50:40.169639 systemd-resolved[286]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 21 16:50:40.169703 systemd-resolved[286]: 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 21 16:50:40.185254 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 21 16:50:40.183000 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 21 16:50:40.212121 kernel: audit: type=1130 audit(1792601440.183:10): 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 21 16:50:40.233153 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 21 16:50:40.235553 systemd-resolved[286]: Defaulting to hostname 'linux'. Oct 21 16:50:40.253000 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 21 16:50:40.283263 kernel: audit: type=1130 audit(1792601440.253:11): 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 21 16:50:40.255685 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 21 16:50:40.299000 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 21 16:50:40.301343 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 21 16:50:40.322214 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 21 16:50:40.367838 dracut-cmdline[299]: dracut-110 Oct 21 16:50:40.376255 dracut-cmdline[299]: 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=f9c4131fb5c44666f45d1763dbb5d9bab6fc31b20ca6f6f66c17cc9a3d769067 Oct 21 16:50:40.517029 kernel: Loading iSCSI transport class v2.0-870. Oct 21 16:50:40.547938 kernel: iscsi: registered transport (tcp) Oct 21 16:50:40.584574 kernel: iscsi: registered transport (qla4xxx) Oct 21 16:50:40.584691 kernel: QLogic iSCSI HBA Driver Oct 21 16:50:40.619853 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 21 16:50:40.660181 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 21 16:50:40.658000 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 21 16:50:40.664311 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 21 16:50:40.760808 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 21 16:50:40.768000 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 21 16:50:40.773117 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 21 16:50:40.797572 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 21 16:50:40.818213 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 21 16:50:40.837000 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 21 16:50:40.838000 audit: BPF prog-id=6 op=LOAD Oct 21 16:50:40.838000 audit: BPF prog-id=7 op=LOAD Oct 21 16:50:40.842174 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 21 16:50:40.945594 systemd-udevd[513]: Using default interface naming scheme 'v260'. Oct 21 16:50:40.984683 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 21 16:50:41.005000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:50:41.007438 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 21 16:50:41.005000 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 21 16:50:41.010130 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 21 16:50:41.027000 audit: BPF prog-id=8 op=LOAD Oct 21 16:50:41.031581 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 21 16:50:41.062451 dracut-pre-trigger[649]: rd.md=0: removing MD RAID activation Oct 21 16:50:41.121354 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 21 16:50:41.119000 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 21 16:50:41.125412 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 21 16:50:41.126299 systemd-networkd[650]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Oct 21 16:50:41.167000 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 21 16:50:41.140710 systemd-networkd[650]: lo: Link UP Oct 21 16:50:41.140716 systemd-networkd[650]: lo: Gained carrier Oct 21 16:50:41.151462 systemd[1]: Started systemd-networkd.service - Network Management. Oct 21 16:50:41.169302 systemd[1]: Reached target network.target - Network. Oct 21 16:50:41.382889 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 21 16:50:41.400000 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 21 16:50:41.407692 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 21 16:50:41.761988 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Oct 21 16:50:41.769432 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - PersistentDisk EFI-SYSTEM. Oct 21 16:50:41.809951 kernel: cryptd: max_cpu_qlen set to 1000 Oct 21 16:50:41.816417 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 21 16:50:41.824000 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 21 16:50:41.816621 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 16:50:41.826298 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 21 16:50:41.849438 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 21 16:50:41.929154 systemd-networkd[650]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 21 16:50:41.929163 systemd-networkd[650]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 21 16:50:41.930752 systemd-networkd[650]: eth0: Link UP Oct 21 16:50:41.931209 systemd-networkd[650]: eth0: Gained carrier Oct 21 16:50:41.931231 systemd-networkd[650]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 21 16:50:41.993124 kernel: AES CTR mode by8 optimization enabled Oct 21 16:50:41.941014 systemd-networkd[650]: eth0: DHCPv4 address 10.128.0.21/32, gateway 10.128.0.1 acquired from 169.254.169.254 Oct 21 16:50:42.025540 systemd-vconsole-setup[731]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 21 16:50:42.028805 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 16:50:42.056000 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 21 16:50:42.059365 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 21 16:50:42.057000 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 21 16:50:42.075745 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - PersistentDisk ROOT. Oct 21 16:50:42.102736 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - PersistentDisk USR-A. Oct 21 16:50:42.120416 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - PersistentDisk OEM. Oct 21 16:50:42.123492 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 21 16:50:42.162086 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 21 16:50:42.181083 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 21 16:50:42.198421 systemd[1]: Mounting oem.mount - /oem... Oct 21 16:50:42.205327 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 21 16:50:42.240374 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (800) Oct 21 16:50:42.243373 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 21 16:50:42.284712 kernel: BTRFS info (device sda6): first mount of filesystem 3121944a-26f0-4a1d-9974-7c2fa600f45d Oct 21 16:50:42.284790 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Oct 21 16:50:42.285173 kernel: BTRFS info (device sda6): enabling ssd optimizations Oct 21 16:50:42.285207 disk-uuid[816]: Primary Header is updated. Oct 21 16:50:42.285207 disk-uuid[816]: Secondary Entries is updated. Oct 21 16:50:42.285207 disk-uuid[816]: Secondary Header is updated. Oct 21 16:50:42.328501 kernel: BTRFS info (device sda6): turning on async discard Oct 21 16:50:42.306164 systemd[1]: Mounted oem.mount - /oem. Oct 21 16:50:42.336297 kernel: BTRFS info (device sda6): enabling free space tree Oct 21 16:50:42.323265 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 21 16:50:42.366325 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 21 16:50:42.373000 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 21 16:50:42.698768 ignition[825]: Ignition 2.24.0 Oct 21 16:50:42.698789 ignition[825]: Stage: fetch-offline Oct 21 16:50:42.703477 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 21 16:50:42.718000 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 21 16:50:42.699752 ignition[825]: no config dir at "/usr/lib/ignition/base.d" Oct 21 16:50:42.728149 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 21 16:50:42.699944 ignition[825]: no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 21 16:50:42.700119 ignition[825]: parsed url from cmdline: "" Oct 21 16:50:42.700126 ignition[825]: no config URL provided Oct 21 16:50:42.700137 ignition[825]: reading system config file "/usr/lib/ignition/user.ign" Oct 21 16:50:42.700179 ignition[825]: no config at "/usr/lib/ignition/user.ign" Oct 21 16:50:42.700191 ignition[825]: failed to fetch config: resource requires networking Oct 21 16:50:42.700684 ignition[825]: Ignition finished successfully Oct 21 16:50:42.807072 ignition[851]: Ignition 2.24.0 Oct 21 16:50:42.807835 ignition[851]: Stage: fetch Oct 21 16:50:42.808099 ignition[851]: no config dir at "/usr/lib/ignition/base.d" Oct 21 16:50:42.808115 ignition[851]: no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 21 16:50:42.808261 ignition[851]: parsed url from cmdline: "" Oct 21 16:50:42.808268 ignition[851]: no config URL provided Oct 21 16:50:42.808278 ignition[851]: reading system config file "/usr/lib/ignition/user.ign" Oct 21 16:50:42.808297 ignition[851]: no config at "/usr/lib/ignition/user.ign" Oct 21 16:50:42.845457 unknown[851]: fetched base config from "system" Oct 21 16:50:42.865000 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 21 16:50:42.808360 ignition[851]: GET http://169.254.169.254/computeMetadata/v1/instance/attributes/user-data: attempt #1 Oct 21 16:50:42.845469 unknown[851]: fetched base config from "system" Oct 21 16:50:42.812459 ignition[851]: GET result: OK Oct 21 16:50:42.845479 unknown[851]: fetched user config from "gcp" Oct 21 16:50:42.812553 ignition[851]: parsing config with SHA512: 7aabbf904a6dd383d09c0d893413da25b21315075f2d01fcc7d54c00feff0f7a31e5a2464f93108193b269bc34aba2098c4516d516ebb81839df5e9d2fe7234a Oct 21 16:50:42.854313 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 21 16:50:42.846021 ignition[851]: fetch: fetch complete Oct 21 16:50:42.891497 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 21 16:50:42.846031 ignition[851]: fetch: fetch passed Oct 21 16:50:42.945000 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 21 16:50:42.937515 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 21 16:50:42.846105 ignition[851]: Ignition finished successfully Oct 21 16:50:42.934547 ignition[865]: Ignition 2.24.0 Oct 21 16:50:42.934558 ignition[865]: Stage: kargs Oct 21 16:50:42.934743 ignition[865]: no config dir at "/usr/lib/ignition/base.d" Oct 21 16:50:42.934753 ignition[865]: no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 21 16:50:42.935396 ignition[865]: kargs: kargs passed Oct 21 16:50:42.935459 ignition[865]: Ignition finished successfully Oct 21 16:50:43.364126 disk-uuid[820]: Warning: The kernel is still using the old partition table. Oct 21 16:50:43.364126 disk-uuid[820]: The new table will be used at the next reboot or after you Oct 21 16:50:43.364126 disk-uuid[820]: run partprobe(8) or kpartx(8) Oct 21 16:50:43.364126 disk-uuid[820]: The operation has completed successfully. Oct 21 16:50:43.392000 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 21 16:50:43.392000 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 21 16:50:43.373228 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 21 16:50:43.373403 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 21 16:50:43.396263 systemd[1]: Mounting boot.mount - Boot partition... Oct 21 16:50:43.417431 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 21 16:50:43.459718 systemd[1]: Mounted boot.mount - Boot partition. Oct 21 16:50:43.473431 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 21 16:50:43.473000 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 21 16:50:43.473610 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 21 16:50:43.498000 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 21 16:50:43.475512 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 21 16:50:43.516000 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 21 16:50:43.475660 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 21 16:50:43.500497 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 21 16:50:43.500647 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 21 16:50:43.519555 systemd[1]: Unmounting oem.mount - /oem... Oct 21 16:50:43.575314 kernel: BTRFS info (device sda6): last unmount of filesystem 3121944a-26f0-4a1d-9974-7c2fa600f45d Oct 21 16:50:43.572150 systemd[1]: oem.mount: Deactivated successfully. Oct 21 16:50:43.572350 systemd[1]: Unmounted oem.mount - /oem. Oct 21 16:50:43.593082 systemd-networkd[650]: eth0: Gained IPv6LL Oct 21 16:50:43.622234 ignition[881]: Ignition 2.24.0 Oct 21 16:50:43.622256 ignition[881]: Stage: disks Oct 21 16:50:43.622511 ignition[881]: no config dir at "/usr/lib/ignition/base.d" Oct 21 16:50:43.622528 ignition[881]: no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 21 16:50:43.623361 ignition[881]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-label/ROOT] Oct 21 16:50:43.633101 ignition[881]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-label/ROOT] Oct 21 16:50:43.633250 ignition[881]: disks: createFilesystems: created device alias for "/dev/disk/by-label/ROOT": "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" -> "/dev/sda9" Oct 21 16:50:43.633319 ignition[881]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-label/ROOT" Oct 21 16:50:43.673111 ignition[881]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-label/ROOT" Oct 21 16:50:43.673127 ignition[881]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-label/ROOT" with uuid "1f406373-0f20-497d-8155-eabffc61096e" and label "ROOT" Oct 21 16:50:43.673246 ignition[881]: disks: createFilesystems: op(3): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" Oct 21 16:50:43.673260 ignition[881]: disks: createFilesystems: op(3): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" Oct 21 16:50:43.701821 ignition[881]: disks: createFilesystems: op(3): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" Oct 21 16:50:43.701948 ignition[881]: disks: createFilesystems: op(4): [started] creating "btrfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" Oct 21 16:50:43.701975 ignition[881]: 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 21 16:50:43.835059 ignition[881]: disks: createFilesystems: op(4): [finished] creating "btrfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-label/ROOT" Oct 21 16:50:43.835230 ignition[881]: disks: createFilesystems: op(5): [started] waiting for triggered uevent Oct 21 16:50:43.835243 ignition[881]: disks: createFilesystems: op(5): executing: "udevadm" "trigger" "--settle" "/dev/sda9" Oct 21 16:50:43.965205 ignition[881]: disks: createFilesystems: op(5): [finished] waiting for triggered uevent Oct 21 16:50:43.965231 ignition[881]: disks: disks passed Oct 21 16:50:43.974549 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 21 16:50:43.987000 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 21 16:50:43.965321 ignition[881]: Ignition finished successfully Oct 21 16:50:43.992714 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 21 16:50:44.008274 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 21 16:50:44.033175 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 21 16:50:44.060118 systemd[1]: Reached target sysinit.target - System Initialization. Oct 21 16:50:44.060424 systemd[1]: Reached target basic.target - Basic System. Oct 21 16:50:44.091413 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 21 16:50:44.150389 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 21 16:50:44.148000 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 21 16:50:44.152947 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 21 16:50:44.215988 kernel: BTRFS: device label ROOT devid 1 transid 8 /dev/sda9 (8:9) scanned by mount (906) Oct 21 16:50:44.234293 kernel: BTRFS info (device sda9): first mount of filesystem 9aa5237a-ab6b-458b-a7e8-f25e2baef1a3 Oct 21 16:50:44.234391 kernel: BTRFS info (device sda9): using crc32c (crc32c-intel) checksum algorithm Oct 21 16:50:44.246052 kernel: BTRFS info (device sda9): checking UUID tree Oct 21 16:50:44.246152 kernel: BTRFS info (device sda9): enabling ssd optimizations Oct 21 16:50:44.257851 kernel: BTRFS info (device sda9): turning on async discard Oct 21 16:50:44.257955 kernel: BTRFS info (device sda9): enabling free space tree Oct 21 16:50:44.266141 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 21 16:50:44.267046 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 21 16:50:44.290515 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 21 16:50:44.314490 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent skipped, no trigger condition checks were met. Oct 21 16:50:44.314570 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Oct 21 16:50:44.314621 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 21 16:50:44.340809 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 21 16:50:44.356414 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 21 16:50:44.452197 systemd-tmpfiles[942]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:1: Duplicate line for path "/sysroot/var", ignoring. Oct 21 16:50:44.452272 systemd-tmpfiles[942]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:7: Duplicate line for path "/sysroot/var/empty", ignoring. Oct 21 16:50:44.452532 systemd-tmpfiles[942]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:28: Duplicate line for path "/sysroot/var/log", ignoring. Oct 21 16:50:44.637964 kernel: loop1: detected capacity change from 0 to 44360 Oct 21 16:50:44.657693 kernel: loop1: p1 p2 p3 Oct 21 16:50:44.736395 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:44.736516 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:44.745387 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:44.745507 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:44.751550 systemd-confext[996]: device-mapper: reload ioctl on loop1p1-12-verity (254:1) failed: Invalid argument Oct 21 16:50:44.772787 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:44.841938 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 21 16:50:44.871979 kernel: loop2: detected capacity change from 0 to 44360 Oct 21 16:50:44.880927 kernel: loop2: p1 p2 p3 Oct 21 16:50:44.905670 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:44.905773 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:44.916930 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:44.917035 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:44.920776 (sd-merge)[1006]: device-mapper: reload ioctl on loop2p1-16-verity (254:1) failed: Invalid argument Oct 21 16:50:44.940102 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:44.981962 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 21 16:50:44.982830 (sd-merge)[1006]: Using extensions '00-flatcar-default.raw'. Oct 21 16:50:44.984357 (sd-merge)[1006]: Merged extensions into '/sysroot/etc'. Oct 21 16:50:44.995319 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 21 16:50:45.007000 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 21 16:50:45.044710 initrd-setup-root[1013]: /etc 00-flatcar-default Wed 2026-10-21 16:50:39 UTC Oct 21 16:50:45.062118 kernel: kauditd_printk_skb: 26 callbacks suppressed Oct 21 16:50:45.012122 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 21 16:50:45.071365 kernel: audit: type=1130 audit(1792601445.007:38): 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 21 16:50:45.122932 ignition[1017]: INFO : Ignition 2.24.0 Oct 21 16:50:45.122932 ignition[1017]: INFO : Stage: mount Oct 21 16:50:45.138000 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 21 16:50:45.166299 kernel: audit: type=1130 audit(1792601445.138:39): 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 21 16:50:45.166349 ignition[1017]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 21 16:50:45.166349 ignition[1017]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 21 16:50:45.166349 ignition[1017]: INFO : mount: mount passed Oct 21 16:50:45.166349 ignition[1017]: INFO : Ignition finished successfully Oct 21 16:50:45.126271 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 21 16:50:45.143133 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 21 16:50:45.197190 systemd[1]: Mounting oem.mount - /oem... Oct 21 16:50:45.248935 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1025) Oct 21 16:50:45.267032 kernel: BTRFS info (device sda6): first mount of filesystem 3121944a-26f0-4a1d-9974-7c2fa600f45d Oct 21 16:50:45.267172 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Oct 21 16:50:45.288397 kernel: BTRFS info (device sda6): enabling ssd optimizations Oct 21 16:50:45.288538 kernel: BTRFS info (device sda6): turning on async discard Oct 21 16:50:45.288576 kernel: BTRFS info (device sda6): enabling free space tree Oct 21 16:50:45.299069 systemd[1]: Mounted oem.mount - /oem. Oct 21 16:50:45.302180 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 21 16:50:45.344002 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 21 16:50:45.391611 ignition[1043]: INFO : Ignition 2.24.0 Oct 21 16:50:45.391611 ignition[1043]: INFO : Stage: files Oct 21 16:50:45.406159 ignition[1043]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 21 16:50:45.406159 ignition[1043]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 21 16:50:45.406159 ignition[1043]: DEBUG : files: compiled without relabeling support, skipping Oct 21 16:50:45.406159 ignition[1043]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 21 16:50:45.406159 ignition[1043]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 21 16:50:45.406159 ignition[1043]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 21 16:50:45.406159 ignition[1043]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 21 16:50:45.406159 ignition[1043]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 21 16:50:45.406159 ignition[1043]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 21 16:50:45.406159 ignition[1043]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 21 16:50:45.406159 ignition[1043]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 21 16:50:45.406159 ignition[1043]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 21 16:50:45.406159 ignition[1043]: INFO : files: files passed Oct 21 16:50:45.406159 ignition[1043]: INFO : Ignition finished successfully Oct 21 16:50:45.420000 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 21 16:50:45.587000 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 21 16:50:45.587000 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 21 16:50:45.399813 unknown[1043]: wrote ssh authorized keys file for user: core Oct 21 16:50:45.663099 kernel: audit: type=1130 audit(1792601445.420:40): 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 21 16:50:45.403911 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 21 16:50:45.671130 kernel: audit: type=1130 audit(1792601445.587:41): 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 21 16:50:45.425240 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 21 16:50:45.680116 kernel: audit: type=1131 audit(1792601445.587:42): 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 21 16:50:45.471762 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 21 16:50:45.529708 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 21 16:50:45.705091 initrd-setup-root-after-ignition[1076]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 21 16:50:45.705091 initrd-setup-root-after-ignition[1076]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 21 16:50:45.765068 kernel: loop3: detected capacity change from 0 to 44360 Oct 21 16:50:45.529923 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 21 16:50:45.782085 initrd-setup-root-after-ignition[1079]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 21 16:50:45.795067 kernel: loop3: p1 p2 p3 Oct 21 16:50:45.761150 systemd-confext[1082]: device-mapper: reload ioctl on loop3p1-19-verity (254:2) failed: Invalid argument Oct 21 16:50:45.809101 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:45.809143 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:45.809167 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:45.809197 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:45.809219 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:45.823933 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 21 16:50:45.848999 kernel: loop4: detected capacity change from 0 to 44360 Oct 21 16:50:45.858937 kernel: loop4: p1 p2 p3 Oct 21 16:50:45.880935 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:45.889961 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:45.905469 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:45.905557 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:45.905549 (sd-merge)[1090]: device-mapper: reload ioctl on loop4p1-23-verity (254:2) failed: Invalid argument Oct 21 16:50:45.924253 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:45.961946 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 21 16:50:45.962075 (sd-merge)[1090]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 21 16:50:45.994946 kernel: loop4: detected capacity change from 0 to 198112 Oct 21 16:50:46.011143 kernel: loop4: p1 p2 p3 Oct 21 16:50:46.072558 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:46.072638 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:46.081951 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:46.088203 systemd-sysext[1098]: device-mapper: reload ioctl on loop4p1-27-verity (254:2) failed: Invalid argument Oct 21 16:50:46.108094 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:46.108142 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:46.168004 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 21 16:50:46.204030 kernel: loop5: detected capacity change from 0 to 388528 Oct 21 16:50:46.221939 kernel: loop5: p1 p2 p3 Oct 21 16:50:46.257984 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:46.258086 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:46.275564 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:46.283427 systemd-sysext[1098]: device-mapper: reload ioctl on loop5p1-31-verity (254:2) failed: Invalid argument Oct 21 16:50:46.304011 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:46.304053 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:46.386994 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 21 16:50:46.419003 kernel: loop6: detected capacity change from 0 to 183832 Oct 21 16:50:46.433082 kernel: loop6: p1 p2 p3 Oct 21 16:50:46.486930 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:46.487030 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:46.497946 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:46.498047 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:46.503681 systemd-sysext[1098]: device-mapper: reload ioctl on loop6p1-35-verity (254:2) failed: Invalid argument Oct 21 16:50:46.524416 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:46.580976 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 21 16:50:46.606953 kernel: loop7: detected capacity change from 0 to 198112 Oct 21 16:50:46.618921 kernel: loop7: p1 p2 p3 Oct 21 16:50:46.647184 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:46.647264 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:46.656409 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:46.662600 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:46.662746 (sd-merge)[1122]: device-mapper: reload ioctl on loop7p1-39-verity (254:2) failed: Invalid argument Oct 21 16:50:46.683123 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:46.735927 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 21 16:50:46.743945 kernel: loop1: detected capacity change from 0 to 388528 Oct 21 16:50:46.755945 kernel: loop1: p1 p2 p3 Oct 21 16:50:46.784498 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:46.784578 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:46.784606 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:46.798400 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:46.798474 (sd-merge)[1122]: device-mapper: reload ioctl on loop1p1-43-verity (254:3) failed: Invalid argument Oct 21 16:50:46.818064 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:46.893948 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Oct 21 16:50:46.904934 kernel: loop3: detected capacity change from 0 to 183832 Oct 21 16:50:46.913931 kernel: loop3: p1 p2 p3 Oct 21 16:50:46.936423 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:46.958933 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:46.959028 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:46.959057 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:46.965640 (sd-merge)[1122]: device-mapper: reload ioctl on loop3p1-47-verity (254:4) failed: Invalid argument Oct 21 16:50:46.985101 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:47.035004 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Oct 21 16:50:47.035841 (sd-merge)[1122]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-gce-4757.2.2.raw'. Oct 21 16:50:47.037797 (sd-merge)[1122]: Merged extensions into '/sysroot/usr'. Oct 21 16:50:47.056000 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 21 16:50:47.087417 kernel: audit: type=1130 audit(1792601447.056:43): 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 21 16:50:47.041290 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 21 16:50:47.060676 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 21 16:50:47.138145 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 21 16:50:47.138372 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 21 16:50:47.154000 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 21 16:50:47.154000 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 21 16:50:47.208318 kernel: audit: type=1130 audit(1792601447.154:44): 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 21 16:50:47.156227 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Oct 21 16:50:47.226262 kernel: audit: type=1131 audit(1792601447.154: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 21 16:50:47.157144 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 21 16:50:47.219024 systemd[1]: Starting dracut-mount.service - dracut mount hook... Oct 21 16:50:47.294558 systemd[1]: Finished dracut-mount.service - dracut mount hook. Oct 21 16:50:47.292000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:50:47.330223 kernel: audit: type=1130 audit(1792601447.292:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:50:47.307520 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 21 16:50:47.381090 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 21 16:50:47.379000 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 21 16:50:47.420249 kernel: audit: type=1130 audit(1792601447.379: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 21 16:50:47.383683 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 21 16:50:47.453600 systemd[1]: Stopped target basic.target - Basic System. Oct 21 16:50:47.454101 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 21 16:50:47.487288 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 21 16:50:47.504309 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 21 16:50:47.504782 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 21 16:50:47.541346 systemd[1]: Stopped target paths.target - Path Units. Oct 21 16:50:47.541885 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 21 16:50:47.556512 systemd[1]: Stopped target slices.target - Slice Units. Oct 21 16:50:47.589277 systemd[1]: Stopped target sockets.target - Socket Units. Oct 21 16:50:47.589726 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 21 16:50:47.604517 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 21 16:50:47.636421 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Oct 21 16:50:47.656339 systemd[1]: Stopped target swap.target - Swaps. Oct 21 16:50:47.669333 systemd[1]: Stopped target timers.target - Timer Units. Oct 21 16:50:47.684396 systemd[1]: iscsid.socket: Deactivated successfully. Oct 21 16:50:47.684811 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 21 16:50:47.708408 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 21 16:50:47.708875 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 21 16:50:47.716849 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 21 16:50:47.717095 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Oct 21 16:50:47.742774 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Oct 21 16:50:47.742983 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Oct 21 16:50:47.784000 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 21 16:50:47.759785 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 21 16:50:47.760196 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 21 16:50:47.786754 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 21 16:50:47.804597 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 21 16:50:47.831474 systemd[1]: dracut-mount.service: Deactivated successfully. Oct 21 16:50:47.858000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:50:47.831732 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Oct 21 16:50:47.875000 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 21 16:50:47.860846 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 21 16:50:47.861145 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 21 16:50:47.877747 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 21 16:50:47.894554 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 21 16:50:47.895345 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 21 16:50:47.902834 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 21 16:50:47.978000 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 21 16:50:47.921654 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 21 16:50:47.998000 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 21 16:50:47.922369 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 21 16:50:48.015000 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 21 16:50:47.940821 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 21 16:50:47.941146 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 21 16:50:48.053000 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 21 16:50:47.980778 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 21 16:50:47.981113 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 21 16:50:48.083000 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 21 16:50:48.000766 systemd[1]: ignition-files.service: Deactivated successfully. Oct 21 16:50:48.104162 ignition[1164]: INFO : Ignition 2.24.0 Oct 21 16:50:48.104162 ignition[1164]: INFO : Stage: umount Oct 21 16:50:48.104162 ignition[1164]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 21 16:50:48.104162 ignition[1164]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/gcp" Oct 21 16:50:48.104162 ignition[1164]: INFO : umount: umount passed Oct 21 16:50:48.104162 ignition[1164]: INFO : Ignition finished successfully Oct 21 16:50:48.112000 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 21 16:50:48.133000 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 21 16:50:48.151000 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 21 16:50:48.001099 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 21 16:50:48.192000 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 21 16:50:48.019514 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 21 16:50:48.209000 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 21 16:50:48.038211 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 21 16:50:48.227000 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 21 16:50:48.038584 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 21 16:50:48.055618 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 21 16:50:48.055840 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 21 16:50:48.086107 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 21 16:50:48.290000 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 21 16:50:48.086412 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 21 16:50:48.308000 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 21 16:50:48.114597 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 21 16:50:48.327000 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 21 16:50:48.327000 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 21 16:50:48.328000 audit: BPF prog-id=5 op=UNLOAD Oct 21 16:50:48.331000 audit: BPF prog-id=8 op=UNLOAD Oct 21 16:50:48.114855 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 21 16:50:48.139669 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 21 16:50:48.139863 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 21 16:50:48.155733 systemd[1]: Stopped target network.target - Network. Oct 21 16:50:48.176433 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 21 16:50:48.176538 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 21 16:50:48.194541 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 21 16:50:48.194635 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 21 16:50:48.441000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:50:48.211392 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 21 16:50:48.211515 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 21 16:50:48.229591 systemd[1]: Stopping systemd-networkd.service - Network Management... Oct 21 16:50:48.490000 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 21 16:50:48.248710 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 21 16:50:48.274190 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 21 16:50:48.527000 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 21 16:50:48.274399 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 21 16:50:48.544000 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 21 16:50:48.296129 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 21 16:50:48.564000 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 21 16:50:48.296351 systemd[1]: Stopped systemd-networkd.service - Network Management. Oct 21 16:50:48.314688 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 21 16:50:48.314883 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 21 16:50:48.598000 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 21 16:50:48.334256 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Oct 21 16:50:48.334352 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 21 16:50:48.348406 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 21 16:50:48.650000 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 21 16:50:48.366298 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 21 16:50:48.670000 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 21 16:50:48.366419 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Oct 21 16:50:48.689000 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 21 16:50:48.375974 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 21 16:50:48.710000 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 21 16:50:48.408049 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 21 16:50:48.728000 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 21 16:50:48.408214 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 21 16:50:48.747000 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 21 16:50:48.747000 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 21 16:50:48.443534 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 21 16:50:48.473162 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 21 16:50:48.473424 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 21 16:50:48.492288 systemd[1]: systemd-udevd.service: Consumed 2.348s CPU time over 7.631s wall clock time. Oct 21 16:50:48.495646 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 21 16:50:48.495796 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 21 16:50:48.511360 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 21 16:50:48.511472 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 21 16:50:48.529360 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 21 16:50:48.529473 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 21 16:50:48.546319 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 21 16:50:48.546428 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 21 16:50:48.898305 systemd-journald[268]: Received SIGTERM from PID 1 (systemd). Oct 21 16:50:48.575639 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 21 16:50:48.592103 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 21 16:50:48.592430 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 21 16:50:48.600606 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 21 16:50:48.600686 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 21 16:50:48.652349 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 21 16:50:48.652449 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 21 16:50:48.672351 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 21 16:50:48.672448 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 21 16:50:48.691336 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 21 16:50:49.038000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 21 16:50:48.691451 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 16:50:49.070142 kernel: SELinux: policy capability network_peer_controls=1 Oct 21 16:50:48.713470 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 21 16:50:49.078166 kernel: SELinux: policy capability open_perms=1 Oct 21 16:50:48.713656 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 21 16:50:49.079132 kernel: SELinux: policy capability extended_socket_class=1 Oct 21 16:50:48.731078 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 21 16:50:49.079261 kernel: SELinux: policy capability always_check_network=0 Oct 21 16:50:48.731282 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 21 16:50:49.079391 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 21 16:50:48.751114 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 21 16:50:49.079525 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 21 16:50:48.771629 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 21 16:50:49.079597 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 21 16:50:48.839142 systemd[1]: Switching root. Oct 21 16:50:49.079672 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 21 16:50:49.079688 kernel: SELinux: policy capability userspace_initial_context=0 Oct 21 16:50:49.079704 systemd[1]: Successfully loaded SELinux policy in 101.209ms. Oct 21 16:50:49.079724 systemd-journald[268]: Journal stopped Oct 21 16:50:52.928496 kernel: NET: Registered PF_VSOCK protocol family Oct 21 16:50:52.928569 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 13.731ms. Oct 21 16:50:52.928599 systemd[1]: systemd 260.4 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 21 16:50:52.928628 systemd[1]: Detected virtualization google. Oct 21 16:50:52.928648 systemd[1]: Detected architecture x86-64. Oct 21 16:50:52.928668 systemd[1]: Detected first boot. Oct 21 16:50:52.928688 systemd[1]: Initializing machine ID from random generator. Oct 21 16:50:52.928709 kernel: kauditd_printk_skb: 35 callbacks suppressed Oct 21 16:50:52.928736 kernel: audit: type=1334 audit(1792601450.282:83): prog-id=9 op=LOAD Oct 21 16:50:52.928756 kernel: audit: type=1334 audit(1792601450.283:84): prog-id=9 op=UNLOAD Oct 21 16:50:52.928777 zram_generator::config[1204]: No configuration found. Oct 21 16:50:52.928800 systemd[1]: Applying preset policy. Oct 21 16:50:52.928824 systemd[1]: Created symlink '/etc/systemd/system/timers.target.wants/google-oslogin-cache.timer' → '/usr/lib/systemd/system/google-oslogin-cache.timer'. Oct 21 16:50:52.928846 systemd[1]: Populated /etc with preset unit settings. Oct 21 16:50:52.928874 kernel: audit: type=1334 audit(1792601451.369:85): prog-id=10 op=LOAD Oct 21 16:50:52.928912 kernel: audit: type=1334 audit(1792601451.369:86): prog-id=2 op=UNLOAD Oct 21 16:50:52.928935 kernel: audit: type=1334 audit(1792601451.369:87): prog-id=11 op=LOAD Oct 21 16:50:52.928956 kernel: audit: type=1334 audit(1792601451.369:88): prog-id=12 op=LOAD Oct 21 16:50:52.928980 kernel: audit: type=1334 audit(1792601451.369:89): prog-id=3 op=UNLOAD Oct 21 16:50:52.929002 kernel: audit: type=1334 audit(1792601451.369:90): prog-id=4 op=UNLOAD Oct 21 16:50:52.929022 kernel: audit: type=1334 audit(1792601451.397:91): prog-id=10 op=UNLOAD Oct 21 16:50:52.929044 kernel: audit: type=1131 audit(1792601451.425:92): 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 21 16:50:52.929067 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 21 16:50:52.929090 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 21 16:50:52.929111 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 21 16:50:52.929138 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 21 16:50:52.929169 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 21 16:50:52.929192 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 21 16:50:52.929216 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 21 16:50:52.929238 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 21 16:50:52.929265 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 21 16:50:52.929289 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 21 16:50:52.929312 systemd[1]: Created slice user.slice - User and Session Slice. Oct 21 16:50:52.929334 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 21 16:50:52.929358 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 21 16:50:52.929381 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 21 16:50:52.929405 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 21 16:50:52.929432 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 21 16:50:52.929456 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 21 16:50:52.929479 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 21 16:50:52.929507 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 21 16:50:52.929530 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 21 16:50:52.929554 systemd[1]: Reached target imports.target - Image Downloads. Oct 21 16:50:52.929578 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 21 16:50:52.929606 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 21 16:50:52.929629 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 21 16:50:52.929652 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 21 16:50:52.929691 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 21 16:50:52.929715 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 21 16:50:52.929737 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Oct 21 16:50:52.929761 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Oct 21 16:50:52.929788 systemd[1]: Reached target slices.target - Slice Units. Oct 21 16:50:52.929812 systemd[1]: Reached target swap.target - Swaps. Oct 21 16:50:52.929837 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 21 16:50:52.929864 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 21 16:50:52.929888 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 21 16:50:52.929927 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 21 16:50:52.929951 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Oct 21 16:50:52.929974 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 21 16:50:52.929998 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Oct 21 16:50:52.930026 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Oct 21 16:50:52.930050 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Oct 21 16:50:52.930074 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Oct 21 16:50:52.930098 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 21 16:50:52.930124 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Oct 21 16:50:52.930148 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Oct 21 16:50:52.930181 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Oct 21 16:50:52.930209 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Oct 21 16:50:52.930234 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Oct 21 16:50:52.930257 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 21 16:50:52.930281 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 21 16:50:52.930304 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 21 16:50:52.930328 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 21 16:50:52.930356 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 21 16:50:52.930379 systemd[1]: Mounting media.mount - External Media Directory... Oct 21 16:50:52.930403 systemd[1]: proc-xen.mount - /proc/xen skipped, unmet condition check ConditionVirtualization=xen Oct 21 16:50:52.930426 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 21 16:50:52.930450 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 21 16:50:52.930474 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Oct 21 16:50:52.930497 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 21 16:50:52.930525 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 21 16:50:52.930550 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Oct 21 16:50:52.930574 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 21 16:50:52.930597 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 21 16:50:52.930621 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Oct 21 16:50:52.930647 systemd[1]: modprobe@efi_pstore.service - Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore Oct 21 16:50:52.930671 systemd[1]: modprobe@fuse.service - Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse Oct 21 16:50:52.930709 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 21 16:50:52.930735 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Oct 21 16:50:52.930759 systemd[1]: Starting setup-oem.service - Setup OEM... Oct 21 16:50:52.930783 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 21 16:50:52.930806 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 21 16:50:52.930831 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 21 16:50:52.930859 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 21 16:50:52.930883 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 21 16:50:52.930919 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 21 16:50:52.930943 systemd[1]: Reached target time-set.target - System Time Set. Oct 21 16:50:52.931019 systemd-journald[1289]: Collecting audit messages is enabled. Oct 21 16:50:52.931071 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 21 16:50:52.931100 systemd-journald[1289]: Journal started Oct 21 16:50:52.931144 systemd-journald[1289]: Runtime Journal (/run/log/journal/c4e773bfcf5e455580f0a92355236c65) is 8M, max 148.4M, 140.4M free. Oct 21 16:50:52.124000 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 21 16:50:52.799000 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 21 16:50:52.820000 audit: BPF prog-id=12 op=UNLOAD Oct 21 16:50:52.820000 audit: BPF prog-id=11 op=UNLOAD Oct 21 16:50:52.822000 audit: BPF prog-id=13 op=LOAD Oct 21 16:50:52.822000 audit: BPF prog-id=14 op=LOAD Oct 21 16:50:52.822000 audit: BPF prog-id=15 op=LOAD Oct 21 16:50:51.361770 systemd[1]: Queued start job for default target multi-user.target. Oct 21 16:50:52.920000 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 21 16:50:52.920000 audit[1289]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=3 a1=7ffebcb37010 a2=4000 a3=0 items=0 ppid=1 pid=1289 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 21 16:50:52.920000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 21 16:50:51.372718 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Oct 21 16:50:51.373759 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 21 16:50:52.902789 systemd-modules-load[1290]: Using 2 probe threads Oct 21 16:50:52.957954 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 21 16:50:52.978981 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 21 16:50:53.007935 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer skipped, unmet condition check ConditionVirtualization=xen Oct 21 16:50:53.020029 systemd[1]: Started systemd-journald.service - Journal Service. Oct 21 16:50:53.028000 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 21 16:50:53.032392 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 21 16:50:53.041640 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 21 16:50:53.053596 systemd[1]: Mounted media.mount - External Media Directory. Oct 21 16:50:53.064970 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 21 16:50:53.074441 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 21 16:50:53.084428 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 21 16:50:53.093702 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 21 16:50:53.103000 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 21 16:50:53.106217 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 21 16:50:53.115000 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 21 16:50:53.117856 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 21 16:50:53.118482 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 21 16:50:53.127000 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 21 16:50:53.127000 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 21 16:50:53.129512 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 21 16:50:53.142808 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 21 16:50:53.150000 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 21 16:50:53.154843 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 21 16:50:53.163000 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 21 16:50:53.169221 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 21 16:50:53.178000 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 21 16:50:53.181181 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 21 16:50:53.190000 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 21 16:50:53.195643 systemd[1]: Finished setup-oem.service - Setup OEM. Oct 21 16:50:53.201000 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 21 16:50:53.222284 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 21 16:50:53.233002 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 21 16:50:53.245389 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 21 16:50:53.256128 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Oct 21 16:50:53.266234 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 21 16:50:53.278178 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 21 16:50:53.289319 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Oct 21 16:50:53.293640 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 21 16:50:53.305682 systemd-journald[1289]: Time spent on flushing to /var/log/journal/c4e773bfcf5e455580f0a92355236c65 is 56.234ms for 1173 entries. Oct 21 16:50:53.305682 systemd-journald[1289]: System Journal (/var/log/journal/c4e773bfcf5e455580f0a92355236c65) is 8M, max 632M, 624M free. Oct 21 16:50:53.377000 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 21 16:50:53.403000 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 21 16:50:53.313269 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 21 16:50:53.438889 systemd-journald[1289]: Received client request to flush runtime journal. Oct 21 16:50:53.358095 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 21 16:50:53.439400 systemd-journald[1289]: Creating journal file /var/log/journal/c4e773bfcf5e455580f0a92355236c65/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 21 16:50:53.365054 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 21 16:50:53.379545 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 21 16:50:53.395302 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 21 16:50:53.410031 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 21 16:50:53.438112 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 21 16:50:53.446000 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 21 16:50:53.449433 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 21 16:50:53.457000 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 21 16:50:53.470163 systemd-tmpfiles[1320]: ACLs are not supported, ignoring. Oct 21 16:50:53.470202 systemd-tmpfiles[1320]: ACLs are not supported, ignoring. Oct 21 16:50:53.479099 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 21 16:50:53.488000 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 21 16:50:53.495241 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 21 16:50:53.580924 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 21 16:50:53.588000 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 21 16:50:53.595623 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Oct 21 16:50:53.607000 audit: BPF prog-id=16 op=LOAD Oct 21 16:50:53.607000 audit: BPF prog-id=17 op=LOAD Oct 21 16:50:53.607000 audit: BPF prog-id=18 op=LOAD Oct 21 16:50:53.615268 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Oct 21 16:50:53.626000 audit: BPF prog-id=19 op=LOAD Oct 21 16:50:53.631241 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 21 16:50:53.645519 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 21 16:50:53.657210 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 21 16:50:53.675211 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Oct 21 16:50:53.684000 audit: BPF prog-id=20 op=LOAD Oct 21 16:50:53.684000 audit: BPF prog-id=21 op=LOAD Oct 21 16:50:53.685000 audit: BPF prog-id=22 op=LOAD Oct 21 16:50:53.692331 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 21 16:50:53.706250 systemd-tmpfiles[1334]: ACLs are not supported, ignoring. Oct 21 16:50:53.707990 systemd-tmpfiles[1334]: ACLs are not supported, ignoring. Oct 21 16:50:53.723332 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 21 16:50:53.738000 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 21 16:50:53.740461 kernel: tun: Universal TUN/TAP device driver, 1.6 Oct 21 16:50:53.743035 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 21 16:50:53.755588 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Oct 21 16:50:53.757001 systemd[1]: modprobe@tun.service: Deactivated successfully. Oct 21 16:50:53.757962 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Oct 21 16:50:53.765000 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 21 16:50:53.765000 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 21 16:50:53.767404 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1336 ((systemd-userd)) Oct 21 16:50:53.769000 audit: BPF prog-id=23 op=LOAD Oct 21 16:50:53.769000 audit: BPF prog-id=24 op=LOAD Oct 21 16:50:53.769000 audit: BPF prog-id=25 op=LOAD Oct 21 16:50:53.774411 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Oct 21 16:50:54.013261 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Oct 21 16:50:54.024073 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Oct 21 16:50:54.024598 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 21 16:50:54.034113 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Oct 21 16:50:54.046586 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 21 16:50:54.059102 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 21 16:50:54.072329 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Oct 21 16:50:54.087348 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 21 16:50:54.101359 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Oct 21 16:50:54.118660 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Oct 21 16:50:54.141838 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Oct 21 16:50:54.175008 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 21 16:50:54.177431 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 21 16:50:54.187964 kernel: loop4: detected capacity change from 0 to 44360 Oct 21 16:50:54.194000 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 21 16:50:54.200710 kernel: loop4: p1 p2 p3 Oct 21 16:50:54.202601 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Oct 21 16:50:54.211000 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 21 16:50:54.243932 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:54.266647 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:54.270021 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:54.270112 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:54.278008 systemd-confext[1346]: device-mapper: reload ioctl on loop4p1-51-verity (254:5) failed: Invalid argument Oct 21 16:50:54.278890 systemd-nsresourced[1339]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Oct 21 16:50:54.284693 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 21 16:50:54.295659 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:54.298000 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 21 16:50:54.300310 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Oct 21 16:50:54.309000 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 21 16:50:54.425654 systemd-oomd[1332]: No swap; memory pressure usage will be degraded Oct 21 16:50:54.428644 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Oct 21 16:50:54.437000 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 21 16:50:54.478582 systemd-resolved[1333]: Positive Trust Anchors: Oct 21 16:50:54.479326 systemd-resolved[1333]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 21 16:50:54.479468 systemd-resolved[1333]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 21 16:50:54.479605 systemd-resolved[1333]: 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 21 16:50:54.486207 systemd-resolved[1333]: Defaulting to hostname 'linux'. Oct 21 16:50:54.488887 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 21 16:50:54.496000 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 21 16:50:54.498675 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 21 16:50:54.626728 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 21 16:50:54.635000 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 21 16:50:54.636000 audit: BPF prog-id=7 op=UNLOAD Oct 21 16:50:54.636000 audit: BPF prog-id=6 op=UNLOAD Oct 21 16:50:54.637000 audit: BPF prog-id=26 op=LOAD Oct 21 16:50:54.637000 audit: BPF prog-id=27 op=LOAD Oct 21 16:50:54.640794 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 21 16:50:54.714145 systemd-udevd[1368]: Using default interface naming scheme 'v260'. Oct 21 16:50:54.810731 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 21 16:50:54.819000 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 21 16:50:54.822000 audit: BPF prog-id=28 op=LOAD Oct 21 16:50:54.828263 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 21 16:50:54.942230 systemd[1]: modprobe@fuse.service - Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse Oct 21 16:50:55.031164 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 21 16:50:55.071039 systemd[1]: Condition check resulted in dev-tpmrm0.device - /dev/tpmrm0 being skipped. Oct 21 16:50:55.071185 systemd[1]: Expecting device dev-tpm0.device - /dev/tpm0... Oct 21 16:50:55.074886 systemd-networkd[1370]: lo: Link UP Oct 21 16:50:55.074924 systemd-networkd[1370]: lo: Gained carrier Oct 21 16:50:55.079323 systemd[1]: Started systemd-networkd.service - Network Management. Oct 21 16:50:55.086000 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 21 16:50:55.089532 systemd[1]: Reached target network.target - Network. Oct 21 16:50:55.100336 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 21 16:50:55.116420 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Oct 21 16:50:55.215998 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 21 16:50:55.224000 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 21 16:50:55.343947 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 Oct 21 16:50:55.358936 kernel: mousedev: PS/2 mouse device common for all mice Oct 21 16:50:55.369521 systemd-networkd[1370]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 21 16:50:55.369851 systemd-networkd[1370]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 21 16:50:55.371446 systemd-networkd[1370]: eth0: Link UP Oct 21 16:50:55.373111 systemd-networkd[1370]: eth0: Gained carrier Oct 21 16:50:55.373161 systemd-networkd[1370]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 21 16:50:55.375930 kernel: ACPI: button: Power Button [PWRF] Oct 21 16:50:55.384013 systemd-networkd[1370]: eth0: DHCPv4 address 10.128.0.21/32, gateway 10.128.0.1 acquired from 169.254.169.254 Oct 21 16:50:55.398776 kernel: piix4_smbus 0000:00:01.3: SMBus base address uninitialized - upgrade BIOS or use force_addr=0xaddr Oct 21 16:50:55.399533 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input5 Oct 21 16:50:55.407336 systemd[1]: Condition check resulted in dev-tpm0.device - /dev/tpm0 being skipped. Oct 21 16:50:55.414348 systemd[1]: Reached target tpm2.target - Trusted Platform Module. Oct 21 16:50:55.460232 kernel: ACPI: button: Sleep Button [SLPF] Oct 21 16:50:55.585050 kernel: EDAC MC: Ver: 3.0.0 Oct 21 16:50:55.823654 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 21 16:50:55.894205 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - PersistentDisk OEM. Oct 21 16:50:55.899471 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 21 16:50:55.979601 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 21 16:50:55.978000 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 21 16:50:56.024275 kernel: kauditd_printk_skb: 56 callbacks suppressed Oct 21 16:50:56.024338 kernel: audit: type=1130 audit(1792601455.978:147): 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 21 16:50:56.024393 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 21 16:50:56.029165 systemd-vconsole-setup[1434]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 21 16:50:56.034959 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 16:50:56.044000 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 21 16:50:56.071936 kernel: audit: type=1130 audit(1792601456.044:148): 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 21 16:50:56.084112 kernel: loop4: detected capacity change from 0 to 44360 Oct 21 16:50:56.098973 kernel: loop4: p1 p2 p3 Oct 21 16:50:56.125789 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.125949 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:56.134945 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:56.141825 (sd-merge)[1443]: device-mapper: reload ioctl on loop4p1-56-verity (254:5) failed: Invalid argument Oct 21 16:50:56.142633 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:56.152120 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.190935 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 21 16:50:56.191568 (sd-merge)[1443]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 21 16:50:56.194467 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Oct 21 16:50:56.203000 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 21 16:50:56.211358 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 21 16:50:56.230080 kernel: audit: type=1130 audit(1792601456.203:149): 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 21 16:50:56.264953 kernel: loop4: detected capacity change from 0 to 198112 Oct 21 16:50:56.276929 kernel: loop4: p1 p2 p3 Oct 21 16:50:56.311448 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.311577 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:56.321233 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:56.328043 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:56.328223 systemd-sysext[1453]: device-mapper: reload ioctl on loop4p1-60-verity (254:5) failed: Invalid argument Oct 21 16:50:56.340027 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.385947 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 21 16:50:56.395061 systemd-networkd[1370]: eth0: Gained IPv6LL Oct 21 16:50:56.400947 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Oct 21 16:50:56.414031 kernel: loop4: detected capacity change from 0 to 388528 Oct 21 16:50:56.415000 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 21 16:50:56.425069 systemd[1]: Reached target network-online.target - Network is Online. Oct 21 16:50:56.441106 kernel: audit: type=1130 audit(1792601456.415:150): 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 21 16:50:56.449960 kernel: loop4: p1 p2 p3 Oct 21 16:50:56.466929 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.467063 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:56.490935 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:56.491088 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:56.491005 systemd-sysext[1453]: device-mapper: reload ioctl on loop4p1-65-verity (254:5) failed: Invalid argument Oct 21 16:50:56.499948 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.558995 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 21 16:50:56.584956 kernel: loop4: detected capacity change from 0 to 183832 Oct 21 16:50:56.591961 kernel: loop4: p1 p2 p3 Oct 21 16:50:56.620085 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.620222 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:56.620264 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:56.636943 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:56.635150 systemd-sysext[1453]: device-mapper: reload ioctl on loop4p1-70-verity (254:5) failed: Invalid argument Oct 21 16:50:56.643984 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.698043 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 21 16:50:56.730025 kernel: loop4: detected capacity change from 0 to 198112 Oct 21 16:50:56.739957 kernel: loop4: p1 p2 p3 Oct 21 16:50:56.763453 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.763579 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:56.763613 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:56.778575 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:56.778681 (sd-merge)[1480]: device-mapper: reload ioctl on loop4p1-75-verity (254:5) failed: Invalid argument Oct 21 16:50:56.790043 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.843462 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 21 16:50:56.853039 kernel: loop5: detected capacity change from 0 to 388528 Oct 21 16:50:56.864945 kernel: loop5: p1 p2 p3 Oct 21 16:50:56.888071 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.888304 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:56.888356 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:56.903102 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:56.903229 (sd-merge)[1480]: device-mapper: reload ioctl on loop5p1-79-verity (254:6) failed: Invalid argument Oct 21 16:50:56.911946 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:56.983002 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Oct 21 16:50:56.996281 kernel: loop6: detected capacity change from 0 to 183832 Oct 21 16:50:57.008928 kernel: loop6: p1 p2 p3 Oct 21 16:50:57.035579 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:57.035735 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 21 16:50:57.045701 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Oct 21 16:50:57.052592 kernel: device-mapper: ioctl: error adding target to table Oct 21 16:50:57.052750 (sd-merge)[1480]: device-mapper: reload ioctl on loop6p1-83-verity (254:7) failed: Invalid argument Oct 21 16:50:57.061986 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Oct 21 16:50:57.108946 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Oct 21 16:50:57.110424 (sd-merge)[1480]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 21 16:50:57.114954 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 21 16:50:57.124000 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 21 16:50:57.149039 kernel: audit: type=1130 audit(1792601457.124:151): 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 21 16:50:57.157207 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 21 16:50:57.199122 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/base_image_var.conf:29: Duplicate line for path "/var/log/audit", ignoring. Oct 21 16:50:57.201768 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/base_image_var_late.conf:44: Duplicate line for path "/var/log/audit", ignoring. Oct 21 16:50:57.202349 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/baselayout.conf:15: Duplicate line for path "/var", ignoring. Oct 21 16:50:57.202371 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/baselayout.conf:16: Duplicate line for path "/var/empty", ignoring. Oct 21 16:50:57.202411 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/baselayout.conf:21: Duplicate line for path "/var/log", ignoring. Oct 21 16:50:57.202669 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/dbus.conf:5: Duplicate line for path "/var/lib/dbus", ignoring. Oct 21 16:50:57.203314 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/nfs-utils.conf:2: Duplicate line for path "/var/lib/nfs/v4recovery", ignoring. Oct 21 16:50:57.206787 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 21 16:50:57.206840 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 21 16:50:57.207310 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 21 16:50:57.209275 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/tpm2-tss-fapi.conf:2: Duplicate line for path "/var/lib/tpm2-tss/system/keystore", ignoring. Oct 21 16:50:57.209304 systemd-tmpfiles[1503]: ACLs are not supported, ignoring. Oct 21 16:50:57.209426 systemd-tmpfiles[1503]: ACLs are not supported, ignoring. Oct 21 16:50:57.211042 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/var.conf:10: Duplicate line for path "/var", ignoring. Oct 21 16:50:57.211076 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 21 16:50:57.211279 systemd-tmpfiles[1503]: /usr/lib/tmpfiles.d/var.conf:21: Duplicate line for path "/var/lib", ignoring. Oct 21 16:50:57.219755 systemd-tmpfiles[1503]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 21 16:50:57.219779 systemd-tmpfiles[1503]: Skipping /boot Oct 21 16:50:57.234443 systemd-tmpfiles[1503]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 21 16:50:57.234468 systemd-tmpfiles[1503]: Skipping /boot Oct 21 16:50:57.254400 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 21 16:50:57.263000 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 21 16:50:57.270999 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 21 16:50:57.288951 kernel: audit: type=1130 audit(1792601457.263:152): 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 21 16:50:57.290561 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 21 16:50:57.308494 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 21 16:50:57.321936 systemd[1]: Starting oem-gce-enable-oslogin.service - Enable GCE OS Login... Oct 21 16:50:57.336794 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 21 16:50:57.349301 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 21 16:50:57.398000 audit[1517]: AUDIT1127 pid=1517 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 21 16:50:57.421088 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 21 16:50:57.434589 kernel: audit: type=1127 audit(1792601457.398:153): pid=1517 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 21 16:50:57.445000 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 21 16:50:57.472325 kernel: audit: type=1130 audit(1792601457.445:154): 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 21 16:50:57.475168 systemd[1]: Finished oem-gce-enable-oslogin.service - Enable GCE OS Login. Oct 21 16:50:57.483000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=oem-gce-enable-oslogin comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:50:57.509955 kernel: audit: type=1130 audit(1792601457.483:155): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=oem-gce-enable-oslogin comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:50:57.533000 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 21 16:50:57.544559 augenrules[1542]: No rules Oct 21 16:50:57.533000 audit[1542]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffffaff7f50 a2=420 a3=0 items=0 ppid=1506 pid=1542 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 21 16:50:57.533000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 21 16:50:57.551267 kernel: audit: type=1305 audit(1792601457.533:156): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 21 16:50:57.549683 systemd[1]: audit-rules.service: Deactivated successfully. Oct 21 16:50:57.550817 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 21 16:50:57.560795 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 21 16:50:57.571634 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 21 16:50:57.585947 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 21 16:50:58.455058 ldconfig[1508]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 21 16:50:58.464068 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 21 16:50:58.475862 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 21 16:50:58.506884 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 21 16:50:58.517700 systemd[1]: Reached target sysinit.target - System Initialization. Oct 21 16:50:58.527409 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 21 16:50:58.538341 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 21 16:50:58.549220 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Oct 21 16:50:58.560534 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 21 16:50:58.570484 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 21 16:50:58.582452 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Oct 21 16:50:58.593686 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Oct 21 16:50:58.603261 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 21 16:50:58.614221 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Oct 21 16:50:58.614377 systemd[1]: Reached target paths.target - Path Units. Oct 21 16:50:58.622189 systemd[1]: Reached target timers.target - Timer Units. Oct 21 16:50:58.632707 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 21 16:50:58.644660 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 21 16:50:58.657725 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 21 16:50:58.680326 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 21 16:50:58.689928 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 21 16:50:58.700780 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Oct 21 16:50:58.711862 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 21 16:50:58.723377 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 21 16:50:58.733749 systemd[1]: Reached target sockets.target - Socket Units. Oct 21 16:50:58.743250 systemd[1]: Reached target basic.target - Basic System. Oct 21 16:50:58.751307 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Oct 21 16:50:58.751378 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Oct 21 16:50:58.753484 systemd[1]: Starting containerd.service - containerd container runtime... Oct 21 16:50:58.776281 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 21 16:50:58.786674 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 21 16:50:58.802573 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 21 16:50:58.818553 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 21 16:50:58.827097 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Oct 21 16:50:58.827740 jq[1558]: false Oct 21 16:50:58.829492 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Oct 21 16:50:58.843853 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 21 16:50:58.857634 systemd[1]: Started ntpd.service - Network Time Service. Oct 21 16:50:58.863286 extend-filesystems[1559]: Found /dev/sda6 Oct 21 16:50:58.871226 google_oslogin_nss_cache[1560]: oslogin_cache_refresh[1560]: Refreshing passwd entry cache Oct 21 16:50:58.871068 oslogin_cache_refresh[1560]: Refreshing passwd entry cache Oct 21 16:50:58.874441 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 21 16:50:58.880816 extend-filesystems[1559]: Found /dev/sda9 Oct 21 16:50:58.890179 extend-filesystems[1559]: Checking size of /dev/sda9 Oct 21 16:50:58.887713 systemd[1]: Starting oem-gce.service - GCE Linux Agent... Oct 21 16:50:58.902835 google_oslogin_nss_cache[1560]: oslogin_cache_refresh[1560]: Failure getting users, quitting Oct 21 16:50:58.902835 google_oslogin_nss_cache[1560]: oslogin_cache_refresh[1560]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Oct 21 16:50:58.902835 google_oslogin_nss_cache[1560]: oslogin_cache_refresh[1560]: Refreshing group entry cache Oct 21 16:50:58.902062 oslogin_cache_refresh[1560]: Failure getting users, quitting Oct 21 16:50:58.902100 oslogin_cache_refresh[1560]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Oct 21 16:50:58.903451 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 21 16:50:58.902203 oslogin_cache_refresh[1560]: Refreshing group entry cache Oct 21 16:50:58.914949 motdgen[1579]: /oem/oem-release: line 2: Compute: command not found Oct 21 16:50:58.916889 extend-filesystems[1559]: Resized partition /dev/sda9 Oct 21 16:50:58.929284 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 21 16:50:58.952376 google_oslogin_nss_cache[1560]: oslogin_cache_refresh[1560]: Failure getting groups, quitting Oct 21 16:50:58.952376 google_oslogin_nss_cache[1560]: oslogin_cache_refresh[1560]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Oct 21 16:50:58.926034 oslogin_cache_refresh[1560]: Failure getting groups, quitting Oct 21 16:50:58.947434 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 21 16:50:58.926062 oslogin_cache_refresh[1560]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Oct 21 16:50:58.962139 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionSecurity=!tpm2 Oct 21 16:50:58.969453 systemd[1]: Starting update-engine.service - Update Engine... Oct 21 16:50:58.990366 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 21 16:50:59.011970 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 21 16:50:59.012710 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 21 16:50:59.014685 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 21 16:50:59.016252 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Oct 21 16:50:59.016645 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Oct 21 16:50:59.018567 systemd[1]: motdgen.service: Deactivated successfully. Oct 21 16:50:59.019378 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 21 16:50:59.021208 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 21 16:50:59.021629 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 21 16:50:59.029873 init.sh[1569]: + '[' -e /etc/default/instance_configs.cfg.template ']' Oct 21 16:50:59.029873 init.sh[1569]: + echo -e '[InstanceSetup]\nset_host_keys = false' Oct 21 16:50:59.038733 init.sh[1569]: + /usr/bin/google_instance_setup Oct 21 16:50:59.075051 ntpd[1565]: ntpd 4.2.8p18@1.4062-o Wed Oct 21 13:23:27 UTC 2026 (1): Starting Oct 21 16:50:59.082678 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: ntpd 4.2.8p18@1.4062-o Wed Oct 21 13:23:27 UTC 2026 (1): Starting Oct 21 16:50:59.082678 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 21 16:50:59.082678 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: ---------------------------------------------------- Oct 21 16:50:59.082678 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: ntp-4 is maintained by Network Time Foundation, Oct 21 16:50:59.082678 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 21 16:50:59.082678 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: corporation. Support and training for ntp-4 are Oct 21 16:50:59.082678 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: available at https://www.nwtime.org/support Oct 21 16:50:59.082678 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: ---------------------------------------------------- Oct 21 16:50:59.076616 ntpd[1565]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 21 16:50:59.076633 ntpd[1565]: ---------------------------------------------------- Oct 21 16:50:59.076647 ntpd[1565]: ntp-4 is maintained by Network Time Foundation, Oct 21 16:50:59.076660 ntpd[1565]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 21 16:50:59.076673 ntpd[1565]: corporation. Support and training for ntp-4 are Oct 21 16:50:59.076690 ntpd[1565]: available at https://www.nwtime.org/support Oct 21 16:50:59.076705 ntpd[1565]: ---------------------------------------------------- Oct 21 16:50:59.101452 ntpd[1565]: proto: precision = 0.083 usec (-23) Oct 21 16:50:59.109820 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: proto: precision = 0.083 usec (-23) Oct 21 16:50:59.109820 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: basedate set to 2026-10-09 Oct 21 16:50:59.109820 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: gps base set to 2026-10-11 (week 2440) Oct 21 16:50:59.109820 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: Listen and drop on 0 v6wildcard [::]:123 Oct 21 16:50:59.109820 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 21 16:50:59.109820 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: Listen normally on 2 lo 127.0.0.1:123 Oct 21 16:50:59.109820 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: Listen normally on 3 eth0 10.128.0.21:123 Oct 21 16:50:59.109820 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: Listen normally on 4 lo [::1]:123 Oct 21 16:50:59.109820 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: Listen normally on 5 eth0 [fe80::4001:aff:fe80:15%2]:123 Oct 21 16:50:59.109820 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: Listening on routing socket on fd #22 for interface updates Oct 21 16:50:59.101957 ntpd[1565]: basedate set to 2026-10-09 Oct 21 16:50:59.101981 ntpd[1565]: gps base set to 2026-10-11 (week 2440) Oct 21 16:50:59.102169 ntpd[1565]: Listen and drop on 0 v6wildcard [::]:123 Oct 21 16:50:59.102211 ntpd[1565]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 21 16:50:59.102510 ntpd[1565]: Listen normally on 2 lo 127.0.0.1:123 Oct 21 16:50:59.102554 ntpd[1565]: Listen normally on 3 eth0 10.128.0.21:123 Oct 21 16:50:59.102597 ntpd[1565]: Listen normally on 4 lo [::1]:123 Oct 21 16:50:59.102637 ntpd[1565]: Listen normally on 5 eth0 [fe80::4001:aff:fe80:15%2]:123 Oct 21 16:50:59.102681 ntpd[1565]: Listening on routing socket on fd #22 for interface updates Oct 21 16:50:59.112840 ntpd[1565]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 21 16:50:59.118105 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 21 16:50:59.118270 ntpd[1565]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 21 16:50:59.120951 ntpd[1565]: 21 Oct 16:50:59 ntpd[1565]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 21 16:50:59.141987 jq[1590]: true Oct 21 16:50:59.185137 update_engine[1589]: I20261021 16:50:59.184108 1589 main.cc:92] Flatcar Update Engine starting Oct 21 16:50:59.218846 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 21 16:50:59.275207 kernel: BTRFS info (device sda9): resizing devid 1 Oct 21 16:50:59.299928 kernel: BTRFS info (device sda9): resize device /dev/sda9 (devid 1) from 6627000320 to 10666094592 Oct 21 16:50:59.300141 jq[1619]: true Oct 21 16:50:59.335848 extend-filesystems[1623]: Resize device id 1 (/dev/sda9) from 6.17GiB to max Oct 21 16:50:59.350622 extend-filesystems[1559]: Resized filesystem in /dev/sda9 Oct 21 16:50:59.352638 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 21 16:50:59.355461 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 21 16:50:59.413534 systemd-logind[1588]: Watching system buttons on /dev/input/event2 (Power Button) Oct 21 16:50:59.414353 systemd-logind[1588]: Watching system buttons on /dev/input/event3 (Sleep Button) Oct 21 16:50:59.414414 systemd-logind[1588]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Oct 21 16:50:59.415299 systemd-logind[1588]: New seat seat0. Oct 21 16:50:59.421422 systemd[1]: Started systemd-logind.service - User Login Management. Oct 21 16:50:59.621456 bash[1646]: Updated "/home/core/.ssh/authorized_keys" Oct 21 16:50:59.641834 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 21 16:50:59.658667 dbus-daemon[1556]: [system] SELinux support is enabled Oct 21 16:50:59.660518 systemd[1]: Starting sshkeys.service... Oct 21 16:50:59.666371 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 21 16:50:59.689224 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 21 16:50:59.689307 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 21 16:50:59.696282 dbus-daemon[1556]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.2' (uid=244 pid=1370 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Oct 21 16:50:59.700326 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 21 16:50:59.700370 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 21 16:50:59.737283 update_engine[1589]: I20261021 16:50:59.735229 1589 update_check_scheduler.cc:74] Next update check in 6m35s Oct 21 16:50:59.771205 systemd[1]: Started update-engine.service - Update Engine. Oct 21 16:50:59.777277 dbus-daemon[1556]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 21 16:50:59.805043 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Oct 21 16:50:59.853093 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 21 16:50:59.961021 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Oct 21 16:50:59.977771 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Oct 21 16:51:00.220462 containerd[1605]: time="2026-10-21T16:51:00Z" 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 21 16:51:00.225496 containerd[1605]: time="2026-10-21T16:51:00.224686833Z" level=info msg="starting containerd" revision=e53c7c1516c3b2bff98eb76f1f4117477e6f4e66 version=v2.2.5 Oct 21 16:51:00.293924 coreos-metadata[1659]: Oct 21 16:51:00.293 INFO Fetching http://169.254.169.254/computeMetadata/v1/instance/attributes/sshKeys: Attempt #1 Oct 21 16:51:00.296049 coreos-metadata[1659]: Oct 21 16:51:00.296 INFO Fetch failed with 404: resource not found Oct 21 16:51:00.296049 coreos-metadata[1659]: Oct 21 16:51:00.296 INFO Fetching http://169.254.169.254/computeMetadata/v1/instance/attributes/ssh-keys: Attempt #1 Oct 21 16:51:00.297039 coreos-metadata[1659]: Oct 21 16:51:00.296 INFO Fetch successful Oct 21 16:51:00.297143 coreos-metadata[1659]: Oct 21 16:51:00.297 INFO Fetching http://169.254.169.254/computeMetadata/v1/instance/attributes/block-project-ssh-keys: Attempt #1 Oct 21 16:51:00.297826 coreos-metadata[1659]: Oct 21 16:51:00.297 INFO Fetch failed with 404: resource not found Oct 21 16:51:00.297938 coreos-metadata[1659]: Oct 21 16:51:00.297 INFO Fetching http://169.254.169.254/computeMetadata/v1/project/attributes/sshKeys: Attempt #1 Oct 21 16:51:00.301065 coreos-metadata[1659]: Oct 21 16:51:00.298 INFO Fetch failed with 404: resource not found Oct 21 16:51:00.301065 coreos-metadata[1659]: Oct 21 16:51:00.298 INFO Fetching http://169.254.169.254/computeMetadata/v1/project/attributes/ssh-keys: Attempt #1 Oct 21 16:51:00.303380 coreos-metadata[1659]: Oct 21 16:51:00.303 INFO Fetch successful Oct 21 16:51:00.313957 unknown[1659]: wrote ssh authorized keys file for user: core Oct 21 16:51:00.353937 containerd[1605]: time="2026-10-21T16:51:00.351100731Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="17.636µs" Oct 21 16:51:00.353937 containerd[1605]: time="2026-10-21T16:51:00.351174328Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 21 16:51:00.353937 containerd[1605]: time="2026-10-21T16:51:00.351248452Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 21 16:51:00.353937 containerd[1605]: time="2026-10-21T16:51:00.351281883Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 21 16:51:00.353937 containerd[1605]: time="2026-10-21T16:51:00.351551581Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 21 16:51:00.353937 containerd[1605]: time="2026-10-21T16:51:00.351598441Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Oct 21 16:51:00.353937 containerd[1605]: time="2026-10-21T16:51:00.351628678Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 21 16:51:00.355076 containerd[1605]: time="2026-10-21T16:51:00.351737359Z" 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 21 16:51:00.355076 containerd[1605]: time="2026-10-21T16:51:00.354984192Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 21 16:51:00.356036 containerd[1605]: time="2026-10-21T16:51:00.355595303Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 21 16:51:00.356036 containerd[1605]: time="2026-10-21T16:51:00.355649938Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 21 16:51:00.356036 containerd[1605]: time="2026-10-21T16:51:00.355676647Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 21 16:51:00.356258 containerd[1605]: time="2026-10-21T16:51:00.356058155Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 21 16:51:00.356258 containerd[1605]: time="2026-10-21T16:51:00.356169308Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 21 16:51:00.357948 containerd[1605]: time="2026-10-21T16:51:00.356499360Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 21 16:51:00.357948 containerd[1605]: time="2026-10-21T16:51:00.356571325Z" 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 21 16:51:00.357948 containerd[1605]: time="2026-10-21T16:51:00.356604803Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 21 16:51:00.357948 containerd[1605]: time="2026-10-21T16:51:00.357323098Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 21 16:51:00.373371 containerd[1605]: time="2026-10-21T16:51:00.369113078Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 21 16:51:00.373371 containerd[1605]: time="2026-10-21T16:51:00.369269297Z" level=info msg="metadata content store policy set" policy=shared Oct 21 16:51:00.381549 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Oct 21 16:51:00.394411 dbus-daemon[1556]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 21 16:51:00.412115 dbus-daemon[1556]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1657 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Oct 21 16:51:00.421923 containerd[1605]: time="2026-10-21T16:51:00.420749635Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 21 16:51:00.421923 containerd[1605]: time="2026-10-21T16:51:00.420834421Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 21 16:51:00.421923 containerd[1605]: time="2026-10-21T16:51:00.420887334Z" level=info msg="built-in NRI default validator is disabled" Oct 21 16:51:00.422333 containerd[1605]: time="2026-10-21T16:51:00.422292470Z" level=info msg="runtime interface created" Oct 21 16:51:00.422333 containerd[1605]: time="2026-10-21T16:51:00.422333220Z" level=info msg="created NRI interface" Oct 21 16:51:00.422435 containerd[1605]: time="2026-10-21T16:51:00.422375500Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 21 16:51:00.433803 systemd[1]: Starting polkit.service - Authorization Manager... Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439024220Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439284040Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439314040Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439336272Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439376682Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439396555Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439415906Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439434620Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439452216Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439470921Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439486723Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439504804Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 21 16:51:00.440163 containerd[1605]: time="2026-10-21T16:51:00.439641524Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 21 16:51:00.442532 containerd[1605]: time="2026-10-21T16:51:00.442479239Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 21 16:51:00.442968 containerd[1605]: time="2026-10-21T16:51:00.442551295Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 21 16:51:00.442968 containerd[1605]: time="2026-10-21T16:51:00.442606422Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 21 16:51:00.442968 containerd[1605]: time="2026-10-21T16:51:00.442629274Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 21 16:51:00.442968 containerd[1605]: time="2026-10-21T16:51:00.442646118Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 21 16:51:00.442968 containerd[1605]: time="2026-10-21T16:51:00.442666181Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 21 16:51:00.442968 containerd[1605]: time="2026-10-21T16:51:00.442684628Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 21 16:51:00.442968 containerd[1605]: time="2026-10-21T16:51:00.442702212Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Oct 21 16:51:00.442968 containerd[1605]: time="2026-10-21T16:51:00.442719466Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 21 16:51:00.442968 containerd[1605]: time="2026-10-21T16:51:00.442759094Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 21 16:51:00.442968 containerd[1605]: time="2026-10-21T16:51:00.442781628Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 21 16:51:00.442968 containerd[1605]: time="2026-10-21T16:51:00.442826495Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 21 16:51:00.445193 update-ssh-keys[1668]: Updated "/home/core/.ssh/authorized_keys" Oct 21 16:51:00.448924 containerd[1605]: time="2026-10-21T16:51:00.447354391Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 21 16:51:00.448335 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Oct 21 16:51:00.449186 containerd[1605]: time="2026-10-21T16:51:00.449145804Z" level=info msg="Start snapshots syncer" Oct 21 16:51:00.450599 containerd[1605]: time="2026-10-21T16:51:00.450111200Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 21 16:51:00.452922 containerd[1605]: time="2026-10-21T16:51:00.451359579Z" 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,\"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 21 16:51:00.455178 containerd[1605]: time="2026-10-21T16:51:00.455131639Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.457135011Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461385007Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461428034Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461514625Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461535676Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461555945Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461573923Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461592720Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461626709Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461647349Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461698635Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461722303Z" 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 21 16:51:00.462320 containerd[1605]: time="2026-10-21T16:51:00.461737954Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 21 16:51:00.462982 containerd[1605]: time="2026-10-21T16:51:00.461754367Z" 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 21 16:51:00.462982 containerd[1605]: time="2026-10-21T16:51:00.461770187Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 21 16:51:00.462982 containerd[1605]: time="2026-10-21T16:51:00.461786361Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 21 16:51:00.462982 containerd[1605]: time="2026-10-21T16:51:00.461803825Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 21 16:51:00.462982 containerd[1605]: time="2026-10-21T16:51:00.461826123Z" level=info msg="Connect containerd service" Oct 21 16:51:00.462982 containerd[1605]: time="2026-10-21T16:51:00.461874021Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 21 16:51:00.463818 systemd[1]: Finished sshkeys.service. Oct 21 16:51:00.478226 containerd[1605]: time="2026-10-21T16:51:00.477277069Z" level=error 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 21 16:51:00.685169 locksmithd[1658]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 21 16:51:00.842597 polkitd[1669]: Started polkitd version 126 Oct 21 16:51:00.898806 polkitd[1669]: Loading rules from directory /etc/polkit-1/rules.d Oct 21 16:51:00.905283 polkitd[1669]: Loading rules from directory /run/polkit-1/rules.d Oct 21 16:51:00.913085 polkitd[1669]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Oct 21 16:51:00.913667 polkitd[1669]: Loading rules from directory /usr/local/share/polkit-1/rules.d Oct 21 16:51:00.913701 polkitd[1669]: 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 21 16:51:00.913762 polkitd[1669]: Loading rules from directory /usr/share/polkit-1/rules.d Oct 21 16:51:00.927838 polkitd[1669]: Finished loading, compiling and executing 5 rules Oct 21 16:51:00.929450 systemd[1]: Started polkit.service - Authorization Manager. Oct 21 16:51:00.932221 dbus-daemon[1556]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 21 16:51:00.934255 polkitd[1669]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Oct 21 16:51:00.963946 containerd[1605]: time="2026-10-21T16:51:00.962990392Z" level=info msg="Start subscribing containerd event" Oct 21 16:51:00.963946 containerd[1605]: time="2026-10-21T16:51:00.963080738Z" level=info msg="Start recovering state" Oct 21 16:51:00.965612 containerd[1605]: time="2026-10-21T16:51:00.965564318Z" level=info msg="Start event monitor" Oct 21 16:51:00.965612 containerd[1605]: time="2026-10-21T16:51:00.965615826Z" level=info msg="Start cni network conf syncer for default" Oct 21 16:51:00.965803 containerd[1605]: time="2026-10-21T16:51:00.965633855Z" level=info msg="Start streaming server" Oct 21 16:51:00.965803 containerd[1605]: time="2026-10-21T16:51:00.965647965Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 21 16:51:00.965803 containerd[1605]: time="2026-10-21T16:51:00.965659185Z" level=info msg="runtime interface starting up..." Oct 21 16:51:00.965803 containerd[1605]: time="2026-10-21T16:51:00.965670296Z" level=info msg="starting plugins..." Oct 21 16:51:00.965803 containerd[1605]: time="2026-10-21T16:51:00.965689567Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 21 16:51:00.969278 containerd[1605]: time="2026-10-21T16:51:00.969163302Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 21 16:51:00.972091 containerd[1605]: time="2026-10-21T16:51:00.972032816Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 21 16:51:00.978485 systemd[1]: Started containerd.service - containerd container runtime. Oct 21 16:51:00.978869 containerd[1605]: time="2026-10-21T16:51:00.978827592Z" level=info msg="containerd successfully booted in 0.759951s" Oct 21 16:51:01.001465 systemd-resolved[1333]: System hostname changed to 'ci-4757-2-2-95ce0b69c63581c83f32.c.flatcar-212911.internal'. Oct 21 16:51:01.001572 systemd-hostnamed[1657]: Hostname set to (transient) Oct 21 16:51:01.146739 sshd_keygen[1617]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Oct 21 16:51:01.197516 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 21 16:51:01.210367 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 21 16:51:01.240446 systemd[1]: issuegen.service: Deactivated successfully. Oct 21 16:51:01.241213 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 21 16:51:01.255238 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 21 16:51:01.266842 instance-setup[1603]: INFO Running google_set_multiqueue. Oct 21 16:51:01.283613 instance-setup[1603]: INFO Machine type: projects/558272734166/machineTypes/n1-standard-2 Oct 21 16:51:01.286516 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 21 16:51:01.293233 instance-setup[1603]: INFO Interface: 0/ Oct 21 16:51:01.302687 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 21 16:51:01.309726 instance-setup[1603]: INFO physical-nic-id NOT found in interface 0/ Oct 21 16:51:01.316966 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 21 16:51:01.328486 systemd[1]: Reached target getty.target - Login Prompts. Oct 21 16:51:01.347690 instance-setup[1603]: INFO Setting /proc/irq/31/smp_affinity_list to 0 for device virtio1. Oct 21 16:51:01.349673 instance-setup[1603]: INFO /proc/irq/31/smp_affinity_list: real affinity 0 Oct 21 16:51:01.350019 instance-setup[1603]: INFO Setting /proc/irq/32/smp_affinity_list to 0 for device virtio1. Oct 21 16:51:01.351695 instance-setup[1603]: INFO /proc/irq/32/smp_affinity_list: real affinity 0 Oct 21 16:51:01.352173 instance-setup[1603]: INFO Setting /proc/irq/33/smp_affinity_list to 1 for device virtio1. Oct 21 16:51:01.353936 instance-setup[1603]: INFO /proc/irq/33/smp_affinity_list: real affinity 1 Oct 21 16:51:01.354340 instance-setup[1603]: INFO Setting /proc/irq/34/smp_affinity_list to 1 for device virtio1. Oct 21 16:51:01.356069 instance-setup[1603]: INFO /proc/irq/34/smp_affinity_list: real affinity 1 Oct 21 16:51:01.423937 init.sh[1569]: + /usr/bin/google_metadata_script_runner --script-type startup Oct 21 16:51:01.568657 startup-script[1778]: INFO Starting startup scripts. Oct 21 16:51:01.577672 startup-script[1778]: INFO No startup scripts found in metadata. Oct 21 16:51:01.577746 startup-script[1778]: INFO Finished running startup scripts. Oct 21 16:51:01.598443 init.sh[1569]: + trap 'stopping=1 ; kill "${daemon_pids[@]}" || :' SIGTERM Oct 21 16:51:01.598443 init.sh[1569]: + daemon_pids=() Oct 21 16:51:01.598443 init.sh[1569]: + for d in accounts clock_skew network Oct 21 16:51:01.598777 init.sh[1569]: + daemon_pids+=($!) Oct 21 16:51:01.598831 init.sh[1569]: + for d in accounts clock_skew network Oct 21 16:51:01.600571 init.sh[1569]: + daemon_pids+=($!) Oct 21 16:51:01.600706 init.sh[1781]: + /usr/bin/google_accounts_daemon Oct 21 16:51:01.601409 init.sh[1569]: + for d in accounts clock_skew network Oct 21 16:51:01.601409 init.sh[1569]: + daemon_pids+=($!) Oct 21 16:51:01.601409 init.sh[1569]: + NOTIFY_SOCKET=/run/systemd/notify Oct 21 16:51:01.601409 init.sh[1569]: + /usr/bin/systemd-notify --ready Oct 21 16:51:01.601586 init.sh[1782]: + /usr/bin/google_clock_skew_daemon Oct 21 16:51:01.602234 init.sh[1783]: + /usr/bin/google_network_daemon Oct 21 16:51:01.614333 systemd[1]: Started oem-gce.service - GCE Linux Agent. Oct 21 16:51:01.624544 init.sh[1569]: + wait -n 1781 1782 1783 Oct 21 16:51:01.625290 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 21 16:51:01.636403 systemd[1]: Startup finished in 2.998s (kernel) + 11.504s (initrd) + 12.697s (userspace) = 27.199s. Oct 21 16:51:01.914029 google-clock-skew[1782]: INFO Starting Google Clock Skew daemon. Oct 21 16:51:01.924045 google-clock-skew[1782]: INFO Clock drift token has changed: 0. Oct 21 16:51:01.936837 groupadd[1792]: group added to /etc/group: name=google-sudoers, GID=1000 Oct 21 16:51:01.940776 groupadd[1792]: group added to /etc/gshadow: name=google-sudoers Oct 21 16:51:01.968538 google-networking[1783]: INFO Starting Google Networking daemon. Oct 21 16:51:01.971751 init.sh[1796]: [sss_cache] [sss_tool_confdb_init] (0x0010): Can't access '/var/lib/sss/db/config.ldb', probably SSSD isn't configured Oct 21 16:51:01.971751 init.sh[1796]: Can't find configuration db, was SSSD configured and run? Oct 21 16:51:01.972537 groupadd[1792]: new group: name=google-sudoers, GID=1000 Oct 21 16:51:01.989302 init.sh[1798]: [sss_cache] [sss_tool_confdb_init] (0x0010): Can't access '/var/lib/sss/db/config.ldb', probably SSSD isn't configured Oct 21 16:51:01.989972 init.sh[1798]: Can't find configuration db, was SSSD configured and run? Oct 21 16:51:02.031644 google-accounts[1781]: INFO Starting Google Accounts daemon. Oct 21 16:51:02.048102 google-accounts[1781]: WARNING OS Login not installed. Oct 21 16:51:02.053464 google-accounts[1781]: INFO Creating a new user account for 0. Oct 21 16:51:02.057532 init.sh[1803]: useradd: invalid user name '0' Oct 21 16:51:02.058178 google-accounts[1781]: WARNING Could not create user 0. Command '['useradd', '-m', '-s', '/bin/bash', '-p', '*', '0']' returned non-zero exit status 19.. Oct 21 16:51:02.000530 google-clock-skew[1782]: INFO Synced system time with hardware clock. Oct 21 16:51:02.000597 systemd-resolved[1333]: Clock change detected. Flushing caches. Oct 21 16:51:02.018846 systemd-journald[1289]: Time jumped backwards, rotating. Oct 21 16:51:06.410979 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 21 16:51:06.413453 systemd[1]: Started sshd@0-1-10.128.0.21:22-98.64.94.113:56762.service - OpenSSH per-connection server daemon (98.64.94.113:56762). Oct 21 16:51:07.061424 sshd[1809]: Accepted publickey for core from 98.64.94.113 port 56762 ssh2: RSA SHA256:Y5wbppcL2mQ3PUTgogNQw8yCTN/MBYj5TRjtZWB1Qns Oct 21 16:51:07.065466 sshd-session[1809]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 16:51:07.077892 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 21 16:51:07.080345 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 21 16:51:07.092781 systemd-logind[1588]: New session '1' of user 'core' with class 'user' and type 'tty'. Oct 21 16:51:07.119032 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 21 16:51:07.123789 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 21 16:51:07.159470 (systemd)[1815]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Oct 21 16:51:07.164554 systemd-logind[1588]: New session '2' of user 'core' with class 'manager-early' and type 'unspecified'. Oct 21 16:51:07.475400 systemd[1815]: Queued start job for default target default.target. Oct 21 16:51:07.482867 systemd[1815]: Created slice app.slice - User Application Slice. Oct 21 16:51:07.482941 systemd[1815]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Oct 21 16:51:07.482973 systemd[1815]: Reached target machines.target - Virtual Machines and Containers. Oct 21 16:51:07.483562 systemd[1815]: Reached target paths.target - Paths. Oct 21 16:51:07.483660 systemd[1815]: Reached target timers.target - Timers. Oct 21 16:51:07.485868 systemd[1815]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 21 16:51:07.489426 systemd[1815]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 21 16:51:07.489800 systemd[1815]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 21 16:51:07.492036 systemd[1815]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 21 16:51:07.492638 systemd[1815]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 21 16:51:07.495828 systemd[1815]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Oct 21 16:51:07.524206 systemd[1815]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 21 16:51:07.524423 systemd[1815]: Reached target sockets.target - Sockets. Oct 21 16:51:07.525805 systemd[1815]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Oct 21 16:51:07.526280 systemd[1815]: Reached target basic.target - Basic System. Oct 21 16:51:07.526553 systemd[1815]: Reached target default.target - Main User Target. Oct 21 16:51:07.526734 systemd[1815]: Startup finished in 351ms. Oct 21 16:51:07.526904 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 21 16:51:07.538740 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 21 16:51:07.876642 systemd[1]: Started sshd@1-2-10.128.0.21:22-98.64.94.113:56764.service - OpenSSH per-connection server daemon (98.64.94.113:56764). Oct 21 16:51:08.478578 sshd[1829]: Accepted publickey for core from 98.64.94.113 port 56764 ssh2: RSA SHA256:Y5wbppcL2mQ3PUTgogNQw8yCTN/MBYj5TRjtZWB1Qns Oct 21 16:51:08.480637 sshd-session[1829]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 16:51:08.489836 systemd-logind[1588]: New session '3' of user 'core' with class 'user' and type 'tty'. Oct 21 16:51:08.495516 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 21 16:51:08.798015 sshd[1833]: Connection closed by 98.64.94.113 port 56764 Oct 21 16:51:08.800411 sshd-session[1829]: pam_unix(sshd:session): session closed for user core Oct 21 16:51:08.805565 systemd[1]: sshd@1-2-10.128.0.21:22-98.64.94.113:56764.service: Deactivated successfully. Oct 21 16:51:08.808130 systemd[1]: session-3.scope: Deactivated successfully. Oct 21 16:51:08.809718 systemd-logind[1588]: Session 3 logged out. Waiting for processes to exit. Oct 21 16:51:08.812005 systemd-logind[1588]: Removed session 3. Oct 21 16:51:08.915656 systemd[1]: Started sshd@2-3-10.128.0.21:22-98.64.94.113:56768.service - OpenSSH per-connection server daemon (98.64.94.113:56768). Oct 21 16:51:09.526988 sshd[1839]: Accepted publickey for core from 98.64.94.113 port 56768 ssh2: RSA SHA256:Y5wbppcL2mQ3PUTgogNQw8yCTN/MBYj5TRjtZWB1Qns Oct 21 16:51:09.528025 sshd-session[1839]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 16:51:09.536258 systemd-logind[1588]: New session '4' of user 'core' with class 'user' and type 'tty'. Oct 21 16:51:09.543606 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 21 16:51:09.841094 sshd[1843]: Connection closed by 98.64.94.113 port 56768 Oct 21 16:51:09.843480 sshd-session[1839]: pam_unix(sshd:session): session closed for user core Oct 21 16:51:09.847221 systemd[1]: sshd@2-3-10.128.0.21:22-98.64.94.113:56768.service: Deactivated successfully. Oct 21 16:51:09.849948 systemd[1]: session-4.scope: Deactivated successfully. Oct 21 16:51:09.853254 systemd-logind[1588]: Session 4 logged out. Waiting for processes to exit. Oct 21 16:51:09.854987 systemd-logind[1588]: Removed session 4. Oct 21 16:51:09.958903 systemd[1]: Started sshd@3-4097-10.128.0.21:22-98.64.94.113:58066.service - OpenSSH per-connection server daemon (98.64.94.113:58066). Oct 21 16:51:10.570723 sshd[1849]: Accepted publickey for core from 98.64.94.113 port 58066 ssh2: RSA SHA256:Y5wbppcL2mQ3PUTgogNQw8yCTN/MBYj5TRjtZWB1Qns Oct 21 16:51:10.572654 sshd-session[1849]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 16:51:10.581259 systemd-logind[1588]: New session '5' of user 'core' with class 'user' and type 'tty'. Oct 21 16:51:10.589561 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 21 16:51:10.892722 sshd[1853]: Connection closed by 98.64.94.113 port 58066 Oct 21 16:51:10.894485 sshd-session[1849]: pam_unix(sshd:session): session closed for user core Oct 21 16:51:10.899711 systemd[1]: sshd@3-4097-10.128.0.21:22-98.64.94.113:58066.service: Deactivated successfully. Oct 21 16:51:10.902503 systemd[1]: session-5.scope: Deactivated successfully. Oct 21 16:51:10.904608 systemd-logind[1588]: Session 5 logged out. Waiting for processes to exit. Oct 21 16:51:10.906413 systemd-logind[1588]: Removed session 5. Oct 21 16:51:11.013924 systemd[1]: Started sshd@4-4-10.128.0.21:22-98.64.94.113:58082.service - OpenSSH per-connection server daemon (98.64.94.113:58082). Oct 21 16:51:11.625038 sshd[1859]: Accepted publickey for core from 98.64.94.113 port 58082 ssh2: RSA SHA256:Y5wbppcL2mQ3PUTgogNQw8yCTN/MBYj5TRjtZWB1Qns Oct 21 16:51:11.626903 sshd-session[1859]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 16:51:11.635545 systemd-logind[1588]: New session '6' of user 'core' with class 'user' and type 'tty'. Oct 21 16:51:11.641569 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 21 16:51:11.874665 sudo[1864]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 21 16:51:11.875269 sudo[1864]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 21 16:51:11.889054 sudo[1864]: pam_unix(sudo:session): session closed for user root Oct 21 16:51:11.996939 sshd[1863]: Connection closed by 98.64.94.113 port 58082 Oct 21 16:51:11.998371 sshd-session[1859]: pam_unix(sshd:session): session closed for user core Oct 21 16:51:12.004274 systemd[1]: sshd@4-4-10.128.0.21:22-98.64.94.113:58082.service: Deactivated successfully. Oct 21 16:51:12.007768 systemd[1]: session-6.scope: Deactivated successfully. Oct 21 16:51:12.009482 systemd-logind[1588]: Session 6 logged out. Waiting for processes to exit. Oct 21 16:51:12.012357 systemd-logind[1588]: Removed session 6. Oct 21 16:51:12.111946 systemd[1]: Started sshd@5-4098-10.128.0.21:22-98.64.94.113:58092.service - OpenSSH per-connection server daemon (98.64.94.113:58092). Oct 21 16:51:12.718837 sshd[1871]: Accepted publickey for core from 98.64.94.113 port 58092 ssh2: RSA SHA256:Y5wbppcL2mQ3PUTgogNQw8yCTN/MBYj5TRjtZWB1Qns Oct 21 16:51:12.720918 sshd-session[1871]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 16:51:12.730220 systemd-logind[1588]: New session '7' of user 'core' with class 'user' and type 'tty'. Oct 21 16:51:12.739688 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 21 16:51:12.946508 sudo[1877]: 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 21 16:51:12.947110 sudo[1877]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 21 16:51:12.949799 sudo[1877]: pam_unix(sudo:session): session closed for user root Oct 21 16:51:12.968819 sudo[1876]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 21 16:51:12.969432 sudo[1876]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 21 16:51:12.980705 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 21 16:51:13.055000 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 21 16:51:13.067602 augenrules[1901]: No rules Oct 21 16:51:13.068155 kernel: kauditd_printk_skb: 2 callbacks suppressed Oct 21 16:51:13.068273 kernel: audit: type=1305 audit(1792601473.055:157): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 21 16:51:13.070978 systemd[1]: audit-rules.service: Deactivated successfully. Oct 21 16:51:13.072003 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 21 16:51:13.074034 sudo[1876]: pam_unix(sudo:session): session closed for user root Oct 21 16:51:13.055000 audit[1901]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff3bcbaea0 a2=420 a3=0 items=0 ppid=1882 pid=1901 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 21 16:51:13.113121 kernel: audit: type=1300 audit(1792601473.055:157): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff3bcbaea0 a2=420 a3=0 items=0 ppid=1882 pid=1901 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 21 16:51:13.055000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 21 16:51:13.113405 kernel: audit: type=1327 audit(1792601473.055:157): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 21 16:51:13.071000 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 21 16:51:13.148948 kernel: audit: type=1130 audit(1792601473.071:158): 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 21 16:51:13.071000 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 21 16:51:13.149147 kernel: audit: type=1131 audit(1792601473.071:159): 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 21 16:51:13.072000 audit[1876]: AUDIT1106 pid=1876 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 21 16:51:13.194850 kernel: audit: type=1106 audit(1792601473.072:160): pid=1876 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 21 16:51:13.073000 audit[1876]: AUDIT1104 pid=1876 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 21 16:51:13.195068 kernel: audit: type=1104 audit(1792601473.073:161): pid=1876 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 21 16:51:13.197200 sshd[1875]: Connection closed by 98.64.94.113 port 58092 Oct 21 16:51:13.198073 sshd-session[1871]: pam_unix(sshd:session): session closed for user core Oct 21 16:51:13.206348 systemd[1]: sshd@5-4098-10.128.0.21:22-98.64.94.113:58092.service: Deactivated successfully. Oct 21 16:51:13.210843 systemd[1]: session-7.scope: Deactivated successfully. Oct 21 16:51:13.213406 systemd-logind[1588]: Session 7 logged out. Waiting for processes to exit. Oct 21 16:51:13.216390 systemd-logind[1588]: Removed session 7. Oct 21 16:51:13.197000 audit[1871]: AUDIT1106 pid=1871 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:13.219425 kernel: audit: type=1106 audit(1792601473.197:162): pid=1871 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:13.197000 audit[1871]: AUDIT1104 pid=1871 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:13.205000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4098-10.128.0.21:22-98.64.94.113:58092 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:51:13.304238 kernel: audit: type=1104 audit(1792601473.197:163): pid=1871 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:13.304338 kernel: audit: type=1131 audit(1792601473.205:164): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4098-10.128.0.21:22-98.64.94.113:58092 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:51:13.315960 systemd[1]: Started sshd@6-4099-10.128.0.21:22-98.64.94.113:58108.service - OpenSSH per-connection server daemon (98.64.94.113:58108). Oct 21 16:51:13.315000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4099-10.128.0.21:22-98.64.94.113:58108 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:51:13.918000 audit[1910]: AUDIT1101 pid=1910 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:13.919777 sshd[1910]: Accepted publickey for core from 98.64.94.113 port 58108 ssh2: RSA SHA256:Y5wbppcL2mQ3PUTgogNQw8yCTN/MBYj5TRjtZWB1Qns Oct 21 16:51:13.920000 audit[1910]: AUDIT1103 pid=1910 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:13.920000 audit[1910]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7ffdfd3fbf40 a2=3 a3=0 items=0 ppid=1 pid=1910 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 21 16:51:13.920000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Oct 21 16:51:13.922083 sshd-session[1910]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 16:51:13.930322 systemd-logind[1588]: New session '8' of user 'core' with class 'user' and type 'tty'. Oct 21 16:51:13.937531 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 21 16:51:13.941000 audit[1910]: AUDIT1105 pid=1910 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:13.944000 audit[1914]: AUDIT1103 pid=1914 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:14.153000 audit[1915]: AUDIT1101 pid=1915 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 21 16:51:14.154950 sudo[1915]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s UUID -o value /dev/disk/by-label/ROOT Oct 21 16:51:14.155588 sudo[1915]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 21 16:51:14.154000 audit[1915]: AUDIT1110 pid=1915 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 21 16:51:14.154000 audit[1915]: AUDIT1105 pid=1915 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 21 16:51:14.163406 sudo[1915]: pam_unix(sudo:session): session closed for user root Oct 21 16:51:14.162000 audit[1915]: AUDIT1106 pid=1915 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 21 16:51:14.162000 audit[1915]: AUDIT1104 pid=1915 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 21 16:51:14.270324 sshd[1914]: Connection closed by 98.64.94.113 port 58108 Oct 21 16:51:14.272606 sshd-session[1910]: pam_unix(sshd:session): session closed for user core Oct 21 16:51:14.272000 audit[1910]: AUDIT1106 pid=1910 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:14.272000 audit[1910]: AUDIT1104 pid=1910 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:14.278030 systemd[1]: sshd@6-4099-10.128.0.21:22-98.64.94.113:58108.service: Deactivated successfully. Oct 21 16:51:14.277000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4099-10.128.0.21:22-98.64.94.113:58108 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:51:14.281342 systemd[1]: session-8.scope: Deactivated successfully. Oct 21 16:51:14.284994 systemd-logind[1588]: Session 8 logged out. Waiting for processes to exit. Oct 21 16:51:14.287044 systemd-logind[1588]: Removed session 8. Oct 21 16:51:14.389000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-5-10.128.0.21:22-98.64.94.113:58114 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:51:14.390785 systemd[1]: Started sshd@7-5-10.128.0.21:22-98.64.94.113:58114.service - OpenSSH per-connection server daemon (98.64.94.113:58114). Oct 21 16:51:14.998000 audit[1922]: AUDIT1101 pid=1922 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:15.000451 sshd[1922]: Accepted publickey for core from 98.64.94.113 port 58114 ssh2: RSA SHA256:Y5wbppcL2mQ3PUTgogNQw8yCTN/MBYj5TRjtZWB1Qns Oct 21 16:51:15.000000 audit[1922]: AUDIT1103 pid=1922 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:15.000000 audit[1922]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7fff6ce0cc90 a2=3 a3=0 items=0 ppid=1 pid=1922 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 21 16:51:15.000000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Oct 21 16:51:15.002736 sshd-session[1922]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 16:51:15.012094 systemd-logind[1588]: New session '9' of user 'core' with class 'user' and type 'tty'. Oct 21 16:51:15.022655 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 21 16:51:15.026000 audit[1922]: AUDIT1105 pid=1922 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:15.029000 audit[1926]: AUDIT1103 pid=1926 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:15.228000 audit[1927]: AUDIT1101 pid=1927 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 21 16:51:15.230238 sudo[1927]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s TYPE -o value /dev/disk/by-label/ROOT Oct 21 16:51:15.230818 sudo[1927]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 21 16:51:15.229000 audit[1927]: AUDIT1110 pid=1927 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 21 16:51:15.229000 audit[1927]: AUDIT1105 pid=1927 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 21 16:51:15.233669 sudo[1927]: pam_unix(sudo:session): session closed for user root Oct 21 16:51:15.232000 audit[1927]: AUDIT1106 pid=1927 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 21 16:51:15.232000 audit[1927]: AUDIT1104 pid=1927 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 21 16:51:15.339533 sshd[1926]: Connection closed by 98.64.94.113 port 58114 Oct 21 16:51:15.341000 audit[1922]: AUDIT1106 pid=1922 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:15.341000 audit[1922]: AUDIT1104 pid=1922 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:15.341464 sshd-session[1922]: pam_unix(sshd:session): session closed for user core Oct 21 16:51:15.345435 systemd[1]: sshd@7-5-10.128.0.21:22-98.64.94.113:58114.service: Deactivated successfully. Oct 21 16:51:15.344000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-5-10.128.0.21:22-98.64.94.113:58114 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:51:15.348300 systemd[1]: session-9.scope: Deactivated successfully. Oct 21 16:51:15.351769 systemd-logind[1588]: Session 9 logged out. Waiting for processes to exit. Oct 21 16:51:15.353486 systemd-logind[1588]: Removed session 9. Oct 21 16:51:15.455483 systemd[1]: Started sshd@8-6-10.128.0.21:22-98.64.94.113:58128.service - OpenSSH per-connection server daemon (98.64.94.113:58128). Oct 21 16:51:15.454000 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.21:22-98.64.94.113:58128 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:51:16.055000 audit[1934]: AUDIT1101 pid=1934 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:16.056689 sshd[1934]: Accepted publickey for core from 98.64.94.113 port 58128 ssh2: RSA SHA256:Y5wbppcL2mQ3PUTgogNQw8yCTN/MBYj5TRjtZWB1Qns Oct 21 16:51:16.056000 audit[1934]: AUDIT1103 pid=1934 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:16.056000 audit[1934]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7ffe4af8d3f0 a2=3 a3=0 items=0 ppid=1 pid=1934 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 21 16:51:16.056000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Oct 21 16:51:16.058713 sshd-session[1934]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 16:51:16.067263 systemd-logind[1588]: New session '10' of user 'core' with class 'user' and type 'tty'. Oct 21 16:51:16.074561 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 21 16:51:16.078000 audit[1934]: AUDIT1105 pid=1934 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:16.081000 audit[1938]: AUDIT1103 pid=1938 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:16.376340 sshd[1938]: Connection closed by 98.64.94.113 port 58128 Oct 21 16:51:16.377916 sshd-session[1934]: pam_unix(sshd:session): session closed for user core Oct 21 16:51:16.377000 audit[1934]: AUDIT1106 pid=1934 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:16.377000 audit[1934]: AUDIT1104 pid=1934 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=98.64.94.113 addr=98.64.94.113 terminal=ssh res=success' Oct 21 16:51:16.382963 systemd[1]: sshd@8-6-10.128.0.21:22-98.64.94.113:58128.service: Deactivated successfully. Oct 21 16:51:16.382000 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.21:22-98.64.94.113:58128 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 21 16:51:16.386146 systemd[1]: session-10.scope: Deactivated successfully. Oct 21 16:51:16.387695 systemd-logind[1588]: Session 10 logged out. Waiting for processes to exit. Oct 21 16:51:16.390072 systemd-logind[1588]: Removed session 10.