Sep 11 00:23:02.264148 kernel: Linux version 6.12.46-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT_DYNAMIC Wed Sep 10 22:25:29 -00 2025 Sep 11 00:23:02.264194 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=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=24178014e7d1a618b6c727661dc98ca9324f7f5aeefcaa5f4996d4d839e6e63a Sep 11 00:23:02.264213 kernel: BIOS-provided physical RAM map: Sep 11 00:23:02.264228 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009dfff] usable Sep 11 00:23:02.264238 kernel: BIOS-e820: [mem 0x000000000009e000-0x000000000009ffff] reserved Sep 11 00:23:02.264249 kernel: BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved Sep 11 00:23:02.264265 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000efffffff] usable Sep 11 00:23:02.264276 kernel: BIOS-e820: [mem 0x00000000fc000000-0x00000000ffffffff] reserved Sep 11 00:23:02.264287 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000080fffffff] usable Sep 11 00:23:02.264297 kernel: NX (Execute Disable) protection: active Sep 11 00:23:02.264308 kernel: APIC: Static calls initialized Sep 11 00:23:02.264319 kernel: SMBIOS 2.7 present. Sep 11 00:23:02.264332 kernel: DMI: Xen HVM domU, BIOS 4.11.amazon 08/24/2006 Sep 11 00:23:02.264343 kernel: DMI: Memory slots populated: 2/2 Sep 11 00:23:02.264360 kernel: Hypervisor detected: Xen HVM Sep 11 00:23:02.264372 kernel: Xen version 4.11. Sep 11 00:23:02.264384 kernel: platform_pci_unplug: Netfront and the Xen platform PCI driver have been compiled for this kernel: unplug emulated NICs. Sep 11 00:23:02.264400 kernel: platform_pci_unplug: Blkfront and the Xen platform PCI driver have been compiled for this kernel: unplug emulated disks. You might have to change the root device from /dev/hd[a-d] to /dev/xvd[a-d] in your root= kernel command line option Sep 11 00:23:02.264412 kernel: HVMOP_pagetable_dying not supported Sep 11 00:23:02.264425 kernel: tsc: Fast TSC calibration using PIT Sep 11 00:23:02.264438 kernel: tsc: Detected 2300.253 MHz processor Sep 11 00:23:02.264450 kernel: tsc: Detected 2300.004 MHz TSC Sep 11 00:23:02.264462 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 11 00:23:02.264475 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 11 00:23:02.264487 kernel: last_pfn = 0x810000 max_arch_pfn = 0x400000000 Sep 11 00:23:02.264499 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Sep 11 00:23:02.264514 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Sep 11 00:23:02.264527 kernel: last_pfn = 0xf0000 max_arch_pfn = 0x400000000 Sep 11 00:23:02.264539 kernel: Using GB pages for direct mapping Sep 11 00:23:02.264551 kernel: ACPI: Early table checksum verification disabled Sep 11 00:23:02.264563 kernel: ACPI: RSDP 0x00000000000EA020 000024 (v02 Xen ) Sep 11 00:23:02.264576 kernel: ACPI: XSDT 0x00000000FC00C780 000054 (v01 Xen HVM 00000000 HVML 00000000) Sep 11 00:23:02.264588 kernel: ACPI: FACP 0x00000000FC00C440 0000F4 (v04 Xen HVM 00000000 HVML 00000000) Sep 11 00:23:02.264600 kernel: ACPI: DSDT 0x00000000FC003940 008A7E (v02 Xen HVM 00000000 INTL 20090123) Sep 11 00:23:02.264612 kernel: ACPI: FACS 0x00000000FC003900 000040 Sep 11 00:23:02.264627 kernel: ACPI: FACS 0x00000000FC003900 000040 Sep 11 00:23:02.264639 kernel: ACPI: APIC 0x00000000FC00C540 0000D8 (v02 Xen HVM 00000000 HVML 00000000) Sep 11 00:23:02.264651 kernel: ACPI: HPET 0x00000000FC00C690 000038 (v01 Xen HVM 00000000 HVML 00000000) Sep 11 00:23:02.264663 kernel: ACPI: WAET 0x00000000FC00C6D0 000028 (v01 Xen HVM 00000000 HVML 00000000) Sep 11 00:23:02.264678 kernel: ACPI: SSDT 0x00000000FC00C700 000031 (v02 Xen HVM 00000000 INTL 20090123) Sep 11 00:23:02.264699 kernel: ACPI: SSDT 0x00000000FC00C740 000033 (v02 Xen HVM 00000000 INTL 20090123) Sep 11 00:23:02.264714 kernel: ACPI: Reserving FACP table memory at [mem 0xfc00c440-0xfc00c533] Sep 11 00:23:02.264727 kernel: ACPI: Reserving DSDT table memory at [mem 0xfc003940-0xfc00c3bd] Sep 11 00:23:02.264739 kernel: ACPI: Reserving FACS table memory at [mem 0xfc003900-0xfc00393f] Sep 11 00:23:02.264753 kernel: ACPI: Reserving FACS table memory at [mem 0xfc003900-0xfc00393f] Sep 11 00:23:02.264765 kernel: ACPI: Reserving APIC table memory at [mem 0xfc00c540-0xfc00c617] Sep 11 00:23:02.264778 kernel: ACPI: Reserving HPET table memory at [mem 0xfc00c690-0xfc00c6c7] Sep 11 00:23:02.264790 kernel: ACPI: Reserving WAET table memory at [mem 0xfc00c6d0-0xfc00c6f7] Sep 11 00:23:02.264803 kernel: ACPI: Reserving SSDT table memory at [mem 0xfc00c700-0xfc00c730] Sep 11 00:23:02.264818 kernel: ACPI: Reserving SSDT table memory at [mem 0xfc00c740-0xfc00c772] Sep 11 00:23:02.264830 kernel: No NUMA configuration found Sep 11 00:23:02.264843 kernel: Faking a node at [mem 0x0000000000000000-0x000000080fffffff] Sep 11 00:23:02.264856 kernel: NODE_DATA(0) allocated [mem 0x80fff8dc0-0x80fffffff] Sep 11 00:23:02.264869 kernel: Zone ranges: Sep 11 00:23:02.264881 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Sep 11 00:23:02.264894 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Sep 11 00:23:02.264906 kernel: Normal [mem 0x0000000100000000-0x000000080fffffff] Sep 11 00:23:02.264919 kernel: Device empty Sep 11 00:23:02.264934 kernel: Movable zone start for each node Sep 11 00:23:02.264947 kernel: Early memory node ranges Sep 11 00:23:02.264959 kernel: node 0: [mem 0x0000000000001000-0x000000000009dfff] Sep 11 00:23:02.264972 kernel: node 0: [mem 0x0000000000100000-0x00000000efffffff] Sep 11 00:23:02.264984 kernel: node 0: [mem 0x0000000100000000-0x000000080fffffff] Sep 11 00:23:02.264997 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000080fffffff] Sep 11 00:23:02.265010 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 11 00:23:02.265022 kernel: On node 0, zone DMA: 98 pages in unavailable ranges Sep 11 00:23:02.265051 kernel: ACPI: PM-Timer IO Port: 0xb008 Sep 11 00:23:02.265068 kernel: IOAPIC[0]: apic_id 1, version 17, address 0xfec00000, GSI 0-47 Sep 11 00:23:02.265081 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Sep 11 00:23:02.265094 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 low level) Sep 11 00:23:02.265106 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 low level) Sep 11 00:23:02.265119 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 low level) Sep 11 00:23:02.265132 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Sep 11 00:23:02.265144 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Sep 11 00:23:02.265157 kernel: TSC deadline timer available Sep 11 00:23:02.265170 kernel: CPU topo: Max. logical packages: 1 Sep 11 00:23:02.265185 kernel: CPU topo: Max. logical dies: 1 Sep 11 00:23:02.265197 kernel: CPU topo: Max. dies per package: 1 Sep 11 00:23:02.265210 kernel: CPU topo: Max. threads per core: 2 Sep 11 00:23:02.265222 kernel: CPU topo: Num. cores per package: 4 Sep 11 00:23:02.265235 kernel: CPU topo: Num. threads per package: 8 Sep 11 00:23:02.265248 kernel: CPU topo: Allowing 8 present CPUs plus 7 hotplug CPUs Sep 11 00:23:02.265260 kernel: [mem 0xf0000000-0xfbffffff] available for PCI devices Sep 11 00:23:02.265273 kernel: Booting paravirtualized kernel on Xen HVM Sep 11 00:23:02.265286 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Sep 11 00:23:02.265299 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:15 nr_cpu_ids:15 nr_node_ids:1 Sep 11 00:23:02.265314 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u262144 Sep 11 00:23:02.265327 kernel: pcpu-alloc: s207832 r8192 d29736 u262144 alloc=1*2097152 Sep 11 00:23:02.265339 kernel: pcpu-alloc: [0] 00 01 02 03 04 05 06 07 [0] 08 09 10 11 12 13 14 -- Sep 11 00:23:02.265352 kernel: xen: PV spinlocks enabled Sep 11 00:23:02.265365 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Sep 11 00:23:02.265379 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=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=24178014e7d1a618b6c727661dc98ca9324f7f5aeefcaa5f4996d4d839e6e63a Sep 11 00:23:02.265393 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 11 00:23:02.265408 kernel: random: crng init done Sep 11 00:23:02.265421 kernel: Dentry cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear) Sep 11 00:23:02.265433 kernel: Inode-cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear) Sep 11 00:23:02.265446 kernel: Fallback order for Node 0: 0 Sep 11 00:23:02.265459 kernel: Built 1 zonelists, mobility grouping on. Total pages: 8388509 Sep 11 00:23:02.265471 kernel: Policy zone: Normal Sep 11 00:23:02.265484 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 11 00:23:02.265497 kernel: software IO TLB: area num 16. Sep 11 00:23:02.265511 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=15, Nodes=1 Sep 11 00:23:02.265527 kernel: Kernel/User page tables isolation: enabled Sep 11 00:23:02.265540 kernel: ftrace: allocating 40103 entries in 157 pages Sep 11 00:23:02.265552 kernel: ftrace: allocated 157 pages with 5 groups Sep 11 00:23:02.265565 kernel: Dynamic Preempt: voluntary Sep 11 00:23:02.265577 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 11 00:23:02.265590 kernel: rcu: RCU event tracing is enabled. Sep 11 00:23:02.265603 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=15. Sep 11 00:23:02.265616 kernel: Trampoline variant of Tasks RCU enabled. Sep 11 00:23:02.265628 kernel: Rude variant of Tasks RCU enabled. Sep 11 00:23:02.265644 kernel: Tracing variant of Tasks RCU enabled. Sep 11 00:23:02.265656 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 11 00:23:02.265669 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=15 Sep 11 00:23:02.265682 kernel: RCU Tasks: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=15. Sep 11 00:23:02.265694 kernel: RCU Tasks Rude: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=15. Sep 11 00:23:02.265707 kernel: RCU Tasks Trace: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=15. Sep 11 00:23:02.265721 kernel: NR_IRQS: 33024, nr_irqs: 952, preallocated irqs: 16 Sep 11 00:23:02.265748 kernel: xen:events: Using 2-level ABI Sep 11 00:23:02.265761 kernel: xen:events: Xen HVM callback vector for event delivery is enabled Sep 11 00:23:02.265774 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 11 00:23:02.265787 kernel: Console: colour VGA+ 80x25 Sep 11 00:23:02.265800 kernel: Cannot get hvm parameter CONSOLE_EVTCHN (18): -22! Sep 11 00:23:02.265817 kernel: printk: legacy console [ttyS0] enabled Sep 11 00:23:02.265830 kernel: ACPI: Core revision 20240827 Sep 11 00:23:02.265843 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 30580167144 ns Sep 11 00:23:02.265856 kernel: APIC: Switch to symmetric I/O mode setup Sep 11 00:23:02.265869 kernel: x2apic enabled Sep 11 00:23:02.265882 kernel: APIC: Switched APIC routing to: physical x2apic Sep 11 00:23:02.265896 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=0 pin2=0 Sep 11 00:23:02.265912 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x212738e3f90, max_idle_ns: 440795225370 ns Sep 11 00:23:02.265926 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4600.00 BogoMIPS (lpj=2300004) Sep 11 00:23:02.265939 kernel: Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8 Sep 11 00:23:02.265952 kernel: Last level dTLB entries: 4KB 64, 2MB 32, 4MB 32, 1GB 4 Sep 11 00:23:02.265965 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Sep 11 00:23:02.265978 kernel: Spectre V2 : Mitigation: Retpolines Sep 11 00:23:02.265995 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Sep 11 00:23:02.266008 kernel: Speculative Store Bypass: Vulnerable Sep 11 00:23:02.266021 kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Sep 11 00:23:02.266047 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Sep 11 00:23:02.266070 kernel: active return thunk: its_return_thunk Sep 11 00:23:02.266093 kernel: ITS: Mitigation: Aligned branch/return thunks Sep 11 00:23:02.266109 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Sep 11 00:23:02.266124 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Sep 11 00:23:02.266138 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Sep 11 00:23:02.266155 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Sep 11 00:23:02.266168 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Sep 11 00:23:02.266181 kernel: Freeing SMP alternatives memory: 32K Sep 11 00:23:02.266194 kernel: pid_max: default: 32768 minimum: 301 Sep 11 00:23:02.266208 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 11 00:23:02.266221 kernel: landlock: Up and running. Sep 11 00:23:02.266234 kernel: SELinux: Initializing. Sep 11 00:23:02.266247 kernel: Mount-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 11 00:23:02.266261 kernel: Mountpoint-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 11 00:23:02.266277 kernel: clocksource: xen: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 11 00:23:02.266290 kernel: Xen: using vcpuop timer interface Sep 11 00:23:02.266303 kernel: installing Xen timer for CPU 0 Sep 11 00:23:02.266316 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2686 v4 @ 2.30GHz (family: 0x6, model: 0x4f, stepping: 0x1) Sep 11 00:23:02.266330 kernel: cpu 0 spinlock event irq 53 Sep 11 00:23:02.266343 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only. Sep 11 00:23:02.266356 kernel: signal: max sigframe size: 1776 Sep 11 00:23:02.266368 kernel: rcu: Hierarchical SRCU implementation. Sep 11 00:23:02.266381 kernel: rcu: Max phase no-delay instances is 400. Sep 11 00:23:02.266412 kernel: Timer migration: 2 hierarchy levels; 8 children per group; 2 crossnode level Sep 11 00:23:02.266428 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Sep 11 00:23:02.266441 kernel: smp: Bringing up secondary CPUs ... Sep 11 00:23:02.266453 kernel: installing Xen timer for CPU 1 Sep 11 00:23:02.266466 kernel: smpboot: x86: Booting SMP configuration: Sep 11 00:23:02.266478 kernel: .... node #0, CPUs: #1 Sep 11 00:23:02.266491 kernel: installing Xen timer for CPU 2 Sep 11 00:23:02.266503 kernel: #2 Sep 11 00:23:02.266517 kernel: installing Xen timer for CPU 3 Sep 11 00:23:02.266529 kernel: #3 Sep 11 00:23:02.266541 kernel: cpu 1 spinlock event irq 69 Sep 11 00:23:02.266553 kernel: cpu 2 spinlock event irq 70 Sep 11 00:23:02.266565 kernel: cpu 3 spinlock event irq 71 Sep 11 00:23:02.266581 kernel: installing Xen timer for CPU 4 Sep 11 00:23:02.266593 kernel: #4 Sep 11 00:23:02.266606 kernel: installing Xen timer for CPU 5 Sep 11 00:23:02.266618 kernel: #5 Sep 11 00:23:02.266630 kernel: installing Xen timer for CPU 6 Sep 11 00:23:02.266642 kernel: #6 Sep 11 00:23:02.266655 kernel: installing Xen timer for CPU 7 Sep 11 00:23:02.266667 kernel: #7 Sep 11 00:23:02.266679 kernel: cpu 4 spinlock event irq 92 Sep 11 00:23:02.266692 kernel: Transient Scheduler Attacks: 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. Sep 11 00:23:02.266705 kernel: Transient Scheduler Attacks: 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. Sep 11 00:23:02.266720 kernel: cpu 5 spinlock event irq 93 Sep 11 00:23:02.266733 kernel: cpu 6 spinlock event irq 94 Sep 11 00:23:02.266746 kernel: cpu 7 spinlock event irq 95 Sep 11 00:23:02.266758 kernel: smp: Brought up 1 node, 8 CPUs Sep 11 00:23:02.266770 kernel: smpboot: Total of 8 processors activated (36800.06 BogoMIPS) Sep 11 00:23:02.266783 kernel: Memory: 32811228K/33554036K available (14336K kernel code, 2429K rwdata, 9960K rodata, 53832K init, 1088K bss, 730244K reserved, 0K cma-reserved) Sep 11 00:23:02.266796 kernel: devtmpfs: initialized Sep 11 00:23:02.266808 kernel: x86/mm: Memory block size: 128MB Sep 11 00:23:02.266821 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 11 00:23:02.266833 kernel: futex hash table entries: 4096 (order: 6, 262144 bytes, linear) Sep 11 00:23:02.266847 kernel: pinctrl core: initialized pinctrl subsystem Sep 11 00:23:02.266862 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 11 00:23:02.266874 kernel: audit: initializing netlink subsys (disabled) Sep 11 00:23:02.266887 kernel: audit: type=2000 audit(1757550177.575:1): state=initialized audit_enabled=0 res=1 Sep 11 00:23:02.266900 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 11 00:23:02.266912 kernel: thermal_sys: Registered thermal governor 'user_space' Sep 11 00:23:02.266925 kernel: cpuidle: using governor menu Sep 11 00:23:02.266937 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 11 00:23:02.266950 kernel: dca service started, version 1.12.1 Sep 11 00:23:02.266962 kernel: PCI: Using configuration type 1 for base access Sep 11 00:23:02.266975 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Sep 11 00:23:02.266990 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 11 00:23:02.267003 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Sep 11 00:23:02.267015 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 11 00:23:02.267028 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Sep 11 00:23:02.267055 kernel: ACPI: Added _OSI(Module Device) Sep 11 00:23:02.267068 kernel: ACPI: Added _OSI(Processor Device) Sep 11 00:23:02.267080 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 11 00:23:02.267093 kernel: ACPI: 3 ACPI AML tables successfully acquired and loaded Sep 11 00:23:02.267105 kernel: xen: --> pirq=16 -> irq=9 (gsi=9) Sep 11 00:23:02.267118 kernel: ACPI: Interpreter enabled Sep 11 00:23:02.267130 kernel: ACPI: PM: (supports S0 S3 S5) Sep 11 00:23:02.267143 kernel: ACPI: Using IOAPIC for interrupt routing Sep 11 00:23:02.267159 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 11 00:23:02.267172 kernel: PCI: Using E820 reservations for host bridge windows Sep 11 00:23:02.267184 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Sep 11 00:23:02.267197 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 11 00:23:02.267370 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Sep 11 00:23:02.267496 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Sep 11 00:23:02.267617 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Sep 11 00:23:02.267634 kernel: acpiphp: Slot [0] registered Sep 11 00:23:02.267647 kernel: acpiphp: Slot [3] registered Sep 11 00:23:02.267665 kernel: acpiphp: Slot [4] registered Sep 11 00:23:02.267677 kernel: acpiphp: Slot [5] registered Sep 11 00:23:02.267690 kernel: acpiphp: Slot [6] registered Sep 11 00:23:02.267702 kernel: acpiphp: Slot [7] registered Sep 11 00:23:02.267715 kernel: acpiphp: Slot [8] registered Sep 11 00:23:02.267727 kernel: acpiphp: Slot [9] registered Sep 11 00:23:02.267740 kernel: acpiphp: Slot [10] registered Sep 11 00:23:02.267752 kernel: acpiphp: Slot [11] registered Sep 11 00:23:02.267765 kernel: acpiphp: Slot [12] registered Sep 11 00:23:02.267777 kernel: acpiphp: Slot [13] registered Sep 11 00:23:02.267790 kernel: acpiphp: Slot [14] registered Sep 11 00:23:02.267802 kernel: acpiphp: Slot [15] registered Sep 11 00:23:02.267815 kernel: acpiphp: Slot [16] registered Sep 11 00:23:02.267830 kernel: acpiphp: Slot [17] registered Sep 11 00:23:02.267842 kernel: acpiphp: Slot [18] registered Sep 11 00:23:02.267855 kernel: acpiphp: Slot [19] registered Sep 11 00:23:02.267867 kernel: acpiphp: Slot [20] registered Sep 11 00:23:02.267880 kernel: acpiphp: Slot [21] registered Sep 11 00:23:02.267892 kernel: acpiphp: Slot [22] registered Sep 11 00:23:02.267905 kernel: acpiphp: Slot [23] registered Sep 11 00:23:02.267919 kernel: acpiphp: Slot [24] registered Sep 11 00:23:02.267932 kernel: acpiphp: Slot [25] registered Sep 11 00:23:02.267944 kernel: acpiphp: Slot [26] registered Sep 11 00:23:02.267956 kernel: acpiphp: Slot [27] registered Sep 11 00:23:02.267969 kernel: acpiphp: Slot [28] registered Sep 11 00:23:02.267984 kernel: acpiphp: Slot [29] registered Sep 11 00:23:02.267996 kernel: acpiphp: Slot [30] registered Sep 11 00:23:02.268009 kernel: acpiphp: Slot [31] registered Sep 11 00:23:02.268021 kernel: PCI host bridge to bus 0000:00 Sep 11 00:23:02.268162 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Sep 11 00:23:02.268312 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Sep 11 00:23:02.268438 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Sep 11 00:23:02.268539 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfbffffff window] Sep 11 00:23:02.268638 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 11 00:23:02.268769 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint Sep 11 00:23:02.268908 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint Sep 11 00:23:02.269051 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint Sep 11 00:23:02.269179 kernel: pci 0000:00:01.1: BAR 4 [io 0xc100-0xc10f] Sep 11 00:23:02.269304 kernel: pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk Sep 11 00:23:02.269416 kernel: pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk Sep 11 00:23:02.269528 kernel: pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk Sep 11 00:23:02.269639 kernel: pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk Sep 11 00:23:02.269664 kernel: * Found PM-Timer Bug on the chipset. Due to workarounds for a bug, * this clock source is slow. Consider trying other clock sources Sep 11 00:23:02.269791 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint Sep 11 00:23:02.269906 kernel: pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI Sep 11 00:23:02.270026 kernel: pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 conventional PCI endpoint Sep 11 00:23:02.270188 kernel: pci 0000:00:02.0: BAR 0 [mem 0xf0000000-0xf1ffffff pref] Sep 11 00:23:02.270312 kernel: pci 0000:00:02.0: BAR 1 [mem 0xf3008000-0xf3008fff] Sep 11 00:23:02.270425 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Sep 11 00:23:02.270545 kernel: pci 0000:00:03.0: [8086:10ed] type 00 class 0x020000 conventional PCI endpoint Sep 11 00:23:02.270664 kernel: pci 0000:00:03.0: BAR 0 [mem 0xf3000000-0xf3003fff 64bit pref] Sep 11 00:23:02.270779 kernel: pci 0000:00:03.0: BAR 3 [mem 0xf3004000-0xf3007fff 64bit pref] Sep 11 00:23:02.270899 kernel: pci 0000:00:1f.0: [5853:0001] type 00 class 0xff8000 conventional PCI endpoint Sep 11 00:23:02.271016 kernel: pci 0000:00:1f.0: BAR 0 [io 0xc000-0xc0ff] Sep 11 00:23:02.271164 kernel: pci 0000:00:1f.0: BAR 1 [mem 0xf2000000-0xf2ffffff pref] Sep 11 00:23:02.271182 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 5 Sep 11 00:23:02.271196 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Sep 11 00:23:02.271208 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Sep 11 00:23:02.271221 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 5 Sep 11 00:23:02.271234 kernel: xen:balloon: Initialising balloon driver Sep 11 00:23:02.271247 kernel: iommu: Default domain type: Translated Sep 11 00:23:02.271259 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Sep 11 00:23:02.271272 kernel: PCI: Using ACPI for IRQ routing Sep 11 00:23:02.271285 kernel: PCI: pci_cache_line_size set to 64 bytes Sep 11 00:23:02.271298 kernel: e820: reserve RAM buffer [mem 0x0009e000-0x0009ffff] Sep 11 00:23:02.271407 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Sep 11 00:23:02.271526 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Sep 11 00:23:02.271640 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Sep 11 00:23:02.271658 kernel: vgaarb: loaded Sep 11 00:23:02.271671 kernel: hpet: 3 channels of 0 reserved for per-cpu timers Sep 11 00:23:02.271683 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Sep 11 00:23:02.271696 kernel: hpet0: 3 comparators, 64-bit 62.500000 MHz counter Sep 11 00:23:02.271709 kernel: clocksource: Switched to clocksource xen Sep 11 00:23:02.271721 kernel: VFS: Disk quotas dquot_6.6.0 Sep 11 00:23:02.271735 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 11 00:23:02.271748 kernel: pnp: PnP ACPI init Sep 11 00:23:02.271867 kernel: system 00:00: [mem 0x00000000-0x0009ffff] could not be reserved Sep 11 00:23:02.271987 kernel: system 00:01: [io 0x08a0-0x08a3] has been reserved Sep 11 00:23:02.272118 kernel: system 00:01: [io 0x0cc0-0x0ccf] has been reserved Sep 11 00:23:02.272226 kernel: system 00:01: [io 0x04d0-0x04d1] has been reserved Sep 11 00:23:02.272262 kernel: xen: --> pirq=17 -> irq=8 (gsi=8) Sep 11 00:23:02.272277 kernel: xen: --> pirq=18 -> irq=12 (gsi=12) Sep 11 00:23:02.272289 kernel: xen: --> pirq=19 -> irq=1 (gsi=1) Sep 11 00:23:02.272302 kernel: xen: --> pirq=20 -> irq=6 (gsi=6) Sep 11 00:23:02.272420 kernel: pnp 00:05: [dma 2] Sep 11 00:23:02.272445 kernel: xen: --> pirq=21 -> irq=4 (gsi=4) Sep 11 00:23:02.272563 kernel: system 00:07: [io 0x10c0-0x1141] has been reserved Sep 11 00:23:02.272683 kernel: system 00:07: [io 0xb044-0xb047] has been reserved Sep 11 00:23:02.272702 kernel: pnp: PnP ACPI: found 8 devices Sep 11 00:23:02.272715 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Sep 11 00:23:02.272728 kernel: NET: Registered PF_INET protocol family Sep 11 00:23:02.272741 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 11 00:23:02.272753 kernel: tcp_listen_portaddr_hash hash table entries: 16384 (order: 6, 262144 bytes, linear) Sep 11 00:23:02.272766 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 11 00:23:02.272779 kernel: TCP established hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 11 00:23:02.272797 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Sep 11 00:23:02.272810 kernel: TCP: Hash tables configured (established 262144 bind 65536) Sep 11 00:23:02.272823 kernel: UDP hash table entries: 16384 (order: 7, 524288 bytes, linear) Sep 11 00:23:02.272836 kernel: UDP-Lite hash table entries: 16384 (order: 7, 524288 bytes, linear) Sep 11 00:23:02.272848 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 11 00:23:02.272861 kernel: NET: Registered PF_XDP protocol family Sep 11 00:23:02.272964 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Sep 11 00:23:02.273089 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Sep 11 00:23:02.273193 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Sep 11 00:23:02.273299 kernel: pci_bus 0000:00: resource 7 [mem 0xf0000000-0xfbffffff window] Sep 11 00:23:02.273424 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Sep 11 00:23:02.273544 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Sep 11 00:23:02.273564 kernel: PCI: CLS 0 bytes, default 64 Sep 11 00:23:02.273578 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Sep 11 00:23:02.273592 kernel: software IO TLB: mapped [mem 0x00000000ec000000-0x00000000f0000000] (64MB) Sep 11 00:23:02.273606 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 655360 ms ovfl timer Sep 11 00:23:02.273628 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x212738e3f90, max_idle_ns: 440795225370 ns Sep 11 00:23:02.273658 kernel: Initialise system trusted keyrings Sep 11 00:23:02.273687 kernel: workingset: timestamp_bits=39 max_order=23 bucket_order=0 Sep 11 00:23:02.273708 kernel: Key type asymmetric registered Sep 11 00:23:02.273727 kernel: Asymmetric key parser 'x509' registered Sep 11 00:23:02.273749 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 11 00:23:02.273772 kernel: io scheduler mq-deadline registered Sep 11 00:23:02.273793 kernel: io scheduler kyber registered Sep 11 00:23:02.273815 kernel: io scheduler bfq registered Sep 11 00:23:02.273833 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Sep 11 00:23:02.273855 kernel: xen: --> pirq=22 -> irq=47 (gsi=47) Sep 11 00:23:02.273881 kernel: xen:grant_table: Grant tables using version 1 layout Sep 11 00:23:02.273930 kernel: Grant table initialized Sep 11 00:23:02.273947 kernel: Cannot get hvm parameter CONSOLE_EVTCHN (18): -22! Sep 11 00:23:02.273961 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 11 00:23:02.273975 kernel: 00:06: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Sep 11 00:23:02.273989 kernel: i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12 Sep 11 00:23:02.274003 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Sep 11 00:23:02.274017 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Sep 11 00:23:02.274263 kernel: rtc_cmos 00:02: registered as rtc0 Sep 11 00:23:02.274300 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 Sep 11 00:23:02.274444 kernel: rtc_cmos 00:02: setting system clock to 2025-09-11T00:23:01 UTC (1757550181) Sep 11 00:23:02.274557 kernel: rtc_cmos 00:02: alarms up to one day, 114 bytes nvram, hpet irqs Sep 11 00:23:02.274575 kernel: intel_pstate: CPU model not supported Sep 11 00:23:02.274589 kernel: NET: Registered PF_INET6 protocol family Sep 11 00:23:02.274603 kernel: Segment Routing with IPv6 Sep 11 00:23:02.274617 kernel: In-situ OAM (IOAM) with IPv6 Sep 11 00:23:02.274631 kernel: NET: Registered PF_PACKET protocol family Sep 11 00:23:02.274650 kernel: Key type dns_resolver registered Sep 11 00:23:02.274664 kernel: IPI shorthand broadcast: enabled Sep 11 00:23:02.274678 kernel: sched_clock: Marking stable (3149005347, 779786864)->(5133291770, -1204499559) Sep 11 00:23:02.274692 kernel: registered taskstats version 1 Sep 11 00:23:02.274706 kernel: Loading compiled-in X.509 certificates Sep 11 00:23:02.274720 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.46-flatcar: 8138ce5002a1b572fd22b23ac238f29bab3f249f' Sep 11 00:23:02.274734 kernel: Demotion targets for Node 0: null Sep 11 00:23:02.274747 kernel: Key type .fscrypt registered Sep 11 00:23:02.274761 kernel: Key type fscrypt-provisioning registered Sep 11 00:23:02.274779 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 11 00:23:02.274793 kernel: ima: Allocated hash algorithm: sha1 Sep 11 00:23:02.274806 kernel: ima: No architecture policies found Sep 11 00:23:02.274820 kernel: xenbus_probe_frontend: Device with no driver: device/vbd/51712 Sep 11 00:23:02.274834 kernel: xenbus_probe_frontend: Device with no driver: device/pci/0 Sep 11 00:23:02.274848 kernel: clk: Disabling unused clocks Sep 11 00:23:02.274862 kernel: Warning: unable to open an initial console. Sep 11 00:23:02.274875 kernel: Freeing unused kernel image (initmem) memory: 53832K Sep 11 00:23:02.274889 kernel: Write protecting the kernel read-only data: 24576k Sep 11 00:23:02.274906 kernel: Freeing unused kernel image (rodata/data gap) memory: 280K Sep 11 00:23:02.274920 kernel: Run /init as init process Sep 11 00:23:02.274933 kernel: with arguments: Sep 11 00:23:02.274947 kernel: /init Sep 11 00:23:02.274961 kernel: with environment: Sep 11 00:23:02.274974 kernel: HOME=/ Sep 11 00:23:02.274988 kernel: TERM=linux Sep 11 00:23:02.275004 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 11 00:23:02.275020 systemd[1]: Successfully made /usr/ read-only. Sep 11 00:23:02.275079 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 11 00:23:02.275108 systemd[1]: Detected virtualization xen. Sep 11 00:23:02.275123 systemd[1]: Detected architecture x86-64. Sep 11 00:23:02.275137 systemd[1]: Running in initrd. Sep 11 00:23:02.275150 systemd[1]: No hostname configured, using default hostname. Sep 11 00:23:02.275167 systemd[1]: Hostname set to . Sep 11 00:23:02.275181 systemd[1]: Initializing machine ID from VM UUID. Sep 11 00:23:02.275199 systemd[1]: Queued start job for default target initrd.target. Sep 11 00:23:02.275213 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 11 00:23:02.275228 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 11 00:23:02.275243 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 11 00:23:02.275257 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 11 00:23:02.275272 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 11 00:23:02.275289 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 11 00:23:02.275307 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 11 00:23:02.275321 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 11 00:23:02.275336 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 11 00:23:02.275353 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 11 00:23:02.275368 systemd[1]: Reached target paths.target - Path Units. Sep 11 00:23:02.275384 systemd[1]: Reached target slices.target - Slice Units. Sep 11 00:23:02.275399 systemd[1]: Reached target swap.target - Swaps. Sep 11 00:23:02.275413 systemd[1]: Reached target timers.target - Timer Units. Sep 11 00:23:02.275427 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 11 00:23:02.275441 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 11 00:23:02.275456 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 11 00:23:02.275470 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 11 00:23:02.275484 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 11 00:23:02.275499 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 11 00:23:02.275516 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 11 00:23:02.275530 systemd[1]: Reached target sockets.target - Socket Units. Sep 11 00:23:02.275544 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 11 00:23:02.275558 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 11 00:23:02.275573 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 11 00:23:02.275588 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Sep 11 00:23:02.275602 systemd[1]: Starting systemd-fsck-usr.service... Sep 11 00:23:02.275616 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 11 00:23:02.275633 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 11 00:23:02.275676 systemd-journald[251]: Collecting audit messages is disabled. Sep 11 00:23:02.275723 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 11 00:23:02.275738 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 11 00:23:02.275771 systemd-journald[251]: Journal started Sep 11 00:23:02.275815 systemd-journald[251]: Runtime Journal (/run/log/journal/ec296c666baa842597ee4772637f4784) is 8M, max 642.1M, 634.1M free. Sep 11 00:23:02.274392 systemd-modules-load[253]: Inserted module 'overlay' Sep 11 00:23:02.293071 systemd[1]: Started systemd-journald.service - Journal Service. Sep 11 00:23:02.298087 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 11 00:23:02.298771 systemd[1]: Finished systemd-fsck-usr.service. Sep 11 00:23:02.301392 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 11 00:23:02.302806 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 11 00:23:02.351538 systemd-tmpfiles[265]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 11 00:23:02.668517 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 11 00:23:02.668571 kernel: Bridge firewalling registered Sep 11 00:23:02.353188 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 11 00:23:02.377083 systemd-modules-load[253]: Inserted module 'br_netfilter' Sep 11 00:23:02.668861 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 11 00:23:02.693821 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 11 00:23:02.698193 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 11 00:23:02.715417 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 11 00:23:02.718943 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 11 00:23:02.743953 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 11 00:23:02.771616 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 11 00:23:02.772077 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 11 00:23:02.774616 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 11 00:23:02.782407 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 11 00:23:02.796858 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 11 00:23:02.821507 dracut-cmdline[294]: Using kernel command line parameters: rd.driver.pre=btrfs 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=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=24178014e7d1a618b6c727661dc98ca9324f7f5aeefcaa5f4996d4d839e6e63a Sep 11 00:23:02.836872 systemd-resolved[286]: Positive Trust Anchors: Sep 11 00:23:02.836881 systemd-resolved[286]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 11 00:23:02.836916 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 Sep 11 00:23:02.839872 systemd-resolved[286]: Defaulting to hostname 'linux'. Sep 11 00:23:02.841010 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 11 00:23:02.862725 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 11 00:23:02.932054 kernel: SCSI subsystem initialized Sep 11 00:23:02.946068 kernel: Loading iSCSI transport class v2.0-870. Sep 11 00:23:02.962067 kernel: iscsi: registered transport (tcp) Sep 11 00:23:02.989940 kernel: iscsi: registered transport (qla4xxx) Sep 11 00:23:02.989994 kernel: QLogic iSCSI HBA Driver Sep 11 00:23:03.009381 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 11 00:23:03.036682 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 11 00:23:03.038200 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 11 00:23:03.090531 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 11 00:23:03.092074 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 11 00:23:03.155067 kernel: raid6: avx2x4 gen() 26066 MB/s Sep 11 00:23:03.174064 kernel: raid6: avx2x2 gen() 26465 MB/s Sep 11 00:23:03.195720 kernel: raid6: avx2x1 gen() 23575 MB/s Sep 11 00:23:03.195745 kernel: raid6: using algorithm avx2x2 gen() 26465 MB/s Sep 11 00:23:03.218268 kernel: raid6: .... xor() 15419 MB/s, rmw enabled Sep 11 00:23:03.218312 kernel: raid6: using avx2x2 recovery algorithm Sep 11 00:23:03.245069 kernel: xor: automatically using best checksumming function avx Sep 11 00:23:03.472066 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 11 00:23:03.479670 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 11 00:23:03.485604 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 11 00:23:03.534757 systemd-udevd[504]: Using default interface naming scheme 'v255'. Sep 11 00:23:03.541616 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 11 00:23:03.542620 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 11 00:23:03.589136 dracut-pre-trigger[508]: rd.md=0: removing MD RAID activation Sep 11 00:23:03.614585 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 11 00:23:03.615835 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 11 00:23:03.768824 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 11 00:23:03.782974 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 11 00:23:03.830293 kernel: cryptd: max_cpu_qlen set to 1000 Sep 11 00:23:03.874708 kernel: ixgbevf: Intel(R) 10 Gigabit PCI Express Virtual Function Network Driver Sep 11 00:23:03.874765 kernel: ixgbevf: Copyright (c) 2009 - 2018 Intel Corporation. Sep 11 00:23:03.875079 kernel: AES CTR mode by8 optimization enabled Sep 11 00:23:03.891206 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Sep 11 00:23:03.891256 kernel: libata version 3.00 loaded. Sep 11 00:23:03.899365 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 11 00:23:03.950682 kernel: ixgbevf 0000:00:03.0: 06:61:e6:21:2f:07 Sep 11 00:23:03.950969 kernel: ixgbevf 0000:00:03.0: MAC: 1 Sep 11 00:23:03.951249 kernel: ixgbevf 0000:00:03.0: Intel(R) 82599 Virtual Function Sep 11 00:23:03.951487 kernel: ata_piix 0000:00:01.1: version 2.13 Sep 11 00:23:03.951725 kernel: blkfront: xvda: barrier or flush: disabled; persistent grants: disabled; indirect descriptors: enabled; bounce buffer: disabled; Sep 11 00:23:03.951768 kernel: scsi host0: ata_piix Sep 11 00:23:03.952013 kernel: scsi host1: ata_piix Sep 11 00:23:03.952200 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc100 irq 14 lpm-pol 0 Sep 11 00:23:03.952221 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc108 irq 15 lpm-pol 0 Sep 11 00:23:03.952239 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Sep 11 00:23:03.952256 kernel: GPT:9289727 != 16777215 Sep 11 00:23:03.952273 kernel: GPT:Alternate GPT header not at the end of the disk. Sep 11 00:23:03.952290 kernel: GPT:9289727 != 16777215 Sep 11 00:23:03.952312 kernel: GPT: Use GNU Parted to correct GPT errors. Sep 11 00:23:03.952330 kernel: xvda: xvda1 xvda2 xvda3 xvda4 xvda6 xvda7 xvda9 Sep 11 00:23:03.899573 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 11 00:23:03.907024 (udev-worker)[568]: Network interface NamePolicy= disabled on kernel command line. Sep 11 00:23:03.950737 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 11 00:23:03.956163 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 11 00:23:03.964415 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Sep 11 00:23:04.267214 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 11 00:23:04.653970 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 11 00:23:04.702892 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 11 00:23:04.726520 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 11 00:23:04.726668 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 11 00:23:04.739537 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 11 00:23:04.750939 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 11 00:23:04.780769 disk-uuid[670]: Primary Header is updated. Sep 11 00:23:04.780769 disk-uuid[670]: Secondary Entries is updated. Sep 11 00:23:04.780769 disk-uuid[670]: Secondary Header is updated. Sep 11 00:23:04.991612 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 11 00:23:04.992787 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 11 00:23:05.005475 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 11 00:23:05.010479 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 11 00:23:05.020888 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 11 00:23:05.062920 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 11 00:23:05.795990 disk-uuid[671]: The operation has completed successfully. Sep 11 00:23:05.800397 kernel: xvda: xvda1 xvda2 xvda3 xvda4 xvda6 xvda7 xvda9 Sep 11 00:23:05.869355 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 11 00:23:05.869478 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 11 00:23:05.879524 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 11 00:23:05.904467 sh[698]: Success Sep 11 00:23:05.987119 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 11 00:23:05.987185 kernel: device-mapper: uevent: version 1.0.3 Sep 11 00:23:05.992394 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 11 00:23:06.006081 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Sep 11 00:23:06.326686 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 11 00:23:06.328716 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 11 00:23:06.353665 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 11 00:23:06.396073 kernel: BTRFS: device fsid f1eb5eb7-34cc-49c0-9f2b-e603bd772d66 devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (710) Sep 11 00:23:06.404910 kernel: BTRFS info (device dm-0): first mount of filesystem f1eb5eb7-34cc-49c0-9f2b-e603bd772d66 Sep 11 00:23:06.404943 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Sep 11 00:23:07.572340 kernel: BTRFS info (device dm-0): enabling ssd optimizations Sep 11 00:23:07.572415 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 11 00:23:07.572434 kernel: BTRFS info (device dm-0): enabling free space tree Sep 11 00:23:07.815697 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 11 00:23:07.820981 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 11 00:23:07.830439 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 11 00:23:07.831425 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 11 00:23:07.857543 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 11 00:23:07.913083 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/xvda6 (202:6) scanned by mount (741) Sep 11 00:23:07.922316 kernel: BTRFS info (device xvda6): first mount of filesystem a5de7b5e-e14d-4c62-883d-af7ea22fae7e Sep 11 00:23:07.922352 kernel: BTRFS info (device xvda6): using crc32c (crc32c-intel) checksum algorithm Sep 11 00:23:07.958822 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 11 00:23:07.960686 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 11 00:23:08.015895 systemd-networkd[873]: lo: Link UP Sep 11 00:23:08.015913 systemd-networkd[873]: lo: Gained carrier Sep 11 00:23:08.033790 kernel: BTRFS info (device xvda6): enabling ssd optimizations Sep 11 00:23:08.033827 kernel: BTRFS info (device xvda6): enabling free space tree Sep 11 00:23:08.017459 systemd-networkd[873]: Enumeration completed Sep 11 00:23:08.044591 kernel: ixgbevf 0000:00:03.0: NIC Link is Up 10 Gbps Sep 11 00:23:08.017576 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 11 00:23:08.054634 kernel: BTRFS info (device xvda6): last unmount of filesystem a5de7b5e-e14d-4c62-883d-af7ea22fae7e Sep 11 00:23:08.017930 systemd-networkd[873]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 11 00:23:08.017934 systemd-networkd[873]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 11 00:23:08.024491 systemd[1]: Reached target network.target - Network. Sep 11 00:23:08.038756 systemd-networkd[873]: eth0: Link UP Sep 11 00:23:08.040254 systemd-networkd[873]: eth0: Gained carrier Sep 11 00:23:08.040267 systemd-networkd[873]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 11 00:23:08.055115 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 11 00:23:08.066618 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 11 00:23:08.107109 systemd-networkd[873]: eth0: DHCPv4 address 172.31.30.249/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 11 00:23:08.152496 systemd-networkd[873]: eth0: Lost carrier Sep 11 00:23:08.158744 kernel: ixgbevf 0000:00:03.0: NIC Link is Up 10 Gbps Sep 11 00:23:08.157273 systemd-networkd[873]: eth0: Gained carrier Sep 11 00:23:08.157286 systemd-networkd[873]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 11 00:23:09.206170 systemd-networkd[873]: eth0: Gained IPv6LL Sep 11 00:23:11.706975 ignition[881]: Ignition 2.21.0 Sep 11 00:23:11.706998 ignition[881]: Stage: fetch-offline Sep 11 00:23:11.707234 ignition[881]: no configs at "/usr/lib/ignition/base.d" Sep 11 00:23:11.707246 ignition[881]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 00:23:11.707832 ignition[881]: Ignition finished successfully Sep 11 00:23:11.724422 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 11 00:23:11.730903 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 11 00:23:11.778014 ignition[893]: Ignition 2.21.0 Sep 11 00:23:11.778392 ignition[893]: Stage: fetch Sep 11 00:23:11.781770 ignition[893]: no configs at "/usr/lib/ignition/base.d" Sep 11 00:23:11.781795 ignition[893]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 00:23:11.781926 ignition[893]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 00:23:11.785793 ignition[893]: PUT result: OK Sep 11 00:23:11.793111 unknown[893]: fetched base config from "system" Sep 11 00:23:11.787954 ignition[893]: parsed url from cmdline: "" Sep 11 00:23:11.793121 unknown[893]: fetched base config from "system" Sep 11 00:23:11.787960 ignition[893]: no config URL provided Sep 11 00:23:11.793132 unknown[893]: fetched user config from "aws" Sep 11 00:23:11.787972 ignition[893]: reading system config file "/usr/lib/ignition/user.ign" Sep 11 00:23:11.796177 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 11 00:23:11.787985 ignition[893]: no config at "/usr/lib/ignition/user.ign" Sep 11 00:23:11.799310 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 11 00:23:11.788012 ignition[893]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 00:23:11.788813 ignition[893]: PUT result: OK Sep 11 00:23:11.788859 ignition[893]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Sep 11 00:23:11.789737 ignition[893]: GET result: OK Sep 11 00:23:11.789803 ignition[893]: parsing config with SHA512: 8692de467592fe96f7af07d758af07956e79e3a516164dd2b67ee62191d0b5a6bbb02b5b0c3d12c573335cf4a9d0b3667954503a444d8934427d462bfb371cc2 Sep 11 00:23:11.793330 ignition[893]: fetch: fetch complete Sep 11 00:23:11.793337 ignition[893]: fetch: fetch passed Sep 11 00:23:11.793379 ignition[893]: Ignition finished successfully Sep 11 00:23:11.871300 ignition[904]: Ignition 2.21.0 Sep 11 00:23:11.871321 ignition[904]: Stage: kargs Sep 11 00:23:11.871627 ignition[904]: no configs at "/usr/lib/ignition/base.d" Sep 11 00:23:11.871640 ignition[904]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 00:23:11.871724 ignition[904]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 00:23:11.872821 ignition[904]: PUT result: OK Sep 11 00:23:11.882219 ignition[904]: kargs: kargs passed Sep 11 00:23:11.889014 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 11 00:23:11.882278 ignition[904]: Ignition finished successfully Sep 11 00:23:11.891808 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 11 00:23:11.933224 ignition[915]: Ignition 2.21.0 Sep 11 00:23:11.933242 ignition[915]: Stage: disks Sep 11 00:23:11.933592 ignition[915]: no configs at "/usr/lib/ignition/base.d" Sep 11 00:23:11.933606 ignition[915]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 00:23:11.933704 ignition[915]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 00:23:11.934902 ignition[915]: PUT result: OK Sep 11 00:23:11.947535 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 11 00:23:11.941521 ignition[915]: disks: disks passed Sep 11 00:23:11.950693 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 11 00:23:11.941574 ignition[915]: Ignition finished successfully Sep 11 00:23:11.961483 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 11 00:23:11.970333 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 11 00:23:11.976892 systemd[1]: Reached target sysinit.target - System Initialization. Sep 11 00:23:11.985418 systemd[1]: Reached target basic.target - Basic System. Sep 11 00:23:11.993177 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 11 00:23:12.097640 systemd-fsck[929]: ROOT: clean, 15/553520 files, 52789/553472 blocks Sep 11 00:23:12.102713 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 11 00:23:12.104082 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 11 00:23:12.526073 kernel: EXT4-fs (xvda9): mounted filesystem 6a9ce0af-81d0-4628-9791-e47488ed2744 r/w with ordered data mode. Quota mode: none. Sep 11 00:23:12.527193 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 11 00:23:12.527841 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 11 00:23:12.541103 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 11 00:23:12.544611 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 11 00:23:12.550517 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 11 00:23:12.550586 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 11 00:23:12.550621 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 11 00:23:12.585877 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 11 00:23:12.587283 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 11 00:23:12.618064 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/xvda6 (202:6) scanned by mount (938) Sep 11 00:23:12.628149 kernel: BTRFS info (device xvda6): first mount of filesystem a5de7b5e-e14d-4c62-883d-af7ea22fae7e Sep 11 00:23:12.628176 kernel: BTRFS info (device xvda6): using crc32c (crc32c-intel) checksum algorithm Sep 11 00:23:12.642757 kernel: BTRFS info (device xvda6): enabling ssd optimizations Sep 11 00:23:12.642797 kernel: BTRFS info (device xvda6): enabling free space tree Sep 11 00:23:12.644135 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 11 00:23:16.375881 initrd-setup-root[962]: cut: /sysroot/etc/passwd: No such file or directory Sep 11 00:23:16.538297 initrd-setup-root[969]: cut: /sysroot/etc/group: No such file or directory Sep 11 00:23:16.542656 initrd-setup-root[976]: cut: /sysroot/etc/shadow: No such file or directory Sep 11 00:23:16.546983 initrd-setup-root[983]: cut: /sysroot/etc/gshadow: No such file or directory Sep 11 00:23:18.608280 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 11 00:23:18.615328 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 11 00:23:18.642702 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 11 00:23:18.648268 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 11 00:23:18.662138 kernel: BTRFS info (device xvda6): last unmount of filesystem a5de7b5e-e14d-4c62-883d-af7ea22fae7e Sep 11 00:23:18.686127 ignition[1051]: INFO : Ignition 2.21.0 Sep 11 00:23:18.686127 ignition[1051]: INFO : Stage: mount Sep 11 00:23:18.693848 ignition[1051]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 11 00:23:18.693848 ignition[1051]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 00:23:18.693848 ignition[1051]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 00:23:18.693848 ignition[1051]: INFO : PUT result: OK Sep 11 00:23:18.693848 ignition[1051]: INFO : mount: mount passed Sep 11 00:23:18.693848 ignition[1051]: INFO : Ignition finished successfully Sep 11 00:23:18.693795 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 11 00:23:18.700786 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 11 00:23:18.710297 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 11 00:23:18.739004 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 11 00:23:18.781070 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/xvda6 (202:6) scanned by mount (1068) Sep 11 00:23:18.791687 kernel: BTRFS info (device xvda6): first mount of filesystem a5de7b5e-e14d-4c62-883d-af7ea22fae7e Sep 11 00:23:18.791721 kernel: BTRFS info (device xvda6): using crc32c (crc32c-intel) checksum algorithm Sep 11 00:23:18.807048 kernel: BTRFS info (device xvda6): enabling ssd optimizations Sep 11 00:23:18.807106 kernel: BTRFS info (device xvda6): enabling free space tree Sep 11 00:23:18.808809 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 11 00:23:18.848947 ignition[1085]: INFO : Ignition 2.21.0 Sep 11 00:23:18.848947 ignition[1085]: INFO : Stage: files Sep 11 00:23:18.855754 ignition[1085]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 11 00:23:18.855754 ignition[1085]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 00:23:18.855754 ignition[1085]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 00:23:18.855754 ignition[1085]: INFO : PUT result: OK Sep 11 00:23:18.875129 ignition[1085]: DEBUG : files: compiled without relabeling support, skipping Sep 11 00:23:18.880465 ignition[1085]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 11 00:23:18.880465 ignition[1085]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 11 00:23:19.033308 ignition[1085]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 11 00:23:19.039821 ignition[1085]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 11 00:23:19.039821 ignition[1085]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 11 00:23:19.039821 ignition[1085]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 11 00:23:19.039821 ignition[1085]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 11 00:23:19.039821 ignition[1085]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 11 00:23:19.034158 unknown[1085]: wrote ssh authorized keys file for user: core Sep 11 00:23:19.080816 ignition[1085]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 11 00:23:19.080816 ignition[1085]: INFO : files: files passed Sep 11 00:23:19.080816 ignition[1085]: INFO : Ignition finished successfully Sep 11 00:23:19.098574 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 11 00:23:19.099797 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 11 00:23:19.125678 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 11 00:23:19.129379 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 11 00:23:19.129487 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 11 00:23:19.153014 initrd-setup-root-after-ignition[1120]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 11 00:23:19.153014 initrd-setup-root-after-ignition[1120]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 11 00:23:19.173462 initrd-setup-root-after-ignition[1124]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 11 00:23:19.153165 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 11 00:23:19.173532 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 11 00:23:19.186628 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 11 00:23:19.223824 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 11 00:23:19.223943 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 11 00:23:19.228668 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 11 00:23:19.240195 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 11 00:23:19.254254 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 11 00:23:19.255055 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 11 00:23:19.303668 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 11 00:23:19.305437 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 11 00:23:19.340834 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 11 00:23:19.341096 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 11 00:23:19.351677 systemd[1]: Stopped target timers.target - Timer Units. Sep 11 00:23:19.362639 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 11 00:23:19.362797 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 11 00:23:19.380896 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 11 00:23:19.386470 systemd[1]: Stopped target basic.target - Basic System. Sep 11 00:23:19.395744 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 11 00:23:19.403991 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 11 00:23:19.413985 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 11 00:23:19.424592 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 11 00:23:19.434741 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 11 00:23:19.444950 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 11 00:23:19.454355 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 11 00:23:19.465726 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 11 00:23:19.475056 systemd[1]: Stopped target swap.target - Swaps. Sep 11 00:23:19.484143 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 11 00:23:19.484286 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 11 00:23:19.500860 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 11 00:23:19.505804 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 11 00:23:19.515307 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 11 00:23:19.515470 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 11 00:23:19.525864 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 11 00:23:19.526013 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 11 00:23:19.546604 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 11 00:23:19.546776 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 11 00:23:19.551080 systemd[1]: ignition-files.service: Deactivated successfully. Sep 11 00:23:19.551235 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 11 00:23:19.561839 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 11 00:23:19.570841 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 11 00:23:19.613446 ignition[1144]: INFO : Ignition 2.21.0 Sep 11 00:23:19.613446 ignition[1144]: INFO : Stage: umount Sep 11 00:23:19.613446 ignition[1144]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 11 00:23:19.613446 ignition[1144]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 00:23:19.613446 ignition[1144]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 00:23:19.613446 ignition[1144]: INFO : PUT result: OK Sep 11 00:23:19.570995 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 11 00:23:19.670850 ignition[1144]: INFO : umount: umount passed Sep 11 00:23:19.670850 ignition[1144]: INFO : Ignition finished successfully Sep 11 00:23:19.593646 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 11 00:23:19.594607 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 11 00:23:19.594758 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 11 00:23:19.608777 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 11 00:23:19.608944 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 11 00:23:19.617863 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 11 00:23:19.617968 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 11 00:23:19.625880 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 11 00:23:19.627357 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 11 00:23:19.627479 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 11 00:23:19.633856 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 11 00:23:19.633906 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 11 00:23:19.643697 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 11 00:23:19.643745 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 11 00:23:19.653589 systemd[1]: Stopped target network.target - Network. Sep 11 00:23:19.665320 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 11 00:23:19.665373 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 11 00:23:19.676823 systemd[1]: Stopped target paths.target - Path Units. Sep 11 00:23:19.684374 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 11 00:23:19.688115 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 11 00:23:19.694315 systemd[1]: Stopped target slices.target - Slice Units. Sep 11 00:23:19.702639 systemd[1]: Stopped target sockets.target - Socket Units. Sep 11 00:23:19.711483 systemd[1]: iscsid.socket: Deactivated successfully. Sep 11 00:23:19.711532 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 11 00:23:19.721147 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 11 00:23:19.721196 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 11 00:23:19.730476 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 11 00:23:19.730529 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 11 00:23:19.740114 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 11 00:23:19.740159 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 11 00:23:19.749484 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 11 00:23:19.758552 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 11 00:23:19.767857 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 11 00:23:19.767975 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 11 00:23:19.782136 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 11 00:23:19.782507 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 11 00:23:19.782615 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 11 00:23:19.795840 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Sep 11 00:23:19.796154 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 11 00:23:19.796251 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 11 00:23:19.799706 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 11 00:23:19.799802 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 11 00:23:19.812736 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 11 00:23:19.818280 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 11 00:23:19.818339 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 11 00:23:19.828149 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 11 00:23:19.828203 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 11 00:23:19.845020 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 11 00:23:19.853121 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 11 00:23:19.853177 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 11 00:23:19.853301 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 11 00:23:19.853344 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 11 00:23:19.864553 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 11 00:23:19.864600 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 11 00:23:19.869912 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 11 00:23:19.869963 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 11 00:23:19.887523 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 11 00:23:19.898219 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Sep 11 00:23:19.898294 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Sep 11 00:23:19.922840 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 11 00:23:19.923071 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 11 00:23:19.932798 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 11 00:23:19.932851 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 11 00:23:19.942282 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 11 00:23:19.942324 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 11 00:23:19.952000 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 11 00:23:19.952121 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 11 00:23:19.966643 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 11 00:23:19.966701 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 11 00:23:19.980727 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 11 00:23:19.980787 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 11 00:23:20.008151 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 11 00:23:20.172263 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 11 00:23:20.172331 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 11 00:23:20.189736 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 11 00:23:20.189792 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 11 00:23:20.200966 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 11 00:23:20.201020 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 11 00:23:20.218454 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Sep 11 00:23:20.218521 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Sep 11 00:23:20.218578 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Sep 11 00:23:20.219100 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 11 00:23:20.219220 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 11 00:23:20.222863 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 11 00:23:20.222964 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 11 00:23:20.257391 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 11 00:23:20.262398 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 11 00:23:20.298871 systemd[1]: Switching root. Sep 11 00:23:20.550254 systemd-journald[251]: Journal stopped Sep 11 00:23:27.120572 systemd-journald[251]: Received SIGTERM from PID 1 (systemd). Sep 11 00:23:27.120681 kernel: SELinux: policy capability network_peer_controls=1 Sep 11 00:23:27.120722 kernel: SELinux: policy capability open_perms=1 Sep 11 00:23:27.120742 kernel: SELinux: policy capability extended_socket_class=1 Sep 11 00:23:27.120769 kernel: SELinux: policy capability always_check_network=0 Sep 11 00:23:27.120799 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 11 00:23:27.120830 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 11 00:23:27.120851 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 11 00:23:27.120875 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 11 00:23:27.120898 kernel: SELinux: policy capability userspace_initial_context=0 Sep 11 00:23:27.120922 kernel: audit: type=1403 audit(1757550202.333:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 11 00:23:27.120949 systemd[1]: Successfully loaded SELinux policy in 434.146ms. Sep 11 00:23:27.120986 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 13.640ms. Sep 11 00:23:27.121014 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 11 00:23:27.121059 systemd[1]: Detected virtualization xen. Sep 11 00:23:27.121095 systemd[1]: Detected architecture x86-64. Sep 11 00:23:27.121126 systemd[1]: Detected first boot. Sep 11 00:23:27.121149 systemd[1]: Initializing machine ID from VM UUID. Sep 11 00:23:27.121173 kernel: Guest personality initialized and is inactive Sep 11 00:23:27.121198 kernel: VMCI host device registered (name=vmci, major=10, minor=124) Sep 11 00:23:27.121218 kernel: Initialized host personality Sep 11 00:23:27.121242 zram_generator::config[1193]: No configuration found. Sep 11 00:23:27.121267 kernel: NET: Registered PF_VSOCK protocol family Sep 11 00:23:27.121300 systemd[1]: Populated /etc with preset unit settings. Sep 11 00:23:27.121321 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 11 00:23:27.121345 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 11 00:23:27.121362 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 11 00:23:27.121387 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 11 00:23:27.121409 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 11 00:23:27.121435 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 11 00:23:27.121453 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 11 00:23:27.121478 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 11 00:23:27.121501 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 11 00:23:27.121527 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 11 00:23:27.121545 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 11 00:23:27.121574 systemd[1]: Created slice user.slice - User and Session Slice. Sep 11 00:23:27.121596 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 11 00:23:27.121622 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 11 00:23:27.121641 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 11 00:23:27.121663 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 11 00:23:27.121685 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 11 00:23:27.121706 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 11 00:23:27.121728 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 11 00:23:27.121750 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 11 00:23:27.121784 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 11 00:23:27.121806 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 11 00:23:27.121827 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 11 00:23:27.121846 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 11 00:23:27.121870 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 11 00:23:27.121889 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 11 00:23:27.121914 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 11 00:23:27.121936 systemd[1]: Reached target slices.target - Slice Units. Sep 11 00:23:27.121961 systemd[1]: Reached target swap.target - Swaps. Sep 11 00:23:27.121983 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 11 00:23:27.122008 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 11 00:23:27.122026 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 11 00:23:27.122066 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 11 00:23:27.122094 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 11 00:23:27.122115 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 11 00:23:27.122140 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 11 00:23:27.122162 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 11 00:23:27.122187 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 11 00:23:27.122209 systemd[1]: Mounting media.mount - External Media Directory... Sep 11 00:23:27.122235 systemd[1]: Mounting proc-xen.mount - /proc/xen... Sep 11 00:23:27.122253 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 11 00:23:27.122282 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 11 00:23:27.122300 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 11 00:23:27.122326 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Sep 11 00:23:27.122345 systemd[1]: Reached target machines.target - Containers. Sep 11 00:23:27.122368 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 11 00:23:27.122391 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 11 00:23:27.122414 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 11 00:23:27.122435 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 11 00:23:27.122453 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 11 00:23:27.122477 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 11 00:23:27.122495 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 11 00:23:27.122520 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 11 00:23:27.122538 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 11 00:23:27.122563 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 11 00:23:27.122585 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 11 00:23:27.122610 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 11 00:23:27.122628 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 11 00:23:27.122653 systemd[1]: Stopped systemd-fsck-usr.service. Sep 11 00:23:27.122676 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 11 00:23:27.122697 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 11 00:23:27.122724 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 11 00:23:27.122762 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 11 00:23:27.122792 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 11 00:23:27.122821 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 11 00:23:27.122849 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 11 00:23:27.122869 systemd[1]: verity-setup.service: Deactivated successfully. Sep 11 00:23:27.122891 systemd[1]: Stopped verity-setup.service. Sep 11 00:23:27.122913 kernel: loop: module loaded Sep 11 00:23:27.122941 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 11 00:23:27.122962 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 11 00:23:27.122981 systemd[1]: Mounted media.mount - External Media Directory. Sep 11 00:23:27.123005 systemd[1]: Mounted proc-xen.mount - /proc/xen. Sep 11 00:23:27.123024 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 11 00:23:27.123066 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 11 00:23:27.123093 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 11 00:23:27.123144 systemd-journald[1271]: Collecting audit messages is disabled. Sep 11 00:23:27.123192 systemd-journald[1271]: Journal started Sep 11 00:23:27.123236 systemd-journald[1271]: Runtime Journal (/run/log/journal/ec296c666baa842597ee4772637f4784) is 8M, max 642.1M, 634.1M free. Sep 11 00:23:26.351760 systemd[1]: Queued start job for default target multi-user.target. Sep 11 00:23:26.364877 systemd[1]: Unnecessary job was removed for dev-xvda6.device - /dev/xvda6. Sep 11 00:23:26.365343 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 11 00:23:27.136064 systemd[1]: Started systemd-journald.service - Journal Service. Sep 11 00:23:27.141852 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 11 00:23:27.146060 kernel: fuse: init (API version 7.41) Sep 11 00:23:27.150093 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 11 00:23:27.156325 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 11 00:23:27.156543 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 11 00:23:27.162488 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 11 00:23:27.162700 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 11 00:23:27.168425 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 11 00:23:27.168643 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 11 00:23:27.174628 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 11 00:23:27.174847 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 11 00:23:27.180177 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 11 00:23:27.180393 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 11 00:23:27.185767 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 11 00:23:27.191287 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 11 00:23:27.197447 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 11 00:23:27.203405 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 11 00:23:27.218480 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 11 00:23:27.225114 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 11 00:23:27.271460 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 11 00:23:27.276339 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 11 00:23:27.276403 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 11 00:23:27.282018 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 11 00:23:27.288861 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 11 00:23:27.293564 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 11 00:23:27.294804 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 11 00:23:27.300743 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 11 00:23:27.306012 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 11 00:23:27.307137 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 11 00:23:27.312004 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 11 00:23:27.313184 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 11 00:23:27.319014 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 11 00:23:27.325944 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 11 00:23:27.331736 systemd[1]: Starting xenserver-pv-version.service - Set fake PV driver version for XenServer... Sep 11 00:23:27.334072 kernel: ACPI: bus type drm_connector registered Sep 11 00:23:27.342356 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 11 00:23:27.342582 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 11 00:23:27.347566 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 11 00:23:27.353408 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 11 00:23:27.358875 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 11 00:23:27.364821 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 11 00:23:27.370393 systemd[1]: Finished xenserver-pv-version.service - Set fake PV driver version for XenServer. Sep 11 00:23:27.379378 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 11 00:23:27.385617 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 11 00:23:27.427005 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 11 00:23:27.427684 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 11 00:23:27.450133 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 11 00:23:27.453900 systemd-journald[1271]: Time spent on flushing to /var/log/journal/ec296c666baa842597ee4772637f4784 is 18.835ms for 1009 entries. Sep 11 00:23:27.453900 systemd-journald[1271]: System Journal (/var/log/journal/ec296c666baa842597ee4772637f4784) is 8M, max 195.6M, 187.6M free. Sep 11 00:23:27.495871 kernel: loop0: detected capacity change from 0 to 72352 Sep 11 00:23:27.495917 systemd-journald[1271]: Received client request to flush runtime journal. Sep 11 00:23:27.497295 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 11 00:23:27.503241 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 11 00:23:27.509859 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 11 00:23:27.548552 systemd-tmpfiles[1348]: ACLs are not supported, ignoring. Sep 11 00:23:27.548578 systemd-tmpfiles[1348]: ACLs are not supported, ignoring. Sep 11 00:23:27.553541 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 11 00:23:28.386616 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 11 00:23:28.393802 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 11 00:23:28.405070 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 11 00:23:28.437215 systemd-udevd[1354]: Using default interface naming scheme 'v255'. Sep 11 00:23:28.547068 kernel: loop1: detected capacity change from 0 to 113872 Sep 11 00:23:28.832394 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 11 00:23:28.844321 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 11 00:23:28.906336 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 11 00:23:28.908478 (udev-worker)[1396]: Network interface NamePolicy= disabled on kernel command line. Sep 11 00:23:28.927079 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 Sep 11 00:23:28.944356 kernel: ACPI: button: Power Button [PWRF] Sep 11 00:23:28.944422 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input5 Sep 11 00:23:28.947167 kernel: ACPI: button: Sleep Button [SLPF] Sep 11 00:23:28.958698 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 11 00:23:28.965857 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 11 00:23:29.032307 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 11 00:23:29.035090 kernel: mousedev: PS/2 mouse device common for all mice Sep 11 00:23:29.054069 kernel: piix4_smbus 0000:00:01.3: SMBus base address uninitialized - upgrade BIOS or use force_addr=0xaddr Sep 11 00:23:29.060548 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 11 00:23:29.077290 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 11 00:23:29.115063 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 11 00:23:29.118135 kernel: EDAC MC: Ver: 3.0.0 Sep 11 00:23:29.301324 systemd-networkd[1377]: lo: Link UP Sep 11 00:23:29.301338 systemd-networkd[1377]: lo: Gained carrier Sep 11 00:23:29.302898 systemd-networkd[1377]: Enumeration completed Sep 11 00:23:29.303010 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 11 00:23:29.303444 systemd-networkd[1377]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 11 00:23:29.303457 systemd-networkd[1377]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 11 00:23:29.304683 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 11 00:23:29.306017 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 11 00:23:29.317588 systemd-networkd[1377]: eth0: Link UP Sep 11 00:23:29.322072 kernel: ixgbevf 0000:00:03.0: NIC Link is Up 10 Gbps Sep 11 00:23:29.323619 systemd-networkd[1377]: eth0: Gained carrier Sep 11 00:23:29.323654 systemd-networkd[1377]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 11 00:23:29.361091 systemd-networkd[1377]: eth0: DHCPv4 address 172.31.30.249/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 11 00:23:29.362763 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 11 00:23:29.617073 kernel: loop2: detected capacity change from 0 to 146240 Sep 11 00:23:29.982181 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 11 00:23:30.454202 systemd-networkd[1377]: eth0: Gained IPv6LL Sep 11 00:23:30.459622 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 11 00:23:30.667075 kernel: loop3: detected capacity change from 0 to 72352 Sep 11 00:23:30.694069 kernel: loop4: detected capacity change from 0 to 113872 Sep 11 00:23:30.723071 kernel: loop5: detected capacity change from 0 to 146240 Sep 11 00:23:30.753911 (sd-merge)[1443]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Sep 11 00:23:30.754440 (sd-merge)[1443]: Merged extensions into '/usr'. Sep 11 00:23:30.757957 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 11 00:23:30.765225 systemd[1]: Starting ensure-sysext.service... Sep 11 00:23:30.780553 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 11 00:23:30.788889 systemd[1]: Reload requested from client PID 1445 ('systemctl') (unit ensure-sysext.service)... Sep 11 00:23:30.788910 systemd[1]: Reloading... Sep 11 00:23:30.839083 zram_generator::config[1477]: No configuration found. Sep 11 00:23:30.924041 systemd-tmpfiles[1446]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 11 00:23:30.924132 systemd-tmpfiles[1446]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 11 00:23:30.924626 systemd-tmpfiles[1446]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 11 00:23:30.925000 systemd-tmpfiles[1446]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 11 00:23:30.926070 systemd-tmpfiles[1446]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 11 00:23:30.926454 systemd-tmpfiles[1446]: ACLs are not supported, ignoring. Sep 11 00:23:30.926582 systemd-tmpfiles[1446]: ACLs are not supported, ignoring. Sep 11 00:23:30.933232 systemd-tmpfiles[1446]: Detected autofs mount point /boot during canonicalization of boot. Sep 11 00:23:30.933255 systemd-tmpfiles[1446]: Skipping /boot Sep 11 00:23:30.945717 systemd-tmpfiles[1446]: Detected autofs mount point /boot during canonicalization of boot. Sep 11 00:23:30.945742 systemd-tmpfiles[1446]: Skipping /boot Sep 11 00:23:31.129970 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Sep 11 00:23:31.212330 systemd[1]: Reloading finished in 422 ms. Sep 11 00:23:31.265079 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 11 00:23:31.281550 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 11 00:23:31.287637 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 11 00:23:31.293356 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 11 00:23:31.308146 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 11 00:23:31.313992 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 11 00:23:31.320583 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 11 00:23:31.325518 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 11 00:23:31.325668 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 11 00:23:31.327327 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 11 00:23:31.334957 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 11 00:23:31.340800 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 11 00:23:31.350595 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 11 00:23:31.350915 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 11 00:23:31.356746 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 11 00:23:31.368213 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 11 00:23:31.374455 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 11 00:23:31.374655 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 11 00:23:31.380055 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 11 00:23:31.393525 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 11 00:23:31.398510 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 11 00:23:31.404236 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 11 00:23:31.411233 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 11 00:23:31.415714 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 11 00:23:31.415918 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 11 00:23:31.421130 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 11 00:23:31.427701 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 11 00:23:31.428009 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 11 00:23:31.434148 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 11 00:23:31.434453 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 11 00:23:31.440805 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 11 00:23:31.441113 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 11 00:23:31.454472 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 11 00:23:31.456218 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 11 00:23:31.457469 augenrules[1566]: No rules Sep 11 00:23:31.492560 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 11 00:23:31.498292 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 11 00:23:31.505370 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 11 00:23:31.509978 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 11 00:23:31.510156 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 11 00:23:31.510367 systemd[1]: Reached target time-set.target - System Time Set. Sep 11 00:23:31.516850 systemd[1]: audit-rules.service: Deactivated successfully. Sep 11 00:23:31.517125 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 11 00:23:31.522125 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 11 00:23:31.527987 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 11 00:23:31.528213 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 11 00:23:31.533808 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 11 00:23:31.534005 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 11 00:23:31.539332 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 11 00:23:31.539526 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 11 00:23:31.545657 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 11 00:23:31.545857 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 11 00:23:31.554156 systemd[1]: Finished ensure-sysext.service. Sep 11 00:23:31.562013 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 11 00:23:31.562096 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 11 00:23:31.562125 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Sep 11 00:23:31.606846 systemd-resolved[1538]: Positive Trust Anchors: Sep 11 00:23:31.606867 systemd-resolved[1538]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 11 00:23:31.606902 systemd-resolved[1538]: 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 Sep 11 00:23:31.612775 systemd-resolved[1538]: Defaulting to hostname 'linux'. Sep 11 00:23:31.614776 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 11 00:23:31.620209 systemd[1]: Reached target network.target - Network. Sep 11 00:23:31.624622 systemd[1]: Reached target network-online.target - Network is Online. Sep 11 00:23:31.629435 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 11 00:23:35.882551 ldconfig[1322]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 11 00:23:35.890205 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 11 00:23:35.897416 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 11 00:23:35.931665 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 11 00:23:35.936747 systemd[1]: Reached target sysinit.target - System Initialization. Sep 11 00:23:35.941605 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 11 00:23:35.947193 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 11 00:23:35.952839 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Sep 11 00:23:35.958163 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 11 00:23:35.963020 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 11 00:23:35.968724 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 11 00:23:35.974392 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 11 00:23:35.974430 systemd[1]: Reached target paths.target - Path Units. Sep 11 00:23:35.978503 systemd[1]: Reached target timers.target - Timer Units. Sep 11 00:23:35.983356 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 11 00:23:35.989510 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 11 00:23:35.996498 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 11 00:23:36.002611 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 11 00:23:36.008281 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 11 00:23:36.014874 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 11 00:23:36.019778 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 11 00:23:36.025712 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 11 00:23:36.031157 systemd[1]: Reached target sockets.target - Socket Units. Sep 11 00:23:36.035470 systemd[1]: Reached target basic.target - Basic System. Sep 11 00:23:36.039653 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 11 00:23:36.039697 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 11 00:23:36.040714 systemd[1]: Starting containerd.service - containerd container runtime... Sep 11 00:23:36.068734 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Sep 11 00:23:36.074323 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 11 00:23:36.079403 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 11 00:23:36.085556 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 11 00:23:36.091078 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 11 00:23:36.095587 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Sep 11 00:23:36.096758 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Sep 11 00:23:36.098325 jq[1590]: false Sep 11 00:23:36.102424 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 11 00:23:36.108628 systemd[1]: Started ntpd.service - Network Time Service. Sep 11 00:23:36.113575 extend-filesystems[1591]: Found /dev/xvda6 Sep 11 00:23:36.114470 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 11 00:23:36.122959 systemd[1]: Starting setup-oem.service - Setup OEM... Sep 11 00:23:36.128314 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 11 00:23:36.135022 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 11 00:23:36.142712 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 11 00:23:36.148466 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 11 00:23:36.149197 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 11 00:23:36.150070 systemd[1]: Starting update-engine.service - Update Engine... Sep 11 00:23:36.155701 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 11 00:23:36.163197 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 11 00:23:36.169156 jq[1620]: true Sep 11 00:23:36.169347 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 11 00:23:36.169577 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 11 00:23:36.169930 systemd[1]: motdgen.service: Deactivated successfully. Sep 11 00:23:36.170174 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 11 00:23:36.175391 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 11 00:23:36.181381 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 11 00:23:36.181733 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 11 00:23:36.193586 (ntainerd)[1624]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 11 00:23:36.195985 jq[1623]: true Sep 11 00:23:36.204408 systemd[1]: Finished setup-oem.service - Setup OEM. Sep 11 00:23:36.210127 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Sep 11 00:23:36.216211 extend-filesystems[1591]: Found /dev/xvda9 Sep 11 00:23:36.219864 extend-filesystems[1591]: Checking size of /dev/xvda9 Sep 11 00:23:36.230510 extend-filesystems[1591]: Resized partition /dev/xvda9 Sep 11 00:23:36.267312 update_engine[1616]: I20250911 00:23:36.267225 1616 main.cc:92] Flatcar Update Engine starting Sep 11 00:23:36.326443 systemd-logind[1611]: Watching system buttons on /dev/input/event2 (Power Button) Sep 11 00:23:36.326478 systemd-logind[1611]: Watching system buttons on /dev/input/event3 (Sleep Button) Sep 11 00:23:36.326499 systemd-logind[1611]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Sep 11 00:23:36.326847 systemd-logind[1611]: New seat seat0. Sep 11 00:23:36.328609 systemd[1]: Started systemd-logind.service - User Login Management. Sep 11 00:23:36.334082 extend-filesystems[1672]: resize2fs 1.47.2 (1-Jan-2025) Sep 11 00:23:36.338991 google_oslogin_nss_cache[1592]: oslogin_cache_refresh[1592]: Refreshing passwd entry cache Sep 11 00:23:36.338843 oslogin_cache_refresh[1592]: Refreshing passwd entry cache Sep 11 00:23:36.344422 dbus-daemon[1588]: [system] SELinux support is enabled Sep 11 00:23:36.344902 bash[1658]: Updated "/home/core/.ssh/authorized_keys" Sep 11 00:23:36.345423 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 11 00:23:36.347082 dbus-daemon[1588]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1377 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Sep 11 00:23:36.348019 google_oslogin_nss_cache[1592]: oslogin_cache_refresh[1592]: Failure getting users, quitting Sep 11 00:23:36.348007 oslogin_cache_refresh[1592]: Failure getting users, quitting Sep 11 00:23:36.348185 google_oslogin_nss_cache[1592]: oslogin_cache_refresh[1592]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 11 00:23:36.348185 google_oslogin_nss_cache[1592]: oslogin_cache_refresh[1592]: Refreshing group entry cache Sep 11 00:23:36.348030 oslogin_cache_refresh[1592]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 11 00:23:36.348125 oslogin_cache_refresh[1592]: Refreshing group entry cache Sep 11 00:23:36.348898 update_engine[1616]: I20250911 00:23:36.348837 1616 update_check_scheduler.cc:74] Next update check in 7m30s Sep 11 00:23:36.350607 google_oslogin_nss_cache[1592]: oslogin_cache_refresh[1592]: Failure getting groups, quitting Sep 11 00:23:36.350607 google_oslogin_nss_cache[1592]: oslogin_cache_refresh[1592]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 11 00:23:36.350595 oslogin_cache_refresh[1592]: Failure getting groups, quitting Sep 11 00:23:36.350610 oslogin_cache_refresh[1592]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 11 00:23:36.355092 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Sep 11 00:23:36.355371 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Sep 11 00:23:36.358515 ntpd[1597]: ntpd 4.2.8p17@1.4004-o Wed Sep 10 21:39:40 UTC 2025 (1): Starting Sep 11 00:23:36.359455 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: ntpd 4.2.8p17@1.4004-o Wed Sep 10 21:39:40 UTC 2025 (1): Starting Sep 11 00:23:36.359455 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 11 00:23:36.359455 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: ---------------------------------------------------- Sep 11 00:23:36.359455 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: ntp-4 is maintained by Network Time Foundation, Sep 11 00:23:36.359455 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 11 00:23:36.359455 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: corporation. Support and training for ntp-4 are Sep 11 00:23:36.359455 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: available at https://www.nwtime.org/support Sep 11 00:23:36.359455 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: ---------------------------------------------------- Sep 11 00:23:36.358555 ntpd[1597]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 11 00:23:36.358567 ntpd[1597]: ---------------------------------------------------- Sep 11 00:23:36.358578 ntpd[1597]: ntp-4 is maintained by Network Time Foundation, Sep 11 00:23:36.358589 ntpd[1597]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 11 00:23:36.358599 ntpd[1597]: corporation. Support and training for ntp-4 are Sep 11 00:23:36.358610 ntpd[1597]: available at https://www.nwtime.org/support Sep 11 00:23:36.358620 ntpd[1597]: ---------------------------------------------------- Sep 11 00:23:36.361392 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 11 00:23:36.362731 ntpd[1597]: proto: precision = 0.720 usec (-20) Sep 11 00:23:36.363064 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: proto: precision = 0.720 usec (-20) Sep 11 00:23:36.364329 ntpd[1597]: basedate set to 2025-08-29 Sep 11 00:23:36.365147 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: basedate set to 2025-08-29 Sep 11 00:23:36.365147 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: gps base set to 2025-08-31 (week 2382) Sep 11 00:23:36.364356 ntpd[1597]: gps base set to 2025-08-31 (week 2382) Sep 11 00:23:36.366865 ntpd[1597]: Listen and drop on 0 v6wildcard [::]:123 Sep 11 00:23:36.366991 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: Listen and drop on 0 v6wildcard [::]:123 Sep 11 00:23:36.366991 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 11 00:23:36.367153 kernel: EXT4-fs (xvda9): resizing filesystem from 553472 to 1489915 blocks Sep 11 00:23:36.366934 ntpd[1597]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 11 00:23:36.367284 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: Listen normally on 2 lo 127.0.0.1:123 Sep 11 00:23:36.367284 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: Listen normally on 3 eth0 172.31.30.249:123 Sep 11 00:23:36.367181 ntpd[1597]: Listen normally on 2 lo 127.0.0.1:123 Sep 11 00:23:36.367509 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: Listen normally on 4 lo [::1]:123 Sep 11 00:23:36.367509 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: Listen normally on 5 eth0 [fe80::461:e6ff:fe21:2f07%2]:123 Sep 11 00:23:36.367509 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: Listening on routing socket on fd #22 for interface updates Sep 11 00:23:36.367238 ntpd[1597]: Listen normally on 3 eth0 172.31.30.249:123 Sep 11 00:23:36.367293 ntpd[1597]: Listen normally on 4 lo [::1]:123 Sep 11 00:23:36.367357 ntpd[1597]: Listen normally on 5 eth0 [fe80::461:e6ff:fe21:2f07%2]:123 Sep 11 00:23:36.367408 ntpd[1597]: Listening on routing socket on fd #22 for interface updates Sep 11 00:23:36.368764 ntpd[1597]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 11 00:23:36.368809 ntpd[1597]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 11 00:23:36.368941 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 11 00:23:36.368941 ntpd[1597]: 11 Sep 00:23:36 ntpd[1597]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 11 00:23:36.376549 dbus-daemon[1588]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 11 00:23:36.379982 systemd[1]: Started update-engine.service - Update Engine. Sep 11 00:23:36.389177 systemd[1]: Starting sshkeys.service... Sep 11 00:23:36.392443 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Sep 11 00:23:36.392715 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 11 00:23:36.496424 amazon-ssm-agent[1648]: Initializing new seelog logger Sep 11 00:23:36.496879 amazon-ssm-agent[1648]: New Seelog Logger Creation Complete Sep 11 00:23:36.496879 amazon-ssm-agent[1648]: 2025/09/11 00:23:36 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 00:23:36.496879 amazon-ssm-agent[1648]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 00:23:36.497237 amazon-ssm-agent[1648]: 2025/09/11 00:23:36 processing appconfig overrides Sep 11 00:23:36.497644 amazon-ssm-agent[1648]: 2025/09/11 00:23:36 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 00:23:36.497644 amazon-ssm-agent[1648]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 00:23:36.497786 amazon-ssm-agent[1648]: 2025/09/11 00:23:36 processing appconfig overrides Sep 11 00:23:36.497786 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.4975 INFO Proxy environment variables: Sep 11 00:23:36.498252 amazon-ssm-agent[1648]: 2025/09/11 00:23:36 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 00:23:36.498252 amazon-ssm-agent[1648]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 00:23:36.498380 amazon-ssm-agent[1648]: 2025/09/11 00:23:36 processing appconfig overrides Sep 11 00:23:36.503251 amazon-ssm-agent[1648]: 2025/09/11 00:23:36 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 00:23:36.503251 amazon-ssm-agent[1648]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 00:23:36.503335 amazon-ssm-agent[1648]: 2025/09/11 00:23:36 processing appconfig overrides Sep 11 00:23:36.519807 coreos-metadata[1587]: Sep 11 00:23:36.519 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 11 00:23:36.520877 coreos-metadata[1587]: Sep 11 00:23:36.520 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Sep 11 00:23:36.521728 coreos-metadata[1587]: Sep 11 00:23:36.521 INFO Fetch successful Sep 11 00:23:36.521728 coreos-metadata[1587]: Sep 11 00:23:36.521 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Sep 11 00:23:36.522554 coreos-metadata[1587]: Sep 11 00:23:36.522 INFO Fetch successful Sep 11 00:23:36.522554 coreos-metadata[1587]: Sep 11 00:23:36.522 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Sep 11 00:23:36.523384 coreos-metadata[1587]: Sep 11 00:23:36.523 INFO Fetch successful Sep 11 00:23:36.523384 coreos-metadata[1587]: Sep 11 00:23:36.523 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Sep 11 00:23:36.524187 coreos-metadata[1587]: Sep 11 00:23:36.524 INFO Fetch successful Sep 11 00:23:36.524187 coreos-metadata[1587]: Sep 11 00:23:36.524 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Sep 11 00:23:36.524957 coreos-metadata[1587]: Sep 11 00:23:36.524 INFO Fetch failed with 404: resource not found Sep 11 00:23:36.525018 coreos-metadata[1587]: Sep 11 00:23:36.524 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Sep 11 00:23:36.525886 coreos-metadata[1587]: Sep 11 00:23:36.525 INFO Fetch successful Sep 11 00:23:36.525935 coreos-metadata[1587]: Sep 11 00:23:36.525 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Sep 11 00:23:36.526727 coreos-metadata[1587]: Sep 11 00:23:36.526 INFO Fetch successful Sep 11 00:23:36.526793 coreos-metadata[1587]: Sep 11 00:23:36.526 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Sep 11 00:23:36.527561 coreos-metadata[1587]: Sep 11 00:23:36.527 INFO Fetch successful Sep 11 00:23:36.527615 coreos-metadata[1587]: Sep 11 00:23:36.527 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Sep 11 00:23:36.528409 coreos-metadata[1587]: Sep 11 00:23:36.528 INFO Fetch successful Sep 11 00:23:36.528461 coreos-metadata[1587]: Sep 11 00:23:36.528 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Sep 11 00:23:36.529067 kernel: EXT4-fs (xvda9): resized filesystem to 1489915 Sep 11 00:23:36.529773 coreos-metadata[1587]: Sep 11 00:23:36.529 INFO Fetch successful Sep 11 00:23:36.570791 extend-filesystems[1672]: Filesystem at /dev/xvda9 is mounted on /; on-line resizing required Sep 11 00:23:36.570791 extend-filesystems[1672]: old_desc_blocks = 1, new_desc_blocks = 1 Sep 11 00:23:36.570791 extend-filesystems[1672]: The filesystem on /dev/xvda9 is now 1489915 (4k) blocks long. Sep 11 00:23:36.586586 extend-filesystems[1591]: Resized filesystem in /dev/xvda9 Sep 11 00:23:36.598219 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.4975 INFO https_proxy: Sep 11 00:23:36.696547 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.4975 INFO http_proxy: Sep 11 00:23:36.700379 sshd_keygen[1619]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 11 00:23:36.755536 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Sep 11 00:23:36.760330 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Sep 11 00:23:36.760572 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 11 00:23:36.767503 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 11 00:23:36.778095 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 11 00:23:36.778476 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 11 00:23:36.784465 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 11 00:23:36.795064 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.4975 INFO no_proxy: Sep 11 00:23:36.799757 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Sep 11 00:23:36.811141 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Sep 11 00:23:36.818095 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Sep 11 00:23:36.824749 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 11 00:23:36.829090 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 11 00:23:36.836754 systemd[1]: issuegen.service: Deactivated successfully. Sep 11 00:23:36.837074 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 11 00:23:36.841930 amazon-ssm-agent[1648]: 2025/09/11 00:23:36 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 00:23:36.841930 amazon-ssm-agent[1648]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 00:23:36.841930 amazon-ssm-agent[1648]: 2025/09/11 00:23:36 processing appconfig overrides Sep 11 00:23:36.844538 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 11 00:23:36.850581 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Sep 11 00:23:36.850891 dbus-daemon[1588]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 11 00:23:36.851772 dbus-daemon[1588]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1706 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Sep 11 00:23:36.859823 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 11 00:23:36.867019 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 11 00:23:36.869349 coreos-metadata[1715]: Sep 11 00:23:36.869 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 11 00:23:36.870495 coreos-metadata[1715]: Sep 11 00:23:36.870 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Sep 11 00:23:36.871368 coreos-metadata[1715]: Sep 11 00:23:36.871 INFO Fetch successful Sep 11 00:23:36.871368 coreos-metadata[1715]: Sep 11 00:23:36.871 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Sep 11 00:23:36.872196 coreos-metadata[1715]: Sep 11 00:23:36.872 INFO Fetch successful Sep 11 00:23:36.872975 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.4977 INFO Checking if agent identity type OnPrem can be assumed Sep 11 00:23:36.872975 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.4981 INFO Checking if agent identity type EC2 can be assumed Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.5365 INFO Agent will take identity from EC2 Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.5669 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.3.0.0 Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.5669 INFO [amazon-ssm-agent] OS: linux, Arch: amd64 Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.5669 INFO [amazon-ssm-agent] Starting Core Agent Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.5669 INFO [amazon-ssm-agent] Registrar detected. Attempting registration Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.5670 INFO [Registrar] Starting registrar module Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.5690 INFO [EC2Identity] Checking disk for registration info Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.5691 INFO [EC2Identity] No registration info found for ec2 instance, attempting registration Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.5691 INFO [EC2Identity] Generating registration keypair Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.7904 INFO [EC2Identity] Checking write access before registering Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.7910 INFO [EC2Identity] Registering EC2 instance with Systems Manager Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.8391 INFO [EC2Identity] EC2 registration was successful. Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.8391 INFO [amazon-ssm-agent] Registration attempted. Resuming core agent startup. Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.8392 INFO [CredentialRefresher] credentialRefresher has started Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.8393 INFO [CredentialRefresher] Starting credentials refresher loop Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.8727 INFO EC2RoleProvider Successfully connected with instance profile role credentials Sep 11 00:23:36.873131 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.8729 INFO [CredentialRefresher] Credentials ready Sep 11 00:23:36.873701 systemd[1]: Starting polkit.service - Authorization Manager... Sep 11 00:23:36.877957 unknown[1715]: wrote ssh authorized keys file for user: core Sep 11 00:23:36.879146 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 11 00:23:36.884761 systemd[1]: Reached target getty.target - Login Prompts. Sep 11 00:23:36.892897 amazon-ssm-agent[1648]: 2025-09-11 00:23:36.8731 INFO [CredentialRefresher] Next credential rotation will be in 29.999993065033333 minutes Sep 11 00:23:36.914063 update-ssh-keys[1728]: Updated "/home/core/.ssh/authorized_keys" Sep 11 00:23:36.914828 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Sep 11 00:23:36.923286 systemd[1]: Finished sshkeys.service. Sep 11 00:23:36.977830 polkitd[1726]: Started polkitd version 126 Sep 11 00:23:36.998160 polkitd[1726]: Loading rules from directory /etc/polkit-1/rules.d Sep 11 00:23:36.998532 polkitd[1726]: Loading rules from directory /run/polkit-1/rules.d Sep 11 00:23:36.998589 polkitd[1726]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Sep 11 00:23:36.998897 polkitd[1726]: Loading rules from directory /usr/local/share/polkit-1/rules.d Sep 11 00:23:36.998935 polkitd[1726]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Sep 11 00:23:36.998978 polkitd[1726]: Loading rules from directory /usr/share/polkit-1/rules.d Sep 11 00:23:36.999567 polkitd[1726]: Finished loading, compiling and executing 2 rules Sep 11 00:23:36.999855 systemd[1]: Started polkit.service - Authorization Manager. Sep 11 00:23:37.000184 dbus-daemon[1588]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 11 00:23:37.000464 polkitd[1726]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Sep 11 00:23:37.051018 systemd-hostnamed[1706]: Hostname set to (transient) Sep 11 00:23:37.051040 systemd-resolved[1538]: System hostname changed to 'ip-172-31-30-249'. Sep 11 00:23:37.092751 locksmithd[1707]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 11 00:23:37.888370 amazon-ssm-agent[1648]: 2025-09-11 00:23:37.8882 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Sep 11 00:23:37.944905 containerd[1624]: time="2025-09-11T00:23:37Z" 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 Sep 11 00:23:37.945652 containerd[1624]: time="2025-09-11T00:23:37.945607106Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Sep 11 00:23:37.955479 containerd[1624]: time="2025-09-11T00:23:37.955432650Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.508µs" Sep 11 00:23:37.955479 containerd[1624]: time="2025-09-11T00:23:37.955469547Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 11 00:23:37.955586 containerd[1624]: time="2025-09-11T00:23:37.955490116Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 11 00:23:37.955675 containerd[1624]: time="2025-09-11T00:23:37.955640673Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 11 00:23:37.955675 containerd[1624]: time="2025-09-11T00:23:37.955670844Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 11 00:23:37.955740 containerd[1624]: time="2025-09-11T00:23:37.955698928Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 11 00:23:37.955796 containerd[1624]: time="2025-09-11T00:23:37.955765092Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 11 00:23:37.955796 containerd[1624]: time="2025-09-11T00:23:37.955790682Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 11 00:23:37.956023 containerd[1624]: time="2025-09-11T00:23:37.955989452Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 11 00:23:37.956023 containerd[1624]: time="2025-09-11T00:23:37.956017673Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 11 00:23:37.956122 containerd[1624]: time="2025-09-11T00:23:37.956059963Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 11 00:23:37.956122 containerd[1624]: time="2025-09-11T00:23:37.956077763Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 11 00:23:37.956192 containerd[1624]: time="2025-09-11T00:23:37.956165319Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 11 00:23:37.956420 containerd[1624]: time="2025-09-11T00:23:37.956386765Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 11 00:23:37.956456 containerd[1624]: time="2025-09-11T00:23:37.956430298Z" 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 Sep 11 00:23:37.956456 containerd[1624]: time="2025-09-11T00:23:37.956443677Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 11 00:23:37.956518 containerd[1624]: time="2025-09-11T00:23:37.956488780Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 11 00:23:37.956781 containerd[1624]: time="2025-09-11T00:23:37.956744882Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 11 00:23:37.956866 containerd[1624]: time="2025-09-11T00:23:37.956835750Z" level=info msg="metadata content store policy set" policy=shared Sep 11 00:23:37.965296 containerd[1624]: time="2025-09-11T00:23:37.965259532Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 11 00:23:37.965345 containerd[1624]: time="2025-09-11T00:23:37.965314770Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 11 00:23:37.965345 containerd[1624]: time="2025-09-11T00:23:37.965332041Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 11 00:23:37.965414 containerd[1624]: time="2025-09-11T00:23:37.965345977Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 11 00:23:37.965414 containerd[1624]: time="2025-09-11T00:23:37.965360117Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 11 00:23:37.965414 containerd[1624]: time="2025-09-11T00:23:37.965371267Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 11 00:23:37.965414 containerd[1624]: time="2025-09-11T00:23:37.965386693Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 11 00:23:37.965414 containerd[1624]: time="2025-09-11T00:23:37.965399767Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 11 00:23:37.965540 containerd[1624]: time="2025-09-11T00:23:37.965419384Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 11 00:23:37.965540 containerd[1624]: time="2025-09-11T00:23:37.965441206Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 11 00:23:37.965540 containerd[1624]: time="2025-09-11T00:23:37.965459845Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 11 00:23:37.965540 containerd[1624]: time="2025-09-11T00:23:37.965476513Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 11 00:23:37.965645 containerd[1624]: time="2025-09-11T00:23:37.965579313Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 11 00:23:37.965645 containerd[1624]: time="2025-09-11T00:23:37.965602287Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 11 00:23:37.965645 containerd[1624]: time="2025-09-11T00:23:37.965621135Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 11 00:23:37.965645 containerd[1624]: time="2025-09-11T00:23:37.965633372Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 11 00:23:37.965747 containerd[1624]: time="2025-09-11T00:23:37.965646395Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 11 00:23:37.965747 containerd[1624]: time="2025-09-11T00:23:37.965658723Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 11 00:23:37.965747 containerd[1624]: time="2025-09-11T00:23:37.965670351Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 11 00:23:37.965747 containerd[1624]: time="2025-09-11T00:23:37.965687674Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 11 00:23:37.965747 containerd[1624]: time="2025-09-11T00:23:37.965701164Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 11 00:23:37.965747 containerd[1624]: time="2025-09-11T00:23:37.965711923Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 11 00:23:37.965747 containerd[1624]: time="2025-09-11T00:23:37.965724234Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 11 00:23:37.965936 containerd[1624]: time="2025-09-11T00:23:37.965776476Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 11 00:23:37.965936 containerd[1624]: time="2025-09-11T00:23:37.965794510Z" level=info msg="Start snapshots syncer" Sep 11 00:23:37.965936 containerd[1624]: time="2025-09-11T00:23:37.965826499Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 11 00:23:37.966134 containerd[1624]: time="2025-09-11T00:23:37.966030886Z" 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,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":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\"}" Sep 11 00:23:37.966271 containerd[1624]: time="2025-09-11T00:23:37.966135636Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 11 00:23:37.966271 containerd[1624]: time="2025-09-11T00:23:37.966218277Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 11 00:23:37.966333 containerd[1624]: time="2025-09-11T00:23:37.966318670Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 11 00:23:37.966363 containerd[1624]: time="2025-09-11T00:23:37.966342658Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 11 00:23:37.966363 containerd[1624]: time="2025-09-11T00:23:37.966354675Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 11 00:23:37.966430 containerd[1624]: time="2025-09-11T00:23:37.966369076Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 11 00:23:37.966430 containerd[1624]: time="2025-09-11T00:23:37.966399191Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 11 00:23:37.966430 containerd[1624]: time="2025-09-11T00:23:37.966413396Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 11 00:23:37.966430 containerd[1624]: time="2025-09-11T00:23:37.966425999Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 11 00:23:37.966544 containerd[1624]: time="2025-09-11T00:23:37.966449784Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 11 00:23:37.966544 containerd[1624]: time="2025-09-11T00:23:37.966463770Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 11 00:23:37.966544 containerd[1624]: time="2025-09-11T00:23:37.966474484Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 11 00:23:37.966544 containerd[1624]: time="2025-09-11T00:23:37.966513527Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 11 00:23:37.966544 containerd[1624]: time="2025-09-11T00:23:37.966532270Z" 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 Sep 11 00:23:37.966544 containerd[1624]: time="2025-09-11T00:23:37.966541517Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 11 00:23:37.966703 containerd[1624]: time="2025-09-11T00:23:37.966553375Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 11 00:23:37.966703 containerd[1624]: time="2025-09-11T00:23:37.966561624Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 11 00:23:37.966703 containerd[1624]: time="2025-09-11T00:23:37.966572479Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 11 00:23:37.966703 containerd[1624]: time="2025-09-11T00:23:37.966599954Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 11 00:23:37.966703 containerd[1624]: time="2025-09-11T00:23:37.966618191Z" level=info msg="runtime interface created" Sep 11 00:23:37.966703 containerd[1624]: time="2025-09-11T00:23:37.966626998Z" level=info msg="created NRI interface" Sep 11 00:23:37.966703 containerd[1624]: time="2025-09-11T00:23:37.966635416Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 11 00:23:37.966703 containerd[1624]: time="2025-09-11T00:23:37.966647178Z" level=info msg="Connect containerd service" Sep 11 00:23:37.966703 containerd[1624]: time="2025-09-11T00:23:37.966696821Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 11 00:23:37.967455 containerd[1624]: time="2025-09-11T00:23:37.967416154Z" 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" Sep 11 00:23:37.989717 amazon-ssm-agent[1648]: 2025-09-11 00:23:37.8901 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:1751) started Sep 11 00:23:38.090030 amazon-ssm-agent[1648]: 2025-09-11 00:23:37.8901 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Sep 11 00:23:39.628062 containerd[1624]: time="2025-09-11T00:23:39.627668570Z" level=info msg="Start subscribing containerd event" Sep 11 00:23:39.628749 containerd[1624]: time="2025-09-11T00:23:39.628072458Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 11 00:23:39.628749 containerd[1624]: time="2025-09-11T00:23:39.628165968Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 11 00:23:39.628749 containerd[1624]: time="2025-09-11T00:23:39.628343536Z" level=info msg="Start recovering state" Sep 11 00:23:39.628749 containerd[1624]: time="2025-09-11T00:23:39.628590392Z" level=info msg="Start event monitor" Sep 11 00:23:39.628749 containerd[1624]: time="2025-09-11T00:23:39.628672890Z" level=info msg="Start cni network conf syncer for default" Sep 11 00:23:39.628749 containerd[1624]: time="2025-09-11T00:23:39.628690229Z" level=info msg="Start streaming server" Sep 11 00:23:39.628749 containerd[1624]: time="2025-09-11T00:23:39.628700904Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 11 00:23:39.629515 containerd[1624]: time="2025-09-11T00:23:39.629468108Z" level=info msg="runtime interface starting up..." Sep 11 00:23:39.629515 containerd[1624]: time="2025-09-11T00:23:39.629512202Z" level=info msg="starting plugins..." Sep 11 00:23:39.629675 containerd[1624]: time="2025-09-11T00:23:39.629541289Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 11 00:23:39.629814 containerd[1624]: time="2025-09-11T00:23:39.629773916Z" level=info msg="containerd successfully booted in 1.685261s" Sep 11 00:23:39.629883 systemd[1]: Started containerd.service - containerd container runtime. Sep 11 00:23:39.635345 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 11 00:23:39.640290 systemd[1]: Startup finished in 3.288s (kernel) + 20.203s (initrd) + 17.740s (userspace) = 41.233s. Sep 11 00:23:40.387029 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 11 00:23:40.388590 systemd[1]: Started sshd@0-172.31.30.249:22-139.178.68.195:59464.service - OpenSSH per-connection server daemon (139.178.68.195:59464). Sep 11 00:23:41.266887 sshd[1792]: Accepted publickey for core from 139.178.68.195 port 59464 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:41.269995 sshd-session[1792]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:41.277115 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 11 00:23:41.278257 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 11 00:23:41.285358 systemd-logind[1611]: New session 1 of user core. Sep 11 00:23:41.305069 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 11 00:23:41.308483 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 11 00:23:41.340572 (systemd)[1796]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 11 00:23:41.343256 systemd-logind[1611]: New session c1 of user core. Sep 11 00:23:41.440655 systemd[1796]: Queued start job for default target default.target. Sep 11 00:23:41.451140 systemd[1796]: Created slice app.slice - User Application Slice. Sep 11 00:23:41.451181 systemd[1796]: Reached target paths.target - Paths. Sep 11 00:23:41.451240 systemd[1796]: Reached target timers.target - Timers. Sep 11 00:23:41.452478 systemd[1796]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 11 00:23:41.463019 systemd[1796]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 11 00:23:41.463248 systemd[1796]: Reached target sockets.target - Sockets. Sep 11 00:23:41.463317 systemd[1796]: Reached target basic.target - Basic System. Sep 11 00:23:41.463366 systemd[1796]: Reached target default.target - Main User Target. Sep 11 00:23:41.463401 systemd[1796]: Startup finished in 113ms. Sep 11 00:23:41.463431 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 11 00:23:41.465169 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 11 00:23:41.613725 systemd[1]: Started sshd@1-172.31.30.249:22-139.178.68.195:59466.service - OpenSSH per-connection server daemon (139.178.68.195:59466). Sep 11 00:23:41.785484 sshd[1807]: Accepted publickey for core from 139.178.68.195 port 59466 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:41.786694 sshd-session[1807]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:41.791328 systemd-logind[1611]: New session 2 of user core. Sep 11 00:23:41.798198 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 11 00:23:41.925477 sshd[1809]: Connection closed by 139.178.68.195 port 59466 Sep 11 00:23:41.925726 sshd-session[1807]: pam_unix(sshd:session): session closed for user core Sep 11 00:23:41.929249 systemd[1]: sshd@1-172.31.30.249:22-139.178.68.195:59466.service: Deactivated successfully. Sep 11 00:23:41.931024 systemd[1]: session-2.scope: Deactivated successfully. Sep 11 00:23:41.932084 systemd-logind[1611]: Session 2 logged out. Waiting for processes to exit. Sep 11 00:23:41.933380 systemd-logind[1611]: Removed session 2. Sep 11 00:23:41.962662 systemd[1]: Started sshd@2-172.31.30.249:22-139.178.68.195:59470.service - OpenSSH per-connection server daemon (139.178.68.195:59470). Sep 11 00:23:42.131313 sshd[1815]: Accepted publickey for core from 139.178.68.195 port 59470 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:42.132464 sshd-session[1815]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:42.136922 systemd-logind[1611]: New session 3 of user core. Sep 11 00:23:42.153175 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 11 00:23:42.267666 sshd[1817]: Connection closed by 139.178.68.195 port 59470 Sep 11 00:23:42.267930 sshd-session[1815]: pam_unix(sshd:session): session closed for user core Sep 11 00:23:42.271463 systemd[1]: sshd@2-172.31.30.249:22-139.178.68.195:59470.service: Deactivated successfully. Sep 11 00:23:42.273266 systemd[1]: session-3.scope: Deactivated successfully. Sep 11 00:23:42.274288 systemd-logind[1611]: Session 3 logged out. Waiting for processes to exit. Sep 11 00:23:42.275560 systemd-logind[1611]: Removed session 3. Sep 11 00:23:42.312634 systemd[1]: Started sshd@3-172.31.30.249:22-139.178.68.195:59476.service - OpenSSH per-connection server daemon (139.178.68.195:59476). Sep 11 00:23:42.476576 sshd[1823]: Accepted publickey for core from 139.178.68.195 port 59476 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:42.477738 sshd-session[1823]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:42.482344 systemd-logind[1611]: New session 4 of user core. Sep 11 00:23:42.494183 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 11 00:23:42.610905 sshd[1825]: Connection closed by 139.178.68.195 port 59476 Sep 11 00:23:42.611204 sshd-session[1823]: pam_unix(sshd:session): session closed for user core Sep 11 00:23:42.614615 systemd[1]: sshd@3-172.31.30.249:22-139.178.68.195:59476.service: Deactivated successfully. Sep 11 00:23:42.616251 systemd[1]: session-4.scope: Deactivated successfully. Sep 11 00:23:42.617001 systemd-logind[1611]: Session 4 logged out. Waiting for processes to exit. Sep 11 00:23:42.618180 systemd-logind[1611]: Removed session 4. Sep 11 00:23:42.658393 systemd[1]: Started sshd@4-172.31.30.249:22-139.178.68.195:59492.service - OpenSSH per-connection server daemon (139.178.68.195:59492). Sep 11 00:23:42.816028 sshd[1831]: Accepted publickey for core from 139.178.68.195 port 59492 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:42.817320 sshd-session[1831]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:42.821905 systemd-logind[1611]: New session 5 of user core. Sep 11 00:23:42.844197 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 11 00:23:43.227588 sudo[1834]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 11 00:23:43.227907 sudo[1834]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 11 00:23:43.251605 sudo[1834]: pam_unix(sudo:session): session closed for user root Sep 11 00:23:43.273196 sshd[1833]: Connection closed by 139.178.68.195 port 59492 Sep 11 00:23:43.273587 sshd-session[1831]: pam_unix(sshd:session): session closed for user core Sep 11 00:23:43.277487 systemd[1]: sshd@4-172.31.30.249:22-139.178.68.195:59492.service: Deactivated successfully. Sep 11 00:23:43.279150 systemd[1]: session-5.scope: Deactivated successfully. Sep 11 00:23:43.279896 systemd-logind[1611]: Session 5 logged out. Waiting for processes to exit. Sep 11 00:23:43.281213 systemd-logind[1611]: Removed session 5. Sep 11 00:23:43.320633 systemd[1]: Started sshd@5-172.31.30.249:22-139.178.68.195:59504.service - OpenSSH per-connection server daemon (139.178.68.195:59504). Sep 11 00:23:43.486723 sshd[1840]: Accepted publickey for core from 139.178.68.195 port 59504 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:43.488003 sshd-session[1840]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:43.492706 systemd-logind[1611]: New session 6 of user core. Sep 11 00:23:43.503181 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 11 00:23:43.601400 sudo[1844]: 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 Sep 11 00:23:43.601864 sudo[1844]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 11 00:23:43.607399 sudo[1844]: pam_unix(sudo:session): session closed for user root Sep 11 00:23:43.612903 sudo[1843]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 11 00:23:43.613236 sudo[1843]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 11 00:23:43.622888 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 11 00:23:43.663027 augenrules[1866]: No rules Sep 11 00:23:43.664257 systemd[1]: audit-rules.service: Deactivated successfully. Sep 11 00:23:43.664514 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 11 00:23:43.665570 sudo[1843]: pam_unix(sudo:session): session closed for user root Sep 11 00:23:43.688350 sshd[1842]: Connection closed by 139.178.68.195 port 59504 Sep 11 00:23:43.688669 sshd-session[1840]: pam_unix(sshd:session): session closed for user core Sep 11 00:23:43.692019 systemd[1]: sshd@5-172.31.30.249:22-139.178.68.195:59504.service: Deactivated successfully. Sep 11 00:23:43.693581 systemd[1]: session-6.scope: Deactivated successfully. Sep 11 00:23:43.694372 systemd-logind[1611]: Session 6 logged out. Waiting for processes to exit. Sep 11 00:23:43.695534 systemd-logind[1611]: Removed session 6. Sep 11 00:23:43.725348 systemd[1]: Started sshd@6-172.31.30.249:22-139.178.68.195:59506.service - OpenSSH per-connection server daemon (139.178.68.195:59506). Sep 11 00:23:43.887070 sshd[1875]: Accepted publickey for core from 139.178.68.195 port 59506 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:43.888331 sshd-session[1875]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:43.892704 systemd-logind[1611]: New session 7 of user core. Sep 11 00:23:43.915195 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 11 00:23:44.008667 sudo[1878]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mkdir -p . Sep 11 00:23:44.008965 sudo[1878]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 11 00:23:44.012263 sudo[1878]: pam_unix(sudo:session): session closed for user root Sep 11 00:23:44.034262 sshd[1877]: Connection closed by 139.178.68.195 port 59506 Sep 11 00:23:44.034537 sshd-session[1875]: pam_unix(sshd:session): session closed for user core Sep 11 00:23:44.037799 systemd[1]: sshd@6-172.31.30.249:22-139.178.68.195:59506.service: Deactivated successfully. Sep 11 00:23:44.039524 systemd[1]: session-7.scope: Deactivated successfully. Sep 11 00:23:44.040541 systemd-logind[1611]: Session 7 logged out. Waiting for processes to exit. Sep 11 00:23:44.041776 systemd-logind[1611]: Removed session 7. Sep 11 00:23:44.072492 systemd[1]: Started sshd@7-172.31.30.249:22-139.178.68.195:59508.service - OpenSSH per-connection server daemon (139.178.68.195:59508). Sep 11 00:23:44.236739 sshd[1885]: Accepted publickey for core from 139.178.68.195 port 59508 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:44.237868 sshd-session[1885]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:44.242399 systemd-logind[1611]: New session 8 of user core. Sep 11 00:23:44.260186 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 11 00:23:44.356436 sudo[1888]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/install -m 0755 /dev/stdin kolet Sep 11 00:23:44.356733 sudo[1888]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 11 00:23:45.089572 sudo[1888]: pam_unix(sudo:session): session closed for user root Sep 11 00:23:45.112116 sshd[1887]: Connection closed by 139.178.68.195 port 59508 Sep 11 00:23:45.112362 sshd-session[1885]: pam_unix(sshd:session): session closed for user core Sep 11 00:23:45.116076 systemd[1]: sshd@7-172.31.30.249:22-139.178.68.195:59508.service: Deactivated successfully. Sep 11 00:23:45.117693 systemd[1]: session-8.scope: Deactivated successfully. Sep 11 00:23:45.118471 systemd-logind[1611]: Session 8 logged out. Waiting for processes to exit. Sep 11 00:23:45.119835 systemd-logind[1611]: Removed session 8. Sep 11 00:23:45.148415 systemd[1]: Started sshd@8-172.31.30.249:22-139.178.68.195:59522.service - OpenSSH per-connection server daemon (139.178.68.195:59522). Sep 11 00:23:45.310776 sshd[1894]: Accepted publickey for core from 139.178.68.195 port 59522 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:45.311920 sshd-session[1894]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:45.316468 systemd-logind[1611]: New session 9 of user core. Sep 11 00:23:45.332180 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 11 00:23:45.602285 sshd[1896]: Connection closed by 139.178.68.195 port 59522 Sep 11 00:23:45.602720 sshd-session[1894]: pam_unix(sshd:session): session closed for user core Sep 11 00:23:45.606348 systemd[1]: sshd@8-172.31.30.249:22-139.178.68.195:59522.service: Deactivated successfully. Sep 11 00:23:45.607933 systemd[1]: session-9.scope: Deactivated successfully. Sep 11 00:23:45.608817 systemd-logind[1611]: Session 9 logged out. Waiting for processes to exit. Sep 11 00:23:45.610158 systemd-logind[1611]: Removed session 9. Sep 11 00:23:45.638316 systemd[1]: Started sshd@9-172.31.30.249:22-139.178.68.195:59538.service - OpenSSH per-connection server daemon (139.178.68.195:59538). Sep 11 00:23:45.803325 sshd[1913]: Accepted publickey for core from 139.178.68.195 port 59538 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:45.804457 sshd-session[1913]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:45.808930 systemd-logind[1611]: New session 10 of user core. Sep 11 00:23:45.829162 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 11 00:23:46.860980 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 11 00:23:46.874447 (dockerd)[1938]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 11 00:23:48.978485 dockerd[1938]: time="2025-09-11T00:23:48.978390960Z" level=info msg="Starting up" Sep 11 00:23:48.979323 dockerd[1938]: time="2025-09-11T00:23:48.979278831Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 11 00:23:49.144185 dockerd[1938]: time="2025-09-11T00:23:49.144118710Z" level=info msg="Loading containers: start." Sep 11 00:23:49.256066 kernel: Initializing XFRM netlink socket Sep 11 00:23:49.905620 (udev-worker)[1966]: Network interface NamePolicy= disabled on kernel command line. Sep 11 00:23:49.947741 systemd-networkd[1377]: docker0: Link UP Sep 11 00:23:49.957750 dockerd[1938]: time="2025-09-11T00:23:49.957699662Z" level=info msg="Loading containers: done." Sep 11 00:23:49.982616 dockerd[1938]: time="2025-09-11T00:23:49.982569685Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 11 00:23:49.982933 dockerd[1938]: time="2025-09-11T00:23:49.982641081Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Sep 11 00:23:49.982933 dockerd[1938]: time="2025-09-11T00:23:49.982739104Z" level=info msg="Initializing buildkit" Sep 11 00:23:50.016480 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2902171769-merged.mount: Deactivated successfully. Sep 11 00:23:50.020760 dockerd[1938]: time="2025-09-11T00:23:50.020722055Z" level=info msg="Completed buildkit initialization" Sep 11 00:23:50.027723 dockerd[1938]: time="2025-09-11T00:23:50.027677994Z" level=info msg="Daemon has completed initialization" Sep 11 00:23:50.027809 dockerd[1938]: time="2025-09-11T00:23:50.027772399Z" level=info msg="API listen on /run/docker.sock" Sep 11 00:23:50.027870 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 11 00:23:51.553228 systemd[1]: var-lib-docker-overlay2-861cc43259e3d60a64f0fa553b4805bd0d62cf0ab541604d669fd7df1af3a81e\x2dinit-merged.mount: Deactivated successfully. Sep 11 00:23:51.626693 containerd[1624]: time="2025-09-11T00:23:51.626634494Z" level=info msg="connecting to shim 47bec733f1fa2c72b0e0f63e46952bcd47c83cb130e8b55d8c64e67181206552" address="unix:///run/containerd/s/bc12b4590500452687463915dfe88352d55e0c43b6d3faf2fc887250ed3d61fc" namespace=moby protocol=ttrpc version=3 Sep 11 00:23:51.659204 systemd[1]: Started docker-47bec733f1fa2c72b0e0f63e46952bcd47c83cb130e8b55d8c64e67181206552.scope - libcontainer container 47bec733f1fa2c72b0e0f63e46952bcd47c83cb130e8b55d8c64e67181206552. Sep 11 00:23:51.812841 (udev-worker)[2083]: Network interface NamePolicy= disabled on kernel command line. Sep 11 00:23:51.818975 kernel: docker0: port 1(veth782b48e) entered blocking state Sep 11 00:23:51.819085 kernel: docker0: port 1(veth782b48e) entered disabled state Sep 11 00:23:51.819125 kernel: veth782b48e: entered allmulticast mode Sep 11 00:23:51.823776 kernel: veth782b48e: entered promiscuous mode Sep 11 00:23:51.824709 systemd-networkd[1377]: veth782b48e: Link UP Sep 11 00:23:51.840074 kernel: eth0: renamed from veth6d6e93e Sep 11 00:23:51.840151 kernel: docker0: port 1(veth782b48e) entered blocking state Sep 11 00:23:51.844506 kernel: docker0: port 1(veth782b48e) entered forwarding state Sep 11 00:23:51.844636 systemd-networkd[1377]: veth782b48e: Gained carrier Sep 11 00:23:51.845107 systemd-networkd[1377]: docker0: Gained carrier Sep 11 00:23:53.238202 systemd-networkd[1377]: docker0: Gained IPv6LL Sep 11 00:23:53.558204 systemd-networkd[1377]: veth782b48e: Gained IPv6LL Sep 11 00:23:54.918796 systemd[1]: docker-47bec733f1fa2c72b0e0f63e46952bcd47c83cb130e8b55d8c64e67181206552.scope: Deactivated successfully. Sep 11 00:23:54.933485 containerd[1624]: time="2025-09-11T00:23:54.933255992Z" level=info msg="shim disconnected" id=47bec733f1fa2c72b0e0f63e46952bcd47c83cb130e8b55d8c64e67181206552 namespace=moby Sep 11 00:23:54.933485 containerd[1624]: time="2025-09-11T00:23:54.933310665Z" level=warning msg="cleaning up after shim disconnected" id=47bec733f1fa2c72b0e0f63e46952bcd47c83cb130e8b55d8c64e67181206552 namespace=moby Sep 11 00:23:54.933485 containerd[1624]: time="2025-09-11T00:23:54.933329247Z" level=info msg="cleaning up dead shim" namespace=moby Sep 11 00:23:54.933857 dockerd[1938]: time="2025-09-11T00:23:54.933416552Z" level=info msg="ignoring event" container=47bec733f1fa2c72b0e0f63e46952bcd47c83cb130e8b55d8c64e67181206552 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 11 00:23:54.963077 kernel: docker0: port 1(veth782b48e) entered disabled state Sep 11 00:23:54.963150 kernel: veth6d6e93e: renamed from eth0 Sep 11 00:23:54.963134 systemd-networkd[1377]: veth782b48e: Lost carrier Sep 11 00:23:54.991692 systemd-networkd[1377]: veth782b48e: Link DOWN Sep 11 00:23:54.994111 kernel: docker0: port 1(veth782b48e) entered disabled state Sep 11 00:23:54.999507 kernel: veth782b48e (unregistering): left allmulticast mode Sep 11 00:23:54.999562 kernel: veth782b48e (unregistering): left promiscuous mode Sep 11 00:23:54.999591 kernel: docker0: port 1(veth782b48e) entered disabled state Sep 11 00:23:55.031481 systemd[1]: run-docker-netns-99082295e7dc.mount: Deactivated successfully. Sep 11 00:23:55.033523 systemd[1]: var-lib-docker-overlay2-861cc43259e3d60a64f0fa553b4805bd0d62cf0ab541604d669fd7df1af3a81e-merged.mount: Deactivated successfully. Sep 11 00:23:55.077931 sshd[1915]: Connection closed by 139.178.68.195 port 59538 Sep 11 00:23:55.078355 sshd-session[1913]: pam_unix(sshd:session): session closed for user core Sep 11 00:23:55.082158 systemd[1]: sshd@9-172.31.30.249:22-139.178.68.195:59538.service: Deactivated successfully. Sep 11 00:23:55.083789 systemd[1]: session-10.scope: Deactivated successfully. Sep 11 00:23:55.084648 systemd-logind[1611]: Session 10 logged out. Waiting for processes to exit. Sep 11 00:23:55.085900 systemd-logind[1611]: Removed session 10. Sep 11 00:23:55.125706 systemd[1]: Started sshd@10-172.31.30.249:22-139.178.68.195:46574.service - OpenSSH per-connection server daemon (139.178.68.195:46574). Sep 11 00:23:55.288317 sshd[2245]: Accepted publickey for core from 139.178.68.195 port 46574 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:55.289708 sshd-session[2245]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:55.294203 systemd-logind[1611]: New session 11 of user core. Sep 11 00:23:55.303185 systemd[1]: Started session-11.scope - Session 11 of User core. Sep 11 00:23:55.452193 systemd[1]: var-lib-docker-overlay2-fe492c586f56c4d1b494f76c49ef66cfc73a394c522a5591fbb6108dcb196150\x2dinit-merged.mount: Deactivated successfully. Sep 11 00:23:55.505773 containerd[1624]: time="2025-09-11T00:23:55.505716638Z" level=info msg="connecting to shim 5f893e61fa0883e05e3b073c946005b0bcc3a45c5d4f41665d630b91648a35ae" address="unix:///run/containerd/s/cbd9c2c80b331a4674f720f05cc44a23f254158f4fa82667819d5fac70cd847d" namespace=moby protocol=ttrpc version=3 Sep 11 00:23:55.540196 systemd[1]: Started docker-5f893e61fa0883e05e3b073c946005b0bcc3a45c5d4f41665d630b91648a35ae.scope - libcontainer container 5f893e61fa0883e05e3b073c946005b0bcc3a45c5d4f41665d630b91648a35ae. Sep 11 00:23:55.583310 systemd-networkd[1377]: docker0: Lost carrier Sep 11 00:23:55.583388 (udev-worker)[2240]: Network interface NamePolicy= disabled on kernel command line. Sep 11 00:23:55.587889 kernel: docker0: port 1(veth0c7cb9e) entered blocking state Sep 11 00:23:55.587962 kernel: docker0: port 1(veth0c7cb9e) entered disabled state Sep 11 00:23:55.588002 kernel: veth0c7cb9e: entered allmulticast mode Sep 11 00:23:55.591720 kernel: veth0c7cb9e: entered promiscuous mode Sep 11 00:23:55.592439 systemd-networkd[1377]: veth0c7cb9e: Link UP Sep 11 00:23:55.605070 kernel: eth0: renamed from vetheb16303 Sep 11 00:23:55.609524 kernel: docker0: port 1(veth0c7cb9e) entered blocking state Sep 11 00:23:55.609580 kernel: docker0: port 1(veth0c7cb9e) entered forwarding state Sep 11 00:23:55.609624 systemd-networkd[1377]: veth0c7cb9e: Gained carrier Sep 11 00:23:55.610068 systemd-networkd[1377]: docker0: Gained carrier Sep 11 00:23:55.636841 systemd[1]: docker-5f893e61fa0883e05e3b073c946005b0bcc3a45c5d4f41665d630b91648a35ae.scope: Deactivated successfully. Sep 11 00:23:55.655431 containerd[1624]: time="2025-09-11T00:23:55.655375512Z" level=info msg="shim disconnected" id=5f893e61fa0883e05e3b073c946005b0bcc3a45c5d4f41665d630b91648a35ae namespace=moby Sep 11 00:23:55.655431 containerd[1624]: time="2025-09-11T00:23:55.655424304Z" level=warning msg="cleaning up after shim disconnected" id=5f893e61fa0883e05e3b073c946005b0bcc3a45c5d4f41665d630b91648a35ae namespace=moby Sep 11 00:23:55.655598 containerd[1624]: time="2025-09-11T00:23:55.655442950Z" level=info msg="cleaning up dead shim" namespace=moby Sep 11 00:23:55.655674 dockerd[1938]: time="2025-09-11T00:23:55.655507225Z" level=info msg="ignoring event" container=5f893e61fa0883e05e3b073c946005b0bcc3a45c5d4f41665d630b91648a35ae module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 11 00:23:55.682788 systemd-networkd[1377]: veth0c7cb9e: Lost carrier Sep 11 00:23:55.683076 kernel: docker0: port 1(veth0c7cb9e) entered disabled state Sep 11 00:23:55.683125 kernel: vetheb16303: renamed from eth0 Sep 11 00:23:55.704885 (udev-worker)[2318]: Network interface NamePolicy= disabled on kernel command line. Sep 11 00:23:55.708614 systemd-networkd[1377]: veth0c7cb9e: Link DOWN Sep 11 00:23:55.711065 kernel: docker0: port 1(veth0c7cb9e) entered disabled state Sep 11 00:23:55.711117 kernel: veth0c7cb9e (unregistering): left allmulticast mode Sep 11 00:23:55.716753 kernel: veth0c7cb9e (unregistering): left promiscuous mode Sep 11 00:23:55.716810 kernel: docker0: port 1(veth0c7cb9e) entered disabled state Sep 11 00:23:55.777107 sshd[2247]: Connection closed by 139.178.68.195 port 46574 Sep 11 00:23:55.777446 sshd-session[2245]: pam_unix(sshd:session): session closed for user core Sep 11 00:23:55.781237 systemd[1]: sshd@10-172.31.30.249:22-139.178.68.195:46574.service: Deactivated successfully. Sep 11 00:23:55.782856 systemd[1]: session-11.scope: Deactivated successfully. Sep 11 00:23:55.783639 systemd-logind[1611]: Session 11 logged out. Waiting for processes to exit. Sep 11 00:23:55.784996 systemd-logind[1611]: Removed session 11. Sep 11 00:23:55.821341 systemd[1]: Started sshd@11-172.31.30.249:22-139.178.68.195:46580.service - OpenSSH per-connection server daemon (139.178.68.195:46580). Sep 11 00:23:55.966279 systemd-networkd[1377]: docker0: Lost carrier Sep 11 00:23:55.983971 sshd[2368]: Accepted publickey for core from 139.178.68.195 port 46580 ssh2: RSA SHA256:DI9pNl+z5BGYe6Iyj+qIVODBCZVkxcmsYxJW+bpE6Ww Sep 11 00:23:55.985213 sshd-session[2368]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 00:23:55.989632 systemd-logind[1611]: New session 12 of user core. Sep 11 00:23:55.999182 systemd[1]: Started session-12.scope - Session 12 of User core. Sep 11 00:23:56.124012 ntpdate[2381]: ntpdate 4.2.8p17@1.4004-o Wed Sep 10 21:39:41 UTC 2025 (1) Sep 11 00:24:02.902733 ntpdate[2381]: adjust time server 23.186.168.128 offset -0.081744 sec Sep 11 00:24:02.925743 sshd[2370]: Connection closed by 139.178.68.195 port 46580 Sep 11 00:24:02.926156 sshd-session[2368]: pam_unix(sshd:session): session closed for user core Sep 11 00:24:02.929257 systemd[1]: sshd@11-172.31.30.249:22-139.178.68.195:46580.service: Deactivated successfully. Sep 11 00:24:02.931016 systemd[1]: session-12.scope: Deactivated successfully. Sep 11 00:24:02.933016 systemd-logind[1611]: Session 12 logged out. Waiting for processes to exit. Sep 11 00:24:02.934146 systemd-logind[1611]: Removed session 12.