Apr 30 12:48:13.850593 kernel: Linux version 6.6.88-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.43 p3) 2.43.1) #1 SMP PREEMPT_DYNAMIC Tue Apr 29 22:26:36 -00 2025 Apr 30 12:48:13.850650 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=95dd3de5eb34971546a976dc51c66bc73cf59b888896e27767c0cbf245cb98fe Apr 30 12:48:13.850674 kernel: BIOS-provided physical RAM map: Apr 30 12:48:13.850704 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009dfff] usable Apr 30 12:48:13.850718 kernel: BIOS-e820: [mem 0x000000000009e000-0x000000000009ffff] reserved Apr 30 12:48:13.850737 kernel: BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved Apr 30 12:48:13.850759 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000efffffff] usable Apr 30 12:48:13.850775 kernel: BIOS-e820: [mem 0x00000000fc000000-0x00000000ffffffff] reserved Apr 30 12:48:13.850790 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000080fffffff] usable Apr 30 12:48:13.850806 kernel: NX (Execute Disable) protection: active Apr 30 12:48:13.850821 kernel: APIC: Static calls initialized Apr 30 12:48:13.850837 kernel: SMBIOS 2.7 present. Apr 30 12:48:13.850852 kernel: DMI: Xen HVM domU, BIOS 4.11.amazon 08/24/2006 Apr 30 12:48:13.850868 kernel: Hypervisor detected: Xen HVM Apr 30 12:48:13.850894 kernel: Xen version 4.11. Apr 30 12:48:13.850912 kernel: platform_pci_unplug: Netfront and the Xen platform PCI driver have been compiled for this kernel: unplug emulated NICs. Apr 30 12:48:13.850931 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 Apr 30 12:48:13.850948 kernel: HVMOP_pagetable_dying not supported Apr 30 12:48:13.850967 kernel: tsc: Detected 2299.998 MHz processor Apr 30 12:48:13.850988 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Apr 30 12:48:13.851006 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Apr 30 12:48:13.851024 kernel: last_pfn = 0x810000 max_arch_pfn = 0x400000000 Apr 30 12:48:13.851041 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Apr 30 12:48:13.851058 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Apr 30 12:48:13.851076 kernel: last_pfn = 0xf0000 max_arch_pfn = 0x400000000 Apr 30 12:48:13.851093 kernel: Using GB pages for direct mapping Apr 30 12:48:13.851111 kernel: ACPI: Early table checksum verification disabled Apr 30 12:48:13.851128 kernel: ACPI: RSDP 0x00000000000EA020 000024 (v02 Xen ) Apr 30 12:48:13.851149 kernel: ACPI: XSDT 0x00000000FC00D4F0 00005C (v01 Xen HVM 00000000 HVML 00000000) Apr 30 12:48:13.851166 kernel: ACPI: FACP 0x00000000FC00D3F0 0000F4 (v04 Xen HVM 00000000 HVML 00000000) Apr 30 12:48:13.851183 kernel: ACPI: DSDT 0x00000000FC001000 00BD14 (v02 Xen HVM 00000000 INTL 20090123) Apr 30 12:48:13.851201 kernel: ACPI: FACS 0x00000000FC00D2F0 000040 Apr 30 12:48:13.851218 kernel: ACPI: FACS 0x00000000FC00D2F0 000040 Apr 30 12:48:13.851235 kernel: ACPI: SSDT 0x00000000FC00CD20 000033 (v02 Xen HVM 00000000 INTL 20090123) Apr 30 12:48:13.851253 kernel: ACPI: SSDT 0x00000000FC00CD60 000031 (v02 Xen HVM 00000000 INTL 20090123) Apr 30 12:48:13.851270 kernel: ACPI: APIC 0x00000000FC00CDA0 0000D8 (v02 Xen HVM 00000000 HVML 00000000) Apr 30 12:48:13.851287 kernel: ACPI: HPET 0x00000000FC00D280 000038 (v01 Xen HVM 00000000 HVML 00000000) Apr 30 12:48:13.851308 kernel: ACPI: WAET 0x00000000FC00D2C0 000028 (v01 Xen HVM 00000000 HVML 00000000) Apr 30 12:48:13.851325 kernel: ACPI: Reserving FACP table memory at [mem 0xfc00d3f0-0xfc00d4e3] Apr 30 12:48:13.851351 kernel: ACPI: Reserving DSDT table memory at [mem 0xfc001000-0xfc00cd13] Apr 30 12:48:13.851393 kernel: ACPI: Reserving FACS table memory at [mem 0xfc00d2f0-0xfc00d32f] Apr 30 12:48:13.851423 kernel: ACPI: Reserving FACS table memory at [mem 0xfc00d2f0-0xfc00d32f] Apr 30 12:48:13.851441 kernel: ACPI: Reserving SSDT table memory at [mem 0xfc00cd20-0xfc00cd52] Apr 30 12:48:13.851462 kernel: ACPI: Reserving SSDT table memory at [mem 0xfc00cd60-0xfc00cd90] Apr 30 12:48:13.851481 kernel: ACPI: Reserving APIC table memory at [mem 0xfc00cda0-0xfc00ce77] Apr 30 12:48:13.851500 kernel: ACPI: Reserving HPET table memory at [mem 0xfc00d280-0xfc00d2b7] Apr 30 12:48:13.851518 kernel: ACPI: Reserving WAET table memory at [mem 0xfc00d2c0-0xfc00d2e7] Apr 30 12:48:13.851536 kernel: No NUMA configuration found Apr 30 12:48:13.851554 kernel: Faking a node at [mem 0x0000000000000000-0x000000080fffffff] Apr 30 12:48:13.851572 kernel: NODE_DATA(0) allocated [mem 0x80fffa000-0x80fffffff] Apr 30 12:48:13.851590 kernel: Zone ranges: Apr 30 12:48:13.851612 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Apr 30 12:48:13.851629 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Apr 30 12:48:13.851647 kernel: Normal [mem 0x0000000100000000-0x000000080fffffff] Apr 30 12:48:13.851665 kernel: Movable zone start for each node Apr 30 12:48:13.851700 kernel: Early memory node ranges Apr 30 12:48:13.851719 kernel: node 0: [mem 0x0000000000001000-0x000000000009dfff] Apr 30 12:48:13.851737 kernel: node 0: [mem 0x0000000000100000-0x00000000efffffff] Apr 30 12:48:13.851756 kernel: node 0: [mem 0x0000000100000000-0x000000080fffffff] Apr 30 12:48:13.851774 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000080fffffff] Apr 30 12:48:13.851796 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Apr 30 12:48:13.851814 kernel: On node 0, zone DMA: 98 pages in unavailable ranges Apr 30 12:48:13.851832 kernel: ACPI: PM-Timer IO Port: 0xb008 Apr 30 12:48:13.851850 kernel: IOAPIC[0]: apic_id 1, version 17, address 0xfec00000, GSI 0-47 Apr 30 12:48:13.851869 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Apr 30 12:48:13.851887 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 low level) Apr 30 12:48:13.851905 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 low level) Apr 30 12:48:13.851923 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 low level) Apr 30 12:48:13.851942 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Apr 30 12:48:13.851963 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Apr 30 12:48:13.851982 kernel: TSC deadline timer available Apr 30 12:48:13.852000 kernel: smpboot: Allowing 15 CPUs, 7 hotplug CPUs Apr 30 12:48:13.852018 kernel: [mem 0xf0000000-0xfbffffff] available for PCI devices Apr 30 12:48:13.852036 kernel: Booting paravirtualized kernel on Xen HVM Apr 30 12:48:13.852055 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Apr 30 12:48:13.852081 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:15 nr_cpu_ids:15 nr_node_ids:1 Apr 30 12:48:13.852099 kernel: percpu: Embedded 58 pages/cpu s197096 r8192 d32280 u262144 Apr 30 12:48:13.852118 kernel: pcpu-alloc: s197096 r8192 d32280 u262144 alloc=1*2097152 Apr 30 12:48:13.852139 kernel: pcpu-alloc: [0] 00 01 02 03 04 05 06 07 [0] 08 09 10 11 12 13 14 -- Apr 30 12:48:13.852157 kernel: xen: PV spinlocks enabled Apr 30 12:48:13.852176 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Apr 30 12:48:13.852203 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=95dd3de5eb34971546a976dc51c66bc73cf59b888896e27767c0cbf245cb98fe Apr 30 12:48:13.852234 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Apr 30 12:48:13.852258 kernel: random: crng init done Apr 30 12:48:13.852289 kernel: Dentry cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear) Apr 30 12:48:13.852314 kernel: Inode-cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear) Apr 30 12:48:13.852346 kernel: Fallback order for Node 0: 0 Apr 30 12:48:13.852376 kernel: Built 1 zonelists, mobility grouping on. Total pages: 8257280 Apr 30 12:48:13.852401 kernel: Policy zone: Normal Apr 30 12:48:13.852432 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 30 12:48:13.852456 kernel: software IO TLB: area num 16. Apr 30 12:48:13.852486 kernel: Memory: 32819536K/33554036K available (14336K kernel code, 2295K rwdata, 22864K rodata, 43484K init, 1592K bss, 734240K reserved, 0K cma-reserved) Apr 30 12:48:13.852510 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=15, Nodes=1 Apr 30 12:48:13.852540 kernel: Kernel/User page tables isolation: enabled Apr 30 12:48:13.852565 kernel: ftrace: allocating 37918 entries in 149 pages Apr 30 12:48:13.852597 kernel: ftrace: allocated 149 pages with 4 groups Apr 30 12:48:13.852616 kernel: Dynamic Preempt: voluntary Apr 30 12:48:13.852635 kernel: rcu: Preemptible hierarchical RCU implementation. Apr 30 12:48:13.852654 kernel: rcu: RCU event tracing is enabled. Apr 30 12:48:13.852673 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=15. Apr 30 12:48:13.852717 kernel: Trampoline variant of Tasks RCU enabled. Apr 30 12:48:13.852736 kernel: Rude variant of Tasks RCU enabled. Apr 30 12:48:13.852754 kernel: Tracing variant of Tasks RCU enabled. Apr 30 12:48:13.852781 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 30 12:48:13.852814 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=15 Apr 30 12:48:13.852833 kernel: NR_IRQS: 33024, nr_irqs: 952, preallocated irqs: 16 Apr 30 12:48:13.852852 kernel: xen:events: Using 2-level ABI Apr 30 12:48:13.852870 kernel: xen:events: Xen HVM callback vector for event delivery is enabled Apr 30 12:48:13.852889 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 30 12:48:13.852907 kernel: Console: colour VGA+ 80x25 Apr 30 12:48:13.852925 kernel: Cannot get hvm parameter CONSOLE_EVTCHN (18): -22! Apr 30 12:48:13.852944 kernel: printk: console [ttyS0] enabled Apr 30 12:48:13.852962 kernel: ACPI: Core revision 20230628 Apr 30 12:48:13.852984 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 30580167144 ns Apr 30 12:48:13.853002 kernel: APIC: Switch to symmetric I/O mode setup Apr 30 12:48:13.853020 kernel: x2apic enabled Apr 30 12:48:13.853038 kernel: APIC: Switched APIC routing to: physical x2apic Apr 30 12:48:13.853057 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=0 pin2=0 Apr 30 12:48:13.853091 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x212733415c7, max_idle_ns: 440795236380 ns Apr 30 12:48:13.853114 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4599.99 BogoMIPS (lpj=2299998) Apr 30 12:48:13.853134 kernel: Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8 Apr 30 12:48:13.853153 kernel: Last level dTLB entries: 4KB 64, 2MB 32, 4MB 32, 1GB 4 Apr 30 12:48:13.853172 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Apr 30 12:48:13.853191 kernel: Spectre V2 : Mitigation: Retpolines Apr 30 12:48:13.853211 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Apr 30 12:48:13.853233 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Apr 30 12:48:13.853252 kernel: Speculative Store Bypass: Vulnerable Apr 30 12:48:13.853271 kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Apr 30 12:48:13.853290 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Apr 30 12:48:13.853311 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Apr 30 12:48:13.853333 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Apr 30 12:48:13.853352 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Apr 30 12:48:13.853371 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Apr 30 12:48:13.853391 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Apr 30 12:48:13.853410 kernel: Freeing SMP alternatives memory: 32K Apr 30 12:48:13.853429 kernel: pid_max: default: 32768 minimum: 301 Apr 30 12:48:13.853448 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Apr 30 12:48:13.853467 kernel: landlock: Up and running. Apr 30 12:48:13.853489 kernel: SELinux: Initializing. Apr 30 12:48:13.853508 kernel: Mount-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 30 12:48:13.853528 kernel: Mountpoint-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 30 12:48:13.853547 kernel: clocksource: xen: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Apr 30 12:48:13.853567 kernel: Xen: using vcpuop timer interface Apr 30 12:48:13.853585 kernel: installing Xen timer for CPU 0 Apr 30 12:48:13.853605 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2686 v4 @ 2.30GHz (family: 0x6, model: 0x4f, stepping: 0x1) Apr 30 12:48:13.853624 kernel: cpu 0 spinlock event irq 53 Apr 30 12:48:13.853644 kernel: RCU Tasks: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=15. Apr 30 12:48:13.853666 kernel: RCU Tasks Rude: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=15. Apr 30 12:48:13.853700 kernel: RCU Tasks Trace: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=15. Apr 30 12:48:13.853720 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only. Apr 30 12:48:13.853740 kernel: signal: max sigframe size: 1776 Apr 30 12:48:13.853760 kernel: rcu: Hierarchical SRCU implementation. Apr 30 12:48:13.853780 kernel: rcu: Max phase no-delay instances is 400. Apr 30 12:48:13.853800 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Apr 30 12:48:13.853819 kernel: smp: Bringing up secondary CPUs ... Apr 30 12:48:13.853839 kernel: installing Xen timer for CPU 1 Apr 30 12:48:13.853861 kernel: smpboot: x86: Booting SMP configuration: Apr 30 12:48:13.853881 kernel: .... node #0, CPUs: #1 Apr 30 12:48:13.853918 kernel: installing Xen timer for CPU 2 Apr 30 12:48:13.853954 kernel: #2 Apr 30 12:48:13.853983 kernel: installing Xen timer for CPU 3 Apr 30 12:48:13.854003 kernel: #3 Apr 30 12:48:13.854021 kernel: cpu 1 spinlock event irq 69 Apr 30 12:48:13.854040 kernel: cpu 2 spinlock event irq 70 Apr 30 12:48:13.854066 kernel: cpu 3 spinlock event irq 71 Apr 30 12:48:13.854089 kernel: installing Xen timer for CPU 4 Apr 30 12:48:13.854109 kernel: #4 Apr 30 12:48:13.854127 kernel: installing Xen timer for CPU 5 Apr 30 12:48:13.854146 kernel: #5 Apr 30 12:48:13.854165 kernel: installing Xen timer for CPU 6 Apr 30 12:48:13.854185 kernel: #6 Apr 30 12:48:13.854203 kernel: installing Xen timer for CPU 7 Apr 30 12:48:13.854222 kernel: #7 Apr 30 12:48:13.854241 kernel: cpu 4 spinlock event irq 92 Apr 30 12:48:13.854260 kernel: MDS CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/mds.html for more details. Apr 30 12:48:13.854284 kernel: MMIO Stale Data CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/processor_mmio_stale_data.html for more details. Apr 30 12:48:13.854303 kernel: cpu 5 spinlock event irq 93 Apr 30 12:48:13.854323 kernel: cpu 6 spinlock event irq 94 Apr 30 12:48:13.854342 kernel: cpu 7 spinlock event irq 95 Apr 30 12:48:13.854361 kernel: smp: Brought up 1 node, 8 CPUs Apr 30 12:48:13.854380 kernel: smpboot: Max logical packages: 2 Apr 30 12:48:13.854399 kernel: smpboot: Total of 8 processors activated (36799.96 BogoMIPS) Apr 30 12:48:13.854418 kernel: devtmpfs: initialized Apr 30 12:48:13.854441 kernel: x86/mm: Memory block size: 128MB Apr 30 12:48:13.854460 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 30 12:48:13.854480 kernel: futex hash table entries: 4096 (order: 6, 262144 bytes, linear) Apr 30 12:48:13.854499 kernel: pinctrl core: initialized pinctrl subsystem Apr 30 12:48:13.854518 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 30 12:48:13.855207 kernel: audit: initializing netlink subsys (disabled) Apr 30 12:48:13.855227 kernel: audit: type=2000 audit(1746017293.926:1): state=initialized audit_enabled=0 res=1 Apr 30 12:48:13.855246 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 30 12:48:13.855265 kernel: thermal_sys: Registered thermal governor 'user_space' Apr 30 12:48:13.855288 kernel: cpuidle: using governor menu Apr 30 12:48:13.855308 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 30 12:48:13.855327 kernel: dca service started, version 1.12.1 Apr 30 12:48:13.855355 kernel: PCI: Using configuration type 1 for base access Apr 30 12:48:13.855390 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Apr 30 12:48:13.855410 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Apr 30 12:48:13.855429 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Apr 30 12:48:13.855456 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Apr 30 12:48:13.855475 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Apr 30 12:48:13.855498 kernel: ACPI: Added _OSI(Module Device) Apr 30 12:48:13.855517 kernel: ACPI: Added _OSI(Processor Device) Apr 30 12:48:13.855536 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Apr 30 12:48:13.855555 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 30 12:48:13.855574 kernel: ACPI: 3 ACPI AML tables successfully acquired and loaded Apr 30 12:48:13.855593 kernel: xen: --> pirq=16 -> irq=9 (gsi=9) Apr 30 12:48:13.855612 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Apr 30 12:48:13.855631 kernel: ACPI: Interpreter enabled Apr 30 12:48:13.855651 kernel: ACPI: PM: (supports S0 S3 S5) Apr 30 12:48:13.855670 kernel: ACPI: Using IOAPIC for interrupt routing Apr 30 12:48:13.855708 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Apr 30 12:48:13.855728 kernel: PCI: Using E820 reservations for host bridge windows Apr 30 12:48:13.855747 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Apr 30 12:48:13.855766 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Apr 30 12:48:13.855980 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Apr 30 12:48:13.856127 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Apr 30 12:48:13.856269 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Apr 30 12:48:13.856296 kernel: acpiphp: Slot [0] registered Apr 30 12:48:13.856316 kernel: acpiphp: Slot [3] registered Apr 30 12:48:13.856335 kernel: acpiphp: Slot [4] registered Apr 30 12:48:13.856354 kernel: acpiphp: Slot [5] registered Apr 30 12:48:13.856373 kernel: acpiphp: Slot [6] registered Apr 30 12:48:13.856392 kernel: acpiphp: Slot [7] registered Apr 30 12:48:13.856411 kernel: acpiphp: Slot [8] registered Apr 30 12:48:13.856431 kernel: acpiphp: Slot [9] registered Apr 30 12:48:13.856450 kernel: acpiphp: Slot [10] registered Apr 30 12:48:13.856472 kernel: acpiphp: Slot [11] registered Apr 30 12:48:13.856491 kernel: acpiphp: Slot [12] registered Apr 30 12:48:13.856510 kernel: acpiphp: Slot [13] registered Apr 30 12:48:13.856530 kernel: acpiphp: Slot [14] registered Apr 30 12:48:13.856549 kernel: acpiphp: Slot [15] registered Apr 30 12:48:13.856568 kernel: acpiphp: Slot [16] registered Apr 30 12:48:13.856587 kernel: acpiphp: Slot [17] registered Apr 30 12:48:13.856606 kernel: acpiphp: Slot [18] registered Apr 30 12:48:13.856625 kernel: acpiphp: Slot [19] registered Apr 30 12:48:13.856647 kernel: acpiphp: Slot [20] registered Apr 30 12:48:13.856666 kernel: acpiphp: Slot [21] registered Apr 30 12:48:13.856707 kernel: acpiphp: Slot [22] registered Apr 30 12:48:13.856727 kernel: acpiphp: Slot [23] registered Apr 30 12:48:13.856747 kernel: acpiphp: Slot [24] registered Apr 30 12:48:13.856766 kernel: acpiphp: Slot [25] registered Apr 30 12:48:13.856786 kernel: acpiphp: Slot [26] registered Apr 30 12:48:13.856806 kernel: acpiphp: Slot [27] registered Apr 30 12:48:13.856825 kernel: acpiphp: Slot [28] registered Apr 30 12:48:13.856845 kernel: acpiphp: Slot [29] registered Apr 30 12:48:13.856868 kernel: acpiphp: Slot [30] registered Apr 30 12:48:13.856888 kernel: acpiphp: Slot [31] registered Apr 30 12:48:13.856907 kernel: PCI host bridge to bus 0000:00 Apr 30 12:48:13.857048 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Apr 30 12:48:13.857180 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Apr 30 12:48:13.857307 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Apr 30 12:48:13.857431 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xffffffff window] Apr 30 12:48:13.857554 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Apr 30 12:48:13.857734 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Apr 30 12:48:13.857854 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Apr 30 12:48:13.857971 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 Apr 30 12:48:13.858077 kernel: pci 0000:00:01.1: reg 0x20: [io 0xc000-0xc00f] Apr 30 12:48:13.858218 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Apr 30 12:48:13.858357 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Apr 30 12:48:13.858501 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Apr 30 12:48:13.858636 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Apr 30 12:48:13.858663 kernel: * Found PM-Timer Bug on the chipset. Due to workarounds for a bug, * this clock source is slow. Consider trying other clock sources Apr 30 12:48:13.858906 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 Apr 30 12:48:13.859047 kernel: pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI Apr 30 12:48:13.859192 kernel: pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 Apr 30 12:48:13.859331 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xf8000000-0xf9ffffff pref] Apr 30 12:48:13.859475 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xfbfff000-0xfbffffff] Apr 30 12:48:13.859610 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Apr 30 12:48:13.859776 kernel: pci 0000:00:03.0: [8086:10ed] type 00 class 0x020000 Apr 30 12:48:13.859916 kernel: pci 0000:00:03.0: reg 0x10: [mem 0xfbff4000-0xfbff7fff 64bit pref] Apr 30 12:48:13.860058 kernel: pci 0000:00:03.0: reg 0x1c: [mem 0xfbff8000-0xfbffbfff 64bit pref] Apr 30 12:48:13.860202 kernel: pci 0000:00:1f.0: [5853:0001] type 00 class 0xff8000 Apr 30 12:48:13.860348 kernel: pci 0000:00:1f.0: reg 0x10: [io 0xc100-0xc1ff] Apr 30 12:48:13.860487 kernel: pci 0000:00:1f.0: reg 0x14: [mem 0xfa000000-0xfaffffff pref] Apr 30 12:48:13.860510 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 5 Apr 30 12:48:13.860530 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Apr 30 12:48:13.860550 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Apr 30 12:48:13.860570 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 5 Apr 30 12:48:13.860590 kernel: xen:balloon: Initialising balloon driver Apr 30 12:48:13.860610 kernel: iommu: Default domain type: Translated Apr 30 12:48:13.860633 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Apr 30 12:48:13.860653 kernel: PCI: Using ACPI for IRQ routing Apr 30 12:48:13.860672 kernel: PCI: pci_cache_line_size set to 64 bytes Apr 30 12:48:13.860715 kernel: e820: reserve RAM buffer [mem 0x0009e000-0x0009ffff] Apr 30 12:48:13.861166 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Apr 30 12:48:13.861309 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Apr 30 12:48:13.861448 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Apr 30 12:48:13.861472 kernel: vgaarb: loaded Apr 30 12:48:13.861492 kernel: hpet: 3 channels of 0 reserved for per-cpu timers Apr 30 12:48:13.861516 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Apr 30 12:48:13.861536 kernel: hpet0: 3 comparators, 64-bit 62.500000 MHz counter Apr 30 12:48:13.861556 kernel: clocksource: Switched to clocksource xen Apr 30 12:48:13.861575 kernel: VFS: Disk quotas dquot_6.6.0 Apr 30 12:48:13.861596 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 30 12:48:13.861615 kernel: pnp: PnP ACPI init Apr 30 12:48:13.861774 kernel: system 00:00: [mem 0x00000000-0x0009ffff] could not be reserved Apr 30 12:48:13.861913 kernel: system 00:01: [io 0x08a0-0x08a3] has been reserved Apr 30 12:48:13.862052 kernel: system 00:01: [io 0x0cc0-0x0ccf] has been reserved Apr 30 12:48:13.862183 kernel: system 00:01: [io 0x04d0-0x04d1] has been reserved Apr 30 12:48:13.862206 kernel: xen: --> pirq=17 -> irq=8 (gsi=8) Apr 30 12:48:13.862226 kernel: xen: --> pirq=18 -> irq=12 (gsi=12) Apr 30 12:48:13.862245 kernel: xen: --> pirq=19 -> irq=1 (gsi=1) Apr 30 12:48:13.862265 kernel: xen: --> pirq=20 -> irq=6 (gsi=6) Apr 30 12:48:13.862402 kernel: pnp 00:05: [dma 2] Apr 30 12:48:13.862431 kernel: xen: --> pirq=21 -> irq=4 (gsi=4) Apr 30 12:48:13.862564 kernel: system 00:07: [io 0x10c0-0x1141] has been reserved Apr 30 12:48:13.862711 kernel: system 00:07: [io 0xb044-0xb047] has been reserved Apr 30 12:48:13.862736 kernel: pnp: PnP ACPI: found 8 devices Apr 30 12:48:13.862756 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Apr 30 12:48:13.862776 kernel: NET: Registered PF_INET protocol family Apr 30 12:48:13.862795 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 30 12:48:13.862815 kernel: tcp_listen_portaddr_hash hash table entries: 16384 (order: 6, 262144 bytes, linear) Apr 30 12:48:13.862840 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 30 12:48:13.862860 kernel: TCP established hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 30 12:48:13.862880 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Apr 30 12:48:13.862899 kernel: TCP: Hash tables configured (established 262144 bind 65536) Apr 30 12:48:13.862919 kernel: UDP hash table entries: 16384 (order: 7, 524288 bytes, linear) Apr 30 12:48:13.862939 kernel: UDP-Lite hash table entries: 16384 (order: 7, 524288 bytes, linear) Apr 30 12:48:13.862959 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 30 12:48:13.862979 kernel: NET: Registered PF_XDP protocol family Apr 30 12:48:13.863110 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Apr 30 12:48:13.863246 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Apr 30 12:48:13.863373 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Apr 30 12:48:13.863497 kernel: pci_bus 0000:00: resource 7 [mem 0xf0000000-0xffffffff window] Apr 30 12:48:13.863641 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Apr 30 12:48:13.863799 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Apr 30 12:48:13.863824 kernel: PCI: CLS 0 bytes, default 64 Apr 30 12:48:13.863845 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Apr 30 12:48:13.863869 kernel: software IO TLB: mapped [mem 0x00000000ec000000-0x00000000f0000000] (64MB) Apr 30 12:48:13.863889 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 655360 ms ovfl timer Apr 30 12:48:13.864284 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x212733415c7, max_idle_ns: 440795236380 ns Apr 30 12:48:13.864304 kernel: Initialise system trusted keyrings Apr 30 12:48:13.864324 kernel: workingset: timestamp_bits=39 max_order=23 bucket_order=0 Apr 30 12:48:13.864344 kernel: Key type asymmetric registered Apr 30 12:48:13.864363 kernel: Asymmetric key parser 'x509' registered Apr 30 12:48:13.864383 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Apr 30 12:48:13.864403 kernel: io scheduler mq-deadline registered Apr 30 12:48:13.864427 kernel: io scheduler kyber registered Apr 30 12:48:13.864447 kernel: io scheduler bfq registered Apr 30 12:48:13.864467 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Apr 30 12:48:13.864487 kernel: xen: --> pirq=22 -> irq=47 (gsi=47) Apr 30 12:48:13.864507 kernel: xen:grant_table: Grant tables using version 1 layout Apr 30 12:48:13.864526 kernel: Grant table initialized Apr 30 12:48:13.864546 kernel: Cannot get hvm parameter CONSOLE_EVTCHN (18): -22! Apr 30 12:48:13.864566 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 30 12:48:13.864586 kernel: 00:06: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Apr 30 12:48:13.864609 kernel: i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12 Apr 30 12:48:13.864629 kernel: i8042: Warning: Keylock active Apr 30 12:48:13.864649 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Apr 30 12:48:13.864669 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Apr 30 12:48:13.864848 kernel: rtc_cmos 00:02: registered as rtc0 Apr 30 12:48:13.865013 kernel: rtc_cmos 00:02: setting system clock to 2025-04-30T12:48:13 UTC (1746017293) Apr 30 12:48:13.865149 kernel: rtc_cmos 00:02: alarms up to one day, 114 bytes nvram, hpet irqs Apr 30 12:48:13.865173 kernel: intel_pstate: CPU model not supported Apr 30 12:48:13.865198 kernel: NET: Registered PF_INET6 protocol family Apr 30 12:48:13.865219 kernel: Segment Routing with IPv6 Apr 30 12:48:13.865233 kernel: In-situ OAM (IOAM) with IPv6 Apr 30 12:48:13.865246 kernel: NET: Registered PF_PACKET protocol family Apr 30 12:48:13.865259 kernel: Key type dns_resolver registered Apr 30 12:48:13.865272 kernel: IPI shorthand broadcast: enabled Apr 30 12:48:13.865284 kernel: sched_clock: Marking stable (684004180, 121910269)->(838765601, -32851152) Apr 30 12:48:13.865297 kernel: registered taskstats version 1 Apr 30 12:48:13.865310 kernel: Loading compiled-in X.509 certificates Apr 30 12:48:13.865325 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.88-flatcar: 10d2d341d26c1df942e743344427c053ef3a2a5f' Apr 30 12:48:13.865337 kernel: Key type .fscrypt registered Apr 30 12:48:13.865350 kernel: Key type fscrypt-provisioning registered Apr 30 12:48:13.865363 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 30 12:48:13.865376 kernel: ima: Allocated hash algorithm: sha1 Apr 30 12:48:13.865388 kernel: ima: No architecture policies found Apr 30 12:48:13.865401 kernel: xenbus_probe_frontend: Device with no driver: device/vbd/51712 Apr 30 12:48:13.865414 kernel: clk: Disabling unused clocks Apr 30 12:48:13.865426 kernel: Freeing unused kernel image (initmem) memory: 43484K Apr 30 12:48:13.865442 kernel: Write protecting the kernel read-only data: 38912k Apr 30 12:48:13.865454 kernel: Freeing unused kernel image (rodata/data gap) memory: 1712K Apr 30 12:48:13.865467 kernel: Run /init as init process Apr 30 12:48:13.865480 kernel: with arguments: Apr 30 12:48:13.865492 kernel: /init Apr 30 12:48:13.865504 kernel: with environment: Apr 30 12:48:13.865517 kernel: HOME=/ Apr 30 12:48:13.865529 kernel: TERM=linux Apr 30 12:48:13.865542 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Apr 30 12:48:13.865558 systemd[1]: Successfully made /usr/ read-only. Apr 30 12:48:13.865577 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) Apr 30 12:48:13.865592 systemd[1]: Detected virtualization xen. Apr 30 12:48:13.865605 systemd[1]: Detected architecture x86-64. Apr 30 12:48:13.865617 systemd[1]: Running in initrd. Apr 30 12:48:13.865629 systemd[1]: No hostname configured, using default hostname. Apr 30 12:48:13.865644 systemd[1]: Hostname set to . Apr 30 12:48:13.865660 systemd[1]: Initializing machine ID from VM UUID. Apr 30 12:48:13.865673 systemd[1]: Queued start job for default target initrd.target. Apr 30 12:48:13.865702 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 30 12:48:13.865715 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 30 12:48:13.865729 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Apr 30 12:48:13.865742 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 30 12:48:13.865756 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Apr 30 12:48:13.865774 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Apr 30 12:48:13.865788 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Apr 30 12:48:13.865802 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Apr 30 12:48:13.865815 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 30 12:48:13.865828 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 30 12:48:13.865843 systemd[1]: Reached target paths.target - Path Units. Apr 30 12:48:13.865856 systemd[1]: Reached target slices.target - Slice Units. Apr 30 12:48:13.865869 systemd[1]: Reached target swap.target - Swaps. Apr 30 12:48:13.865884 systemd[1]: Reached target timers.target - Timer Units. Apr 30 12:48:13.865897 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Apr 30 12:48:13.865910 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 30 12:48:13.865923 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Apr 30 12:48:13.865936 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Apr 30 12:48:13.865949 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 30 12:48:13.865962 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 30 12:48:13.865975 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 30 12:48:13.865991 systemd[1]: Reached target sockets.target - Socket Units. Apr 30 12:48:13.866004 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Apr 30 12:48:13.866017 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 30 12:48:13.866030 systemd[1]: Finished network-cleanup.service - Network Cleanup. Apr 30 12:48:13.866043 systemd[1]: Starting systemd-fsck-usr.service... Apr 30 12:48:13.866055 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 30 12:48:13.866071 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 30 12:48:13.866084 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 30 12:48:13.866097 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Apr 30 12:48:13.866110 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 30 12:48:13.866125 systemd[1]: Finished systemd-fsck-usr.service. Apr 30 12:48:13.866141 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 30 12:48:13.866180 systemd-journald[222]: Collecting audit messages is disabled. Apr 30 12:48:13.866221 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 30 12:48:13.866236 systemd-journald[222]: Journal started Apr 30 12:48:13.866272 systemd-journald[222]: Runtime Journal (/run/log/journal/ec2bb5ffe304bc44b351c4fc56394cac) is 8M, max 641.8M, 633.8M free. Apr 30 12:48:13.852815 systemd-modules-load[223]: Inserted module 'overlay' Apr 30 12:48:13.892477 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Apr 30 12:48:13.892506 kernel: Bridge firewalling registered Apr 30 12:48:13.885275 systemd-modules-load[223]: Inserted module 'br_netfilter' Apr 30 12:48:13.895050 systemd[1]: Started systemd-journald.service - Journal Service. Apr 30 12:48:13.897090 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 30 12:48:13.899497 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 30 12:48:13.916827 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 30 12:48:13.917873 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 30 12:48:13.919792 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 30 12:48:13.921081 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 30 12:48:13.932532 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 30 12:48:13.932830 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 30 12:48:13.935022 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 30 12:48:13.935911 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 30 12:48:13.941004 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Apr 30 12:48:13.944269 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 30 12:48:13.958111 dracut-cmdline[260]: dracut-dracut-053 Apr 30 12:48:13.961024 dracut-cmdline[260]: Using kernel command line parameters: rd.driver.pre=btrfs 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=95dd3de5eb34971546a976dc51c66bc73cf59b888896e27767c0cbf245cb98fe Apr 30 12:48:13.982988 systemd-resolved[261]: Positive Trust Anchors: Apr 30 12:48:13.983003 systemd-resolved[261]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 30 12:48:13.983053 systemd-resolved[261]: 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 Apr 30 12:48:13.986588 systemd-resolved[261]: Defaulting to hostname 'linux'. Apr 30 12:48:13.987808 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 30 12:48:13.993465 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 30 12:48:14.009696 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Apr 30 12:48:14.047708 kernel: SCSI subsystem initialized Apr 30 12:48:14.057708 kernel: Loading iSCSI transport class v2.0-870. Apr 30 12:48:14.070699 kernel: iscsi: registered transport (tcp) Apr 30 12:48:14.093700 kernel: iscsi: registered transport (qla4xxx) Apr 30 12:48:14.093740 kernel: QLogic iSCSI HBA Driver Apr 30 12:48:14.135491 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Apr 30 12:48:14.143868 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Apr 30 12:48:14.169028 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 30 12:48:14.169096 kernel: device-mapper: uevent: version 1.0.3 Apr 30 12:48:14.169123 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Apr 30 12:48:14.212716 kernel: raid6: avx2x4 gen() 16914 MB/s Apr 30 12:48:14.229702 kernel: raid6: avx2x2 gen() 17380 MB/s Apr 30 12:48:14.246699 kernel: raid6: avx2x1 gen() 13275 MB/s Apr 30 12:48:14.246723 kernel: raid6: using algorithm avx2x2 gen() 17380 MB/s Apr 30 12:48:14.263700 kernel: raid6: .... xor() 20069 MB/s, rmw enabled Apr 30 12:48:14.263728 kernel: raid6: using avx2x2 recovery algorithm Apr 30 12:48:14.285700 kernel: xor: automatically using best checksumming function avx Apr 30 12:48:14.483705 kernel: Btrfs loaded, zoned=no, fsverity=no Apr 30 12:48:14.496291 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Apr 30 12:48:14.509876 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 30 12:48:14.525233 systemd-udevd[446]: Using default interface naming scheme 'v255'. Apr 30 12:48:14.531352 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 30 12:48:14.532231 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Apr 30 12:48:14.551812 dracut-pre-trigger[451]: rd.md=0: removing MD RAID activation Apr 30 12:48:14.583390 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Apr 30 12:48:14.597906 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 30 12:48:14.725143 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 30 12:48:14.742835 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Apr 30 12:48:14.756041 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Apr 30 12:48:14.758354 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Apr 30 12:48:14.761586 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 30 12:48:14.767724 kernel: cryptd: max_cpu_qlen set to 1000 Apr 30 12:48:14.763792 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 30 12:48:14.773008 kernel: ixgbevf: Intel(R) 10 Gigabit PCI Express Virtual Function Network Driver Apr 30 12:48:14.773062 kernel: ixgbevf: Copyright (c) 2009 - 2018 Intel Corporation. Apr 30 12:48:14.783317 kernel: AVX2 version of gcm_enc/dec engaged. Apr 30 12:48:14.783368 kernel: AES CTR mode by8 optimization enabled Apr 30 12:48:14.786146 kernel: ixgbevf 0000:00:03.0: 06:4f:82:dc:85:57 Apr 30 12:48:14.787222 kernel: ixgbevf 0000:00:03.0: MAC: 1 Apr 30 12:48:14.787419 kernel: ixgbevf 0000:00:03.0: Intel(R) 82599 Virtual Function Apr 30 12:48:14.786022 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Apr 30 12:48:14.797827 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Apr 30 12:48:14.803722 (udev-worker)[515]: Network interface NamePolicy= disabled on kernel command line. Apr 30 12:48:14.809050 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 30 12:48:14.809169 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 30 12:48:14.810636 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 30 12:48:14.811808 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 30 12:48:14.812287 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 30 12:48:14.827267 kernel: libata version 3.00 loaded. Apr 30 12:48:14.814639 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 30 12:48:14.829809 kernel: ata_piix 0000:00:01.1: version 2.13 Apr 30 12:48:14.835283 kernel: scsi host0: ata_piix Apr 30 12:48:14.835488 kernel: scsi host1: ata_piix Apr 30 12:48:14.835653 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc000 irq 14 Apr 30 12:48:14.835696 kernel: blkfront: xvda: barrier or flush: disabled; persistent grants: disabled; indirect descriptors: enabled; bounce buffer: disabled; Apr 30 12:48:14.835722 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc008 irq 15 Apr 30 12:48:14.834644 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 30 12:48:14.843854 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Apr 30 12:48:14.843895 kernel: GPT:9289727 != 16777215 Apr 30 12:48:14.843912 kernel: GPT:Alternate GPT header not at the end of the disk. Apr 30 12:48:14.843929 kernel: GPT:9289727 != 16777215 Apr 30 12:48:14.845605 kernel: GPT: Use GNU Parted to correct GPT errors. Apr 30 12:48:14.845627 kernel: xvda: xvda1 xvda2 xvda3 xvda4 xvda6 xvda7 xvda9 Apr 30 12:48:14.881831 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 30 12:48:14.883380 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 30 12:48:14.905558 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 30 12:48:15.105980 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Apr 30 12:48:15.116994 kernel: BTRFS: device fsid 0778af4c-f6f8-4118-a0d2-fb24d73f5df4 devid 1 transid 40 /dev/xvda3 scanned by (udev-worker) (492) Apr 30 12:48:15.124028 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Apr 30 12:48:15.126548 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/xvda6 scanned by (udev-worker) (497) Apr 30 12:48:15.127056 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Apr 30 12:48:15.127263 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Apr 30 12:48:15.137965 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 30 12:48:15.148802 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Apr 30 12:48:15.155903 disk-uuid[612]: Primary Header is updated. Apr 30 12:48:15.155903 disk-uuid[612]: Secondary Entries is updated. Apr 30 12:48:15.155903 disk-uuid[612]: Secondary Header is updated. Apr 30 12:48:15.162695 kernel: xvda: xvda1 xvda2 xvda3 xvda4 xvda6 xvda7 xvda9 Apr 30 12:48:16.173699 kernel: xvda: xvda1 xvda2 xvda3 xvda4 xvda6 xvda7 xvda9 Apr 30 12:48:16.173761 disk-uuid[613]: The operation has completed successfully. Apr 30 12:48:16.228896 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 30 12:48:16.228985 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Apr 30 12:48:16.247824 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Apr 30 12:48:16.253116 sh[627]: Success Apr 30 12:48:16.268699 kernel: device-mapper: verity: sha256 using implementation "sha256-avx2" Apr 30 12:48:16.385954 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Apr 30 12:48:16.398021 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Apr 30 12:48:16.401868 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Apr 30 12:48:16.437333 kernel: BTRFS info (device dm-0): first mount of filesystem 0778af4c-f6f8-4118-a0d2-fb24d73f5df4 Apr 30 12:48:16.437391 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Apr 30 12:48:16.437409 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Apr 30 12:48:16.438417 kernel: BTRFS info (device dm-0): disabling log replay at mount time Apr 30 12:48:16.439122 kernel: BTRFS info (device dm-0): using free space tree Apr 30 12:48:16.559700 kernel: BTRFS info (device dm-0): enabling ssd optimizations Apr 30 12:48:16.598001 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Apr 30 12:48:16.600258 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Apr 30 12:48:16.611821 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Apr 30 12:48:16.614370 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Apr 30 12:48:16.650973 kernel: BTRFS info (device xvda6): first mount of filesystem 70902d85-577c-4d48-8616-61ed6d6784d1 Apr 30 12:48:16.651035 kernel: BTRFS info (device xvda6): using crc32c (crc32c-intel) checksum algorithm Apr 30 12:48:16.651059 kernel: BTRFS info (device xvda6): using free space tree Apr 30 12:48:16.658726 kernel: BTRFS info (device xvda6): enabling ssd optimizations Apr 30 12:48:16.662706 kernel: BTRFS info (device xvda6): last unmount of filesystem 70902d85-577c-4d48-8616-61ed6d6784d1 Apr 30 12:48:16.664712 systemd[1]: Finished ignition-setup.service - Ignition (setup). Apr 30 12:48:16.671890 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Apr 30 12:48:16.707337 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 30 12:48:16.723847 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 30 12:48:16.748895 systemd-networkd[806]: lo: Link UP Apr 30 12:48:16.748904 systemd-networkd[806]: lo: Gained carrier Apr 30 12:48:16.750838 systemd-networkd[806]: Enumeration completed Apr 30 12:48:16.750934 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 30 12:48:16.751600 systemd-networkd[806]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 30 12:48:16.751605 systemd-networkd[806]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 30 12:48:16.753461 systemd[1]: Reached target network.target - Network. Apr 30 12:48:16.766186 systemd-networkd[806]: eth0: Link UP Apr 30 12:48:16.768392 systemd-networkd[806]: eth0: Gained carrier Apr 30 12:48:16.769903 kernel: ixgbevf 0000:00:03.0: NIC Link is Up 10 Gbps Apr 30 12:48:16.768409 systemd-networkd[806]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 30 12:48:16.790055 systemd-networkd[806]: eth0: DHCPv4 address 172.31.27.168/20, gateway 172.31.16.1 acquired from 172.31.16.1 Apr 30 12:48:16.839708 kernel: ixgbevf 0000:00:03.0: NIC Link is Up 10 Gbps Apr 30 12:48:17.068881 ignition[753]: Ignition 2.20.0 Apr 30 12:48:17.068893 ignition[753]: Stage: fetch-offline Apr 30 12:48:17.069451 ignition[753]: no configs at "/usr/lib/ignition/base.d" Apr 30 12:48:17.069462 ignition[753]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 30 12:48:17.069701 ignition[753]: Ignition finished successfully Apr 30 12:48:17.074469 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Apr 30 12:48:17.086854 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Apr 30 12:48:17.100338 ignition[824]: Ignition 2.20.0 Apr 30 12:48:17.100352 ignition[824]: Stage: fetch Apr 30 12:48:17.100772 ignition[824]: no configs at "/usr/lib/ignition/base.d" Apr 30 12:48:17.100787 ignition[824]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 30 12:48:17.100873 ignition[824]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 30 12:48:17.110390 ignition[824]: PUT result: OK Apr 30 12:48:17.112340 ignition[824]: parsed url from cmdline: "" Apr 30 12:48:17.112350 ignition[824]: no config URL provided Apr 30 12:48:17.112358 ignition[824]: reading system config file "/usr/lib/ignition/user.ign" Apr 30 12:48:17.112373 ignition[824]: no config at "/usr/lib/ignition/user.ign" Apr 30 12:48:17.112394 ignition[824]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 30 12:48:17.113120 ignition[824]: PUT result: OK Apr 30 12:48:17.113189 ignition[824]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Apr 30 12:48:17.114086 ignition[824]: GET result: OK Apr 30 12:48:17.114135 ignition[824]: parsing config with SHA512: 56a8d9aa0ab89e0ab64edce4f781db3f692fa9a8a8d99b0df3fc88db8bb5d648b9d48cb0e6a640138f3b4460f75204f3c992bdb2f6f4a8cbc3a5db39c1429385 Apr 30 12:48:17.122931 unknown[824]: fetched base config from "system" Apr 30 12:48:17.122947 unknown[824]: fetched base config from "system" Apr 30 12:48:17.122956 unknown[824]: fetched user config from "aws" Apr 30 12:48:17.124687 ignition[824]: fetch: fetch complete Apr 30 12:48:17.124697 ignition[824]: fetch: fetch passed Apr 30 12:48:17.124738 ignition[824]: Ignition finished successfully Apr 30 12:48:17.127808 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Apr 30 12:48:17.140182 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Apr 30 12:48:17.156375 ignition[836]: Ignition 2.20.0 Apr 30 12:48:17.156387 ignition[836]: Stage: kargs Apr 30 12:48:17.157076 ignition[836]: no configs at "/usr/lib/ignition/base.d" Apr 30 12:48:17.157086 ignition[836]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 30 12:48:17.157168 ignition[836]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 30 12:48:17.158013 ignition[836]: PUT result: OK Apr 30 12:48:17.170238 ignition[836]: kargs: kargs passed Apr 30 12:48:17.170304 ignition[836]: Ignition finished successfully Apr 30 12:48:17.173473 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Apr 30 12:48:17.187934 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Apr 30 12:48:17.200984 ignition[847]: Ignition 2.20.0 Apr 30 12:48:17.200997 ignition[847]: Stage: disks Apr 30 12:48:17.201291 ignition[847]: no configs at "/usr/lib/ignition/base.d" Apr 30 12:48:17.201301 ignition[847]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 30 12:48:17.201378 ignition[847]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 30 12:48:17.202516 ignition[847]: PUT result: OK Apr 30 12:48:17.206763 systemd[1]: Finished ignition-disks.service - Ignition (disks). Apr 30 12:48:17.204957 ignition[847]: disks: disks passed Apr 30 12:48:17.211494 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Apr 30 12:48:17.205002 ignition[847]: Ignition finished successfully Apr 30 12:48:17.213386 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Apr 30 12:48:17.215117 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 30 12:48:17.217876 systemd[1]: Reached target sysinit.target - System Initialization. Apr 30 12:48:17.219570 systemd[1]: Reached target basic.target - Basic System. Apr 30 12:48:17.233865 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Apr 30 12:48:17.279254 systemd-fsck[862]: ROOT: clean, 14/553520 files, 52654/553472 blocks Apr 30 12:48:17.282508 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Apr 30 12:48:17.293270 systemd[1]: Mounting sysroot.mount - /sysroot... Apr 30 12:48:17.421705 kernel: EXT4-fs (xvda9): mounted filesystem 59d16236-967d-47d1-a9bd-4b055a17ab77 r/w with ordered data mode. Quota mode: none. Apr 30 12:48:17.422708 systemd[1]: Mounted sysroot.mount - /sysroot. Apr 30 12:48:17.423363 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Apr 30 12:48:17.442774 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 30 12:48:17.444762 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Apr 30 12:48:17.446512 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Apr 30 12:48:17.446558 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Apr 30 12:48:17.446585 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Apr 30 12:48:17.455817 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Apr 30 12:48:17.459589 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Apr 30 12:48:17.479705 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/xvda6 scanned by mount (870) Apr 30 12:48:17.482092 kernel: BTRFS info (device xvda6): first mount of filesystem 70902d85-577c-4d48-8616-61ed6d6784d1 Apr 30 12:48:17.482116 kernel: BTRFS info (device xvda6): using crc32c (crc32c-intel) checksum algorithm Apr 30 12:48:17.482133 kernel: BTRFS info (device xvda6): using free space tree Apr 30 12:48:17.496704 kernel: BTRFS info (device xvda6): enabling ssd optimizations Apr 30 12:48:17.498363 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 30 12:48:18.223072 initrd-setup-root[894]: cut: /sysroot/etc/passwd: No such file or directory Apr 30 12:48:18.236493 initrd-setup-root[901]: cut: /sysroot/etc/group: No such file or directory Apr 30 12:48:18.253169 initrd-setup-root[908]: cut: /sysroot/etc/shadow: No such file or directory Apr 30 12:48:18.256230 initrd-setup-root[915]: cut: /sysroot/etc/gshadow: No such file or directory Apr 30 12:48:18.534829 systemd-networkd[806]: eth0: Gained IPv6LL Apr 30 12:48:18.703071 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Apr 30 12:48:18.715980 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Apr 30 12:48:18.717648 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Apr 30 12:48:18.722702 kernel: BTRFS info (device xvda6): last unmount of filesystem 70902d85-577c-4d48-8616-61ed6d6784d1 Apr 30 12:48:18.723086 systemd[1]: sysroot-oem.mount: Deactivated successfully. Apr 30 12:48:18.743842 ignition[983]: INFO : Ignition 2.20.0 Apr 30 12:48:18.743842 ignition[983]: INFO : Stage: mount Apr 30 12:48:18.745653 ignition[983]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 30 12:48:18.745653 ignition[983]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 30 12:48:18.745653 ignition[983]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 30 12:48:18.745653 ignition[983]: INFO : PUT result: OK Apr 30 12:48:18.755955 ignition[983]: INFO : mount: mount passed Apr 30 12:48:18.755955 ignition[983]: INFO : Ignition finished successfully Apr 30 12:48:18.749368 systemd[1]: Finished ignition-mount.service - Ignition (mount). Apr 30 12:48:18.771835 systemd[1]: Starting ignition-files.service - Ignition (files)... Apr 30 12:48:18.776025 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Apr 30 12:48:18.781972 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 30 12:48:18.811401 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/xvda6 scanned by mount (999) Apr 30 12:48:18.811462 kernel: BTRFS info (device xvda6): first mount of filesystem 70902d85-577c-4d48-8616-61ed6d6784d1 Apr 30 12:48:18.811480 kernel: BTRFS info (device xvda6): using crc32c (crc32c-intel) checksum algorithm Apr 30 12:48:18.812850 kernel: BTRFS info (device xvda6): using free space tree Apr 30 12:48:18.817711 kernel: BTRFS info (device xvda6): enabling ssd optimizations Apr 30 12:48:18.819238 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 30 12:48:18.844243 ignition[1015]: INFO : Ignition 2.20.0 Apr 30 12:48:18.844243 ignition[1015]: INFO : Stage: files Apr 30 12:48:18.846019 ignition[1015]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 30 12:48:18.846019 ignition[1015]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 30 12:48:18.846019 ignition[1015]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 30 12:48:18.846019 ignition[1015]: INFO : PUT result: OK Apr 30 12:48:18.851815 ignition[1015]: DEBUG : files: compiled without relabeling support, skipping Apr 30 12:48:18.851815 ignition[1015]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 30 12:48:18.851815 ignition[1015]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 30 12:48:18.903224 ignition[1015]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 30 12:48:18.904668 ignition[1015]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 30 12:48:18.906046 ignition[1015]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 30 12:48:18.905144 unknown[1015]: wrote ssh authorized keys file for user: core Apr 30 12:48:18.909477 systemd[1]: Finished ignition-files.service - Ignition (files). Apr 30 12:48:18.912203 ignition[1015]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Apr 30 12:48:18.912203 ignition[1015]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Apr 30 12:48:18.912203 ignition[1015]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 30 12:48:18.912203 ignition[1015]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 30 12:48:18.912203 ignition[1015]: INFO : files: files passed Apr 30 12:48:18.912203 ignition[1015]: INFO : Ignition finished successfully Apr 30 12:48:18.926835 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Apr 30 12:48:18.928892 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Apr 30 12:48:18.935552 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 30 12:48:18.935857 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Apr 30 12:48:18.943322 initrd-setup-root-after-ignition[1049]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 30 12:48:18.943322 initrd-setup-root-after-ignition[1049]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Apr 30 12:48:18.947085 initrd-setup-root-after-ignition[1053]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 30 12:48:18.948384 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 30 12:48:18.959161 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Apr 30 12:48:18.979844 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Apr 30 12:48:19.004219 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 30 12:48:19.004324 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Apr 30 12:48:19.006793 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Apr 30 12:48:19.010316 systemd[1]: Reached target initrd.target - Initrd Default Target. Apr 30 12:48:19.012358 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Apr 30 12:48:19.020813 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Apr 30 12:48:19.034259 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 30 12:48:19.038223 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Apr 30 12:48:19.052571 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Apr 30 12:48:19.053127 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 30 12:48:19.081221 ignition[1073]: INFO : Ignition 2.20.0 Apr 30 12:48:19.081221 ignition[1073]: INFO : Stage: umount Apr 30 12:48:19.081221 ignition[1073]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 30 12:48:19.081221 ignition[1073]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 30 12:48:19.081221 ignition[1073]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 30 12:48:19.081221 ignition[1073]: INFO : PUT result: OK Apr 30 12:48:19.053482 systemd[1]: Stopped target timers.target - Timer Units. Apr 30 12:48:19.103460 ignition[1073]: INFO : umount: umount passed Apr 30 12:48:19.103460 ignition[1073]: INFO : Ignition finished successfully Apr 30 12:48:19.053634 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 30 12:48:19.053813 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 30 12:48:19.054283 systemd[1]: Stopped target initrd.target - Initrd Default Target. Apr 30 12:48:19.054597 systemd[1]: Stopped target basic.target - Basic System. Apr 30 12:48:19.054854 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Apr 30 12:48:19.055202 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Apr 30 12:48:19.055357 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Apr 30 12:48:19.055512 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Apr 30 12:48:19.055664 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Apr 30 12:48:19.055995 systemd[1]: Stopped target sysinit.target - System Initialization. Apr 30 12:48:19.056156 systemd[1]: Stopped target local-fs.target - Local File Systems. Apr 30 12:48:19.056293 systemd[1]: Stopped target swap.target - Swaps. Apr 30 12:48:19.056421 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 30 12:48:19.056522 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Apr 30 12:48:19.056945 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Apr 30 12:48:19.057111 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 30 12:48:19.057223 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Apr 30 12:48:19.057309 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 30 12:48:19.057384 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 30 12:48:19.057480 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Apr 30 12:48:19.057885 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 30 12:48:19.057987 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 30 12:48:19.058202 systemd[1]: ignition-files.service: Deactivated successfully. Apr 30 12:48:19.058291 systemd[1]: Stopped ignition-files.service - Ignition (files). Apr 30 12:48:19.059919 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Apr 30 12:48:19.060138 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 30 12:48:19.060245 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Apr 30 12:48:19.061030 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Apr 30 12:48:19.061078 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 30 12:48:19.061175 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Apr 30 12:48:19.061318 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 30 12:48:19.061408 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Apr 30 12:48:19.066153 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 30 12:48:19.066234 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Apr 30 12:48:19.083907 systemd[1]: sysroot-boot.mount: Deactivated successfully. Apr 30 12:48:19.084491 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 30 12:48:19.084576 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Apr 30 12:48:19.089295 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 30 12:48:19.089341 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Apr 30 12:48:19.091446 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 30 12:48:19.091488 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Apr 30 12:48:19.094868 systemd[1]: ignition-fetch.service: Deactivated successfully. Apr 30 12:48:19.094919 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Apr 30 12:48:19.101071 systemd[1]: Stopped target network.target - Network. Apr 30 12:48:19.102443 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 30 12:48:19.102497 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Apr 30 12:48:19.104499 systemd[1]: Stopped target paths.target - Path Units. Apr 30 12:48:19.107262 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 30 12:48:19.107651 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 30 12:48:19.109709 systemd[1]: Stopped target slices.target - Slice Units. Apr 30 12:48:19.114271 systemd[1]: Stopped target sockets.target - Socket Units. Apr 30 12:48:19.117459 systemd[1]: iscsid.socket: Deactivated successfully. Apr 30 12:48:19.117496 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Apr 30 12:48:19.119374 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 30 12:48:19.119407 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 30 12:48:19.132918 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 30 12:48:19.132973 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Apr 30 12:48:19.139444 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Apr 30 12:48:19.139487 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Apr 30 12:48:19.144823 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Apr 30 12:48:19.146932 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Apr 30 12:48:19.148443 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 30 12:48:19.148526 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Apr 30 12:48:19.152592 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 30 12:48:19.152662 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Apr 30 12:48:19.154448 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 30 12:48:19.154535 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Apr 30 12:48:19.159994 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Apr 30 12:48:19.160047 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 30 12:48:19.167849 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 30 12:48:19.167939 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Apr 30 12:48:19.170133 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 30 12:48:19.170179 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Apr 30 12:48:19.187795 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Apr 30 12:48:19.192350 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 30 12:48:19.192426 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 30 12:48:19.194656 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 30 12:48:19.194734 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Apr 30 12:48:19.199025 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 30 12:48:19.199079 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Apr 30 12:48:19.200996 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 30 12:48:19.217336 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 30 12:48:19.217511 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 30 12:48:19.219179 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 30 12:48:19.219217 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Apr 30 12:48:19.223671 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Apr 30 12:48:19.223730 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Apr 30 12:48:19.225809 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 30 12:48:19.225854 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Apr 30 12:48:19.230742 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 30 12:48:19.230789 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Apr 30 12:48:19.236876 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 30 12:48:19.236932 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 30 12:48:19.257102 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Apr 30 12:48:19.258222 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 30 12:48:19.258284 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 30 12:48:19.267566 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 30 12:48:19.381546 systemd-journald[222]: Received SIGTERM from PID 1 (systemd). Apr 30 12:48:19.267611 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 30 12:48:19.270774 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 30 12:48:19.270859 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Apr 30 12:48:19.280028 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 30 12:48:19.280107 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Apr 30 12:48:19.282621 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Apr 30 12:48:19.307017 systemd[1]: Starting initrd-switch-root.service - Switch Root... Apr 30 12:48:19.320515 systemd[1]: Switching root. Apr 30 12:48:19.393035 systemd-journald[222]: Journal stopped Apr 30 12:48:22.154591 kernel: SELinux: policy capability network_peer_controls=1 Apr 30 12:48:22.154692 kernel: SELinux: policy capability open_perms=1 Apr 30 12:48:22.154717 kernel: SELinux: policy capability extended_socket_class=1 Apr 30 12:48:22.154735 kernel: SELinux: policy capability always_check_network=0 Apr 30 12:48:22.154758 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 30 12:48:22.154778 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 30 12:48:22.154796 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 30 12:48:22.154814 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 30 12:48:22.154828 kernel: audit: type=1403 audit(1746017299.781:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 30 12:48:22.154848 systemd[1]: Successfully loaded SELinux policy in 131.812ms. Apr 30 12:48:22.154882 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.673ms. Apr 30 12:48:22.154900 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) Apr 30 12:48:22.154921 systemd[1]: Detected virtualization xen. Apr 30 12:48:22.154936 systemd[1]: Detected architecture x86-64. Apr 30 12:48:22.154955 systemd[1]: Detected first boot. Apr 30 12:48:22.154970 systemd[1]: Initializing machine ID from VM UUID. Apr 30 12:48:22.154990 zram_generator::config[1122]: No configuration found. Apr 30 12:48:22.155019 kernel: Guest personality initialized and is inactive Apr 30 12:48:22.155040 kernel: VMCI host device registered (name=vmci, major=10, minor=124) Apr 30 12:48:22.155062 kernel: Initialized host personality Apr 30 12:48:22.155083 kernel: NET: Registered PF_VSOCK protocol family Apr 30 12:48:22.155119 systemd[1]: Populated /etc with preset unit settings. Apr 30 12:48:22.155147 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Apr 30 12:48:22.155171 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 30 12:48:22.155194 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Apr 30 12:48:22.155218 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 30 12:48:22.155243 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Apr 30 12:48:22.155266 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Apr 30 12:48:22.155293 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Apr 30 12:48:22.155323 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Apr 30 12:48:22.155347 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Apr 30 12:48:22.155371 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Apr 30 12:48:22.155396 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Apr 30 12:48:22.155419 systemd[1]: Created slice user.slice - User and Session Slice. Apr 30 12:48:22.155443 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 30 12:48:22.155470 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 30 12:48:22.155497 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Apr 30 12:48:22.155521 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Apr 30 12:48:22.155544 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Apr 30 12:48:22.155573 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 30 12:48:22.155604 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Apr 30 12:48:22.155628 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 30 12:48:22.155655 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Apr 30 12:48:22.155693 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Apr 30 12:48:22.155721 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Apr 30 12:48:22.155745 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Apr 30 12:48:22.155768 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 30 12:48:22.155790 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 30 12:48:22.155813 systemd[1]: Reached target slices.target - Slice Units. Apr 30 12:48:22.155835 systemd[1]: Reached target swap.target - Swaps. Apr 30 12:48:22.155859 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Apr 30 12:48:22.155889 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Apr 30 12:48:22.155912 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Apr 30 12:48:22.155934 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 30 12:48:22.155957 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 30 12:48:22.155979 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 30 12:48:22.156001 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Apr 30 12:48:22.156024 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Apr 30 12:48:22.156056 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Apr 30 12:48:22.156080 systemd[1]: Mounting media.mount - External Media Directory... Apr 30 12:48:22.156103 systemd[1]: Mounting proc-xen.mount - /proc/xen... Apr 30 12:48:22.156139 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Apr 30 12:48:22.156175 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Apr 30 12:48:22.156203 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Apr 30 12:48:22.156231 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). Apr 30 12:48:22.156247 systemd[1]: Reached target machines.target - Containers. Apr 30 12:48:22.156263 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Apr 30 12:48:22.156279 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 30 12:48:22.156295 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 30 12:48:22.156319 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Apr 30 12:48:22.156337 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 30 12:48:22.156353 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 30 12:48:22.156368 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 30 12:48:22.156383 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Apr 30 12:48:22.156398 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 30 12:48:22.156418 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 30 12:48:22.156433 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 30 12:48:22.156451 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Apr 30 12:48:22.156467 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 30 12:48:22.156482 systemd[1]: Stopped systemd-fsck-usr.service. Apr 30 12:48:22.156498 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). Apr 30 12:48:22.156514 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 30 12:48:22.156529 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 30 12:48:22.156545 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Apr 30 12:48:22.156560 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Apr 30 12:48:22.156587 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Apr 30 12:48:22.156605 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 30 12:48:22.156621 systemd[1]: verity-setup.service: Deactivated successfully. Apr 30 12:48:22.156637 systemd[1]: Stopped verity-setup.service. Apr 30 12:48:22.156653 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 30 12:48:22.156669 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Apr 30 12:48:22.156702 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Apr 30 12:48:22.156743 systemd-journald[1196]: Collecting audit messages is disabled. Apr 30 12:48:22.156779 systemd[1]: Mounted media.mount - External Media Directory. Apr 30 12:48:22.156794 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Apr 30 12:48:22.156810 systemd-journald[1196]: Journal started Apr 30 12:48:22.156838 systemd-journald[1196]: Runtime Journal (/run/log/journal/ec2bb5ffe304bc44b351c4fc56394cac) is 8M, max 641.8M, 633.8M free. Apr 30 12:48:21.941459 systemd[1]: Queued start job for default target multi-user.target. Apr 30 12:48:21.950184 systemd[1]: Unnecessary job was removed for dev-xvda6.device - /dev/xvda6. Apr 30 12:48:21.950595 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 30 12:48:22.159706 systemd[1]: Started systemd-journald.service - Journal Service. Apr 30 12:48:22.160918 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Apr 30 12:48:22.162219 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Apr 30 12:48:22.163478 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 30 12:48:22.163737 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Apr 30 12:48:22.165694 kernel: loop: module loaded Apr 30 12:48:22.165814 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 30 12:48:22.166015 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 30 12:48:22.167773 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 30 12:48:22.168420 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 30 12:48:22.170219 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 30 12:48:22.170423 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 30 12:48:22.172052 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 30 12:48:22.173758 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Apr 30 12:48:22.174802 kernel: fuse: init (API version 7.39) Apr 30 12:48:22.176333 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 30 12:48:22.176490 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Apr 30 12:48:22.187029 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Apr 30 12:48:22.188904 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 30 12:48:22.200822 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Apr 30 12:48:22.203388 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Apr 30 12:48:22.204853 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 30 12:48:22.208817 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Apr 30 12:48:22.211000 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Apr 30 12:48:22.212255 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 30 12:48:22.213299 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Apr 30 12:48:22.215358 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 30 12:48:22.216600 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 30 12:48:22.219973 systemd[1]: Mounted proc-xen.mount - /proc/xen. Apr 30 12:48:22.221434 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Apr 30 12:48:22.221722 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Apr 30 12:48:22.224424 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Apr 30 12:48:22.226013 systemd-journald[1196]: Time spent on flushing to /var/log/journal/ec2bb5ffe304bc44b351c4fc56394cac is 26.381ms for 964 entries. Apr 30 12:48:22.226013 systemd-journald[1196]: System Journal (/var/log/journal/ec2bb5ffe304bc44b351c4fc56394cac) is 8M, max 195.6M, 187.6M free. Apr 30 12:48:22.272774 systemd-journald[1196]: Received client request to flush runtime journal. Apr 30 12:48:22.272855 kernel: ACPI: bus type drm_connector registered Apr 30 12:48:22.228949 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 30 12:48:22.232346 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Apr 30 12:48:22.235063 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Apr 30 12:48:22.238596 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Apr 30 12:48:22.239891 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 30 12:48:22.241210 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Apr 30 12:48:22.244405 systemd[1]: Starting systemd-sysusers.service - Create System Users... Apr 30 12:48:22.248016 systemd[1]: Starting xenserver-pv-version.service - Set fake PV driver version for XenServer... Apr 30 12:48:22.250197 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Apr 30 12:48:22.251833 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Apr 30 12:48:22.253596 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Apr 30 12:48:22.257019 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Apr 30 12:48:22.259650 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Apr 30 12:48:22.271162 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 30 12:48:22.271346 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 30 12:48:22.274337 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Apr 30 12:48:22.300909 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 30 12:48:22.303055 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Apr 30 12:48:22.313078 systemd[1]: Finished systemd-sysusers.service - Create System Users. Apr 30 12:48:22.385018 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 30 12:48:22.386671 systemd[1]: Finished xenserver-pv-version.service - Set fake PV driver version for XenServer. Apr 30 12:48:22.390777 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 30 12:48:22.393347 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Apr 30 12:48:22.393700 kernel: loop0: detected capacity change from 0 to 147912 Apr 30 12:48:22.407237 udevadm[1280]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Apr 30 12:48:22.459937 systemd-tmpfiles[1276]: ACLs are not supported, ignoring. Apr 30 12:48:22.459964 systemd-tmpfiles[1276]: ACLs are not supported, ignoring. Apr 30 12:48:22.465549 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 30 12:48:22.952958 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 30 12:48:22.959076 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Apr 30 12:48:22.972819 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 30 12:48:22.997521 systemd-udevd[1283]: Using default interface naming scheme 'v255'. Apr 30 12:48:23.237011 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 30 12:48:23.252913 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 30 12:48:23.259995 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Apr 30 12:48:23.260078 (udev-worker)[1294]: Network interface NamePolicy= disabled on kernel command line. Apr 30 12:48:23.275710 kernel: BTRFS warning: duplicate device /dev/xvda3 devid 1 generation 40 scanned by (udev-worker) (1289) Apr 30 12:48:23.276877 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Apr 30 12:48:23.282711 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 30 12:48:23.287710 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Apr 30 12:48:23.292190 kernel: ACPI: button: Power Button [PWRF] Apr 30 12:48:23.292268 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input3 Apr 30 12:48:23.292812 kernel: ACPI: button: Sleep Button [SLPF] Apr 30 12:48:23.334048 systemd[1]: Started systemd-userdbd.service - User Database Manager. Apr 30 12:48:23.338702 kernel: piix4_smbus 0000:00:01.3: SMBus base address uninitialized - upgrade BIOS or use force_addr=0xaddr Apr 30 12:48:23.367717 kernel: loop1: detected capacity change from 0 to 62832 Apr 30 12:48:23.379841 kernel: EDAC MC: Ver: 3.0.0 Apr 30 12:48:23.384741 kernel: input: ImPS/2 Generic Wheel Mouse as /devices/platform/i8042/serio1/input/input4 Apr 30 12:48:23.393735 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 30 12:48:23.402713 kernel: mousedev: PS/2 mouse device common for all mice Apr 30 12:48:23.410030 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Apr 30 12:48:23.412359 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 30 12:48:23.419366 systemd-networkd[1295]: lo: Link UP Apr 30 12:48:23.419374 systemd-networkd[1295]: lo: Gained carrier Apr 30 12:48:23.421140 systemd-networkd[1295]: Enumeration completed Apr 30 12:48:23.421263 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 30 12:48:23.421757 systemd-networkd[1295]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 30 12:48:23.421766 systemd-networkd[1295]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 30 12:48:23.423929 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Apr 30 12:48:23.424981 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Apr 30 12:48:23.436879 systemd-networkd[1295]: eth0: Link UP Apr 30 12:48:23.438321 systemd-networkd[1295]: eth0: Gained carrier Apr 30 12:48:23.438347 systemd-networkd[1295]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 30 12:48:23.438696 kernel: ixgbevf 0000:00:03.0: NIC Link is Up 10 Gbps Apr 30 12:48:23.452563 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Apr 30 12:48:23.469740 systemd-networkd[1295]: eth0: DHCPv4 address 172.31.27.168/20, gateway 172.31.16.1 acquired from 172.31.16.1 Apr 30 12:48:23.483108 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Apr 30 12:48:23.496647 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Apr 30 12:48:23.508302 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Apr 30 12:48:23.540703 kernel: loop2: detected capacity change from 0 to 138176 Apr 30 12:48:23.560117 lvm[1348]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 30 12:48:23.630589 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 30 12:48:23.632167 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Apr 30 12:48:23.634040 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 30 12:48:23.649163 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Apr 30 12:48:23.653623 lvm[1353]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 30 12:48:23.688350 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Apr 30 12:48:23.708005 kernel: loop3: detected capacity change from 0 to 147912 Apr 30 12:48:23.744707 kernel: loop4: detected capacity change from 0 to 62832 Apr 30 12:48:23.758221 kernel: loop5: detected capacity change from 0 to 138176 Apr 30 12:48:23.774959 (sd-merge)[1356]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Apr 30 12:48:23.775446 (sd-merge)[1356]: Merged extensions into '/usr'. Apr 30 12:48:23.778424 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Apr 30 12:48:23.794863 systemd[1]: Starting ensure-sysext.service... Apr 30 12:48:23.796664 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 30 12:48:23.800866 systemd[1]: Reload requested from client PID 1358 ('systemctl') (unit ensure-sysext.service)... Apr 30 12:48:23.800886 systemd[1]: Reloading... Apr 30 12:48:23.831617 systemd-tmpfiles[1360]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 30 12:48:23.832042 systemd-tmpfiles[1360]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Apr 30 12:48:23.833603 systemd-tmpfiles[1360]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Apr 30 12:48:23.834052 systemd-tmpfiles[1360]: ACLs are not supported, ignoring. Apr 30 12:48:23.834132 systemd-tmpfiles[1360]: ACLs are not supported, ignoring. Apr 30 12:48:23.843717 zram_generator::config[1390]: No configuration found. Apr 30 12:48:23.855108 systemd-tmpfiles[1360]: Detected autofs mount point /boot during canonicalization of boot. Apr 30 12:48:23.855124 systemd-tmpfiles[1360]: Skipping /boot Apr 30 12:48:23.865619 systemd-tmpfiles[1360]: Detected autofs mount point /boot during canonicalization of boot. Apr 30 12:48:23.865639 systemd-tmpfiles[1360]: Skipping /boot Apr 30 12:48:23.979076 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. Apr 30 12:48:24.034713 systemd[1]: Reloading finished in 233 ms. Apr 30 12:48:24.079487 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 30 12:48:24.088104 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 30 12:48:24.090956 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Apr 30 12:48:24.093305 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Apr 30 12:48:24.096303 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 30 12:48:24.098417 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Apr 30 12:48:24.102672 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 30 12:48:24.103916 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 30 12:48:24.106264 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 30 12:48:24.109010 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 30 12:48:24.110718 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 30 12:48:24.110832 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). Apr 30 12:48:24.112454 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 30 12:48:24.112743 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 30 12:48:24.114560 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 30 12:48:24.114755 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 30 12:48:24.120877 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 30 12:48:24.121083 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 30 12:48:24.128694 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 30 12:48:24.130071 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 30 12:48:24.132156 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 30 12:48:24.134558 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 30 12:48:24.136308 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 30 12:48:24.136495 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). Apr 30 12:48:24.141286 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Apr 30 12:48:24.143332 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 30 12:48:24.143495 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 30 12:48:24.146234 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 30 12:48:24.146461 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 30 12:48:24.148401 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Apr 30 12:48:24.150116 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 30 12:48:24.150267 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 30 12:48:24.162205 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 30 12:48:24.163451 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 30 12:48:24.165572 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 30 12:48:24.167719 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 30 12:48:24.170980 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 30 12:48:24.172325 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 30 12:48:24.172510 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). Apr 30 12:48:24.172818 systemd[1]: Reached target time-set.target - System Time Set. Apr 30 12:48:24.175560 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 30 12:48:24.175744 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 30 12:48:24.177572 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 30 12:48:24.177762 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 30 12:48:24.179356 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 30 12:48:24.179534 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 30 12:48:24.181279 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 30 12:48:24.181439 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 30 12:48:24.185613 systemd[1]: Finished ensure-sysext.service. Apr 30 12:48:24.189648 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 30 12:48:24.189758 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 30 12:48:24.194820 systemd-resolved[1444]: Positive Trust Anchors: Apr 30 12:48:24.194833 systemd-resolved[1444]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 30 12:48:24.194871 systemd-resolved[1444]: 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 Apr 30 12:48:24.199901 systemd-resolved[1444]: Defaulting to hostname 'linux'. Apr 30 12:48:24.202214 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 30 12:48:24.203608 systemd[1]: Reached target network.target - Network. Apr 30 12:48:24.204711 augenrules[1489]: No rules Apr 30 12:48:24.204629 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 30 12:48:24.206056 systemd[1]: audit-rules.service: Deactivated successfully. Apr 30 12:48:24.206250 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 30 12:48:24.358216 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Apr 30 12:48:24.359792 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). Apr 30 12:48:24.545830 ldconfig[1258]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 30 12:48:24.552873 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Apr 30 12:48:24.569889 systemd[1]: Starting systemd-update-done.service - Update is Completed... Apr 30 12:48:24.579920 systemd[1]: Finished systemd-update-done.service - Update is Completed. Apr 30 12:48:24.581269 systemd[1]: Reached target sysinit.target - System Initialization. Apr 30 12:48:24.582896 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Apr 30 12:48:24.584126 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Apr 30 12:48:24.585490 systemd[1]: Started logrotate.timer - Daily rotation of log files. Apr 30 12:48:24.590045 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Apr 30 12:48:24.591265 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Apr 30 12:48:24.592497 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 30 12:48:24.592545 systemd[1]: Reached target paths.target - Path Units. Apr 30 12:48:24.593407 systemd[1]: Reached target timers.target - Timer Units. Apr 30 12:48:24.601079 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Apr 30 12:48:24.603520 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 30 12:48:24.606620 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Apr 30 12:48:24.608072 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Apr 30 12:48:24.609345 systemd[1]: Reached target ssh-access.target - SSH Access Available. Apr 30 12:48:24.612227 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Apr 30 12:48:24.618148 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Apr 30 12:48:24.621746 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 30 12:48:24.622905 systemd[1]: Reached target sockets.target - Socket Units. Apr 30 12:48:24.623876 systemd[1]: Reached target basic.target - Basic System. Apr 30 12:48:24.624860 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Apr 30 12:48:24.624893 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Apr 30 12:48:24.625867 systemd[1]: Starting containerd.service - containerd container runtime... Apr 30 12:48:24.628168 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Apr 30 12:48:24.630565 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Apr 30 12:48:24.632777 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Apr 30 12:48:24.634760 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Apr 30 12:48:24.635862 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). Apr 30 12:48:24.637147 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Apr 30 12:48:24.640015 systemd[1]: Started ntpd.service - Network Time Service. Apr 30 12:48:24.642136 systemd[1]: Starting setup-oem.service - Setup OEM... Apr 30 12:48:24.643529 jq[1504]: false Apr 30 12:48:24.644064 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Apr 30 12:48:24.646582 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Apr 30 12:48:24.650787 systemd[1]: Starting systemd-logind.service - User Login Management... Apr 30 12:48:24.653082 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 30 12:48:24.653599 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Apr 30 12:48:24.654160 systemd[1]: Starting update-engine.service - Update Engine... Apr 30 12:48:24.657607 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Apr 30 12:48:24.661923 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 30 12:48:24.662186 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Apr 30 12:48:24.663327 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 30 12:48:24.663589 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Apr 30 12:48:24.667517 extend-filesystems[1505]: Found loop3 Apr 30 12:48:24.670126 extend-filesystems[1505]: Found loop4 Apr 30 12:48:24.670126 extend-filesystems[1505]: Found loop5 Apr 30 12:48:24.670126 extend-filesystems[1505]: Found xvda Apr 30 12:48:24.670126 extend-filesystems[1505]: Found xvda1 Apr 30 12:48:24.670126 extend-filesystems[1505]: Found xvda2 Apr 30 12:48:24.670126 extend-filesystems[1505]: Found xvda3 Apr 30 12:48:24.670126 extend-filesystems[1505]: Found usr Apr 30 12:48:24.670126 extend-filesystems[1505]: Found xvda4 Apr 30 12:48:24.670126 extend-filesystems[1505]: Found xvda6 Apr 30 12:48:24.670126 extend-filesystems[1505]: Found xvda7 Apr 30 12:48:24.670126 extend-filesystems[1505]: Found xvda9 Apr 30 12:48:24.670126 extend-filesystems[1505]: Checking size of /dev/xvda9 Apr 30 12:48:24.684374 jq[1515]: true Apr 30 12:48:24.673405 systemd[1]: motdgen.service: Deactivated successfully. Apr 30 12:48:24.673642 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Apr 30 12:48:24.685404 (ntainerd)[1533]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 30 12:48:24.687589 jq[1532]: true Apr 30 12:48:24.689882 extend-filesystems[1505]: Resized partition /dev/xvda9 Apr 30 12:48:24.692886 update_engine[1514]: I20250430 12:48:24.692783 1514 main.cc:92] Flatcar Update Engine starting Apr 30 12:48:24.695844 systemd[1]: Finished setup-oem.service - Setup OEM. Apr 30 12:48:24.703707 kernel: BTRFS warning: duplicate device /dev/xvda3 devid 1 generation 40 scanned by (udev-worker) (1324) Apr 30 12:48:24.729912 systemd-logind[1512]: Watching system buttons on /dev/input/event1 (Power Button) Apr 30 12:48:24.729936 systemd-logind[1512]: Watching system buttons on /dev/input/event2 (Sleep Button) Apr 30 12:48:24.729953 systemd-logind[1512]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Apr 30 12:48:24.730162 systemd-logind[1512]: New seat seat0. Apr 30 12:48:24.732809 systemd[1]: Started systemd-logind.service - User Login Management. Apr 30 12:48:24.737354 dbus-daemon[1503]: [system] SELinux support is enabled Apr 30 12:48:24.737546 systemd[1]: Started dbus.service - D-Bus System Message Bus. Apr 30 12:48:24.738022 coreos-metadata[1502]: Apr 30 12:48:24.737 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Apr 30 12:48:24.740703 coreos-metadata[1502]: Apr 30 12:48:24.739 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Apr 30 12:48:24.740703 coreos-metadata[1502]: Apr 30 12:48:24.739 INFO Fetch successful Apr 30 12:48:24.740703 coreos-metadata[1502]: Apr 30 12:48:24.739 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Apr 30 12:48:24.740703 coreos-metadata[1502]: Apr 30 12:48:24.740 INFO Fetch successful Apr 30 12:48:24.740703 coreos-metadata[1502]: Apr 30 12:48:24.740 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Apr 30 12:48:24.739978 dbus-daemon[1503]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1295 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Apr 30 12:48:24.741025 coreos-metadata[1502]: Apr 30 12:48:24.740 INFO Fetch successful Apr 30 12:48:24.741025 coreos-metadata[1502]: Apr 30 12:48:24.740 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Apr 30 12:48:24.741127 update_engine[1514]: I20250430 12:48:24.741003 1514 update_check_scheduler.cc:74] Next update check in 3m30s Apr 30 12:48:24.741516 coreos-metadata[1502]: Apr 30 12:48:24.741 INFO Fetch successful Apr 30 12:48:24.741556 coreos-metadata[1502]: Apr 30 12:48:24.741 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Apr 30 12:48:24.742061 coreos-metadata[1502]: Apr 30 12:48:24.742 INFO Fetch failed with 404: resource not found Apr 30 12:48:24.742092 coreos-metadata[1502]: Apr 30 12:48:24.742 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Apr 30 12:48:24.742259 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). Apr 30 12:48:24.742305 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Apr 30 12:48:24.742579 coreos-metadata[1502]: Apr 30 12:48:24.742 INFO Fetch successful Apr 30 12:48:24.742579 coreos-metadata[1502]: Apr 30 12:48:24.742 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Apr 30 12:48:24.743064 coreos-metadata[1502]: Apr 30 12:48:24.743 INFO Fetch successful Apr 30 12:48:24.743064 coreos-metadata[1502]: Apr 30 12:48:24.743 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Apr 30 12:48:24.743073 dbus-daemon[1503]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 30 12:48:24.743710 coreos-metadata[1502]: Apr 30 12:48:24.743 INFO Fetch successful Apr 30 12:48:24.743778 coreos-metadata[1502]: Apr 30 12:48:24.743 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Apr 30 12:48:24.743753 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). Apr 30 12:48:24.743777 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Apr 30 12:48:24.744230 coreos-metadata[1502]: Apr 30 12:48:24.744 INFO Fetch successful Apr 30 12:48:24.744230 coreos-metadata[1502]: Apr 30 12:48:24.744 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Apr 30 12:48:24.744737 coreos-metadata[1502]: Apr 30 12:48:24.744 INFO Fetch successful Apr 30 12:48:24.745182 systemd[1]: Started update-engine.service - Update Engine. Apr 30 12:48:24.806003 ntpd[1507]: ntpd 4.2.8p17@1.4004-o Tue Apr 29 21:38:46 UTC 2025 (1): Starting Apr 30 12:48:24.949068 kernel: EXT4-fs (xvda9): resizing filesystem from 553472 to 1489915 blocks Apr 30 12:48:24.949139 kernel: EXT4-fs (xvda9): resized filesystem to 1489915 Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: ntpd 4.2.8p17@1.4004-o Tue Apr 29 21:38:46 UTC 2025 (1): Starting Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: ---------------------------------------------------- Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: ntp-4 is maintained by Network Time Foundation, Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: corporation. Support and training for ntp-4 are Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: available at https://www.nwtime.org/support Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: ---------------------------------------------------- Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: proto: precision = 0.626 usec (-21) Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: basedate set to 2025-04-17 Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: gps base set to 2025-04-20 (week 2363) Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: Listen and drop on 0 v6wildcard [::]:123 Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: Listen normally on 2 lo 127.0.0.1:123 Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: Listen normally on 3 eth0 172.31.27.168:123 Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: Listen normally on 4 lo [::1]:123 Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: bind(21) AF_INET6 fe80::44f:82ff:fedc:8557%2#123 flags 0x11 failed: Cannot assign requested address Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: unable to create socket on eth0 (5) for fe80::44f:82ff:fedc:8557%2#123 Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: failed to init interface for address fe80::44f:82ff:fedc:8557%2 Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: Listening on routing socket on fd #21 for interface updates Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 30 12:48:24.949199 ntpd[1507]: 30 Apr 12:48:24 ntpd[1507]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 30 12:48:24.950175 sshd_keygen[1522]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 30 12:48:24.806046 ntpd[1507]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Apr 30 12:48:24.950483 bash[1568]: Updated "/home/core/.ssh/authorized_keys" Apr 30 12:48:24.950639 extend-filesystems[1555]: resize2fs 1.47.1 (20-May-2024) Apr 30 12:48:24.950639 extend-filesystems[1555]: Filesystem at /dev/xvda9 is mounted on /; on-line resizing required Apr 30 12:48:24.950639 extend-filesystems[1555]: old_desc_blocks = 1, new_desc_blocks = 1 Apr 30 12:48:24.950639 extend-filesystems[1555]: The filesystem on /dev/xvda9 is now 1489915 (4k) blocks long. Apr 30 12:48:24.949093 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Apr 30 12:48:24.806057 ntpd[1507]: ---------------------------------------------------- Apr 30 12:48:24.958527 extend-filesystems[1505]: Resized filesystem in /dev/xvda9 Apr 30 12:48:24.951560 systemd[1]: Started locksmithd.service - Cluster reboot manager. Apr 30 12:48:24.806067 ntpd[1507]: ntp-4 is maintained by Network Time Foundation, Apr 30 12:48:24.954437 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 30 12:48:24.806077 ntpd[1507]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Apr 30 12:48:24.954703 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Apr 30 12:48:24.806087 ntpd[1507]: corporation. Support and training for ntp-4 are Apr 30 12:48:24.958918 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Apr 30 12:48:24.806097 ntpd[1507]: available at https://www.nwtime.org/support Apr 30 12:48:24.806107 ntpd[1507]: ---------------------------------------------------- Apr 30 12:48:24.808889 ntpd[1507]: proto: precision = 0.626 usec (-21) Apr 30 12:48:24.809826 ntpd[1507]: basedate set to 2025-04-17 Apr 30 12:48:24.809844 ntpd[1507]: gps base set to 2025-04-20 (week 2363) Apr 30 12:48:24.811932 ntpd[1507]: Listen and drop on 0 v6wildcard [::]:123 Apr 30 12:48:24.811974 ntpd[1507]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 30 12:48:24.812217 ntpd[1507]: Listen normally on 2 lo 127.0.0.1:123 Apr 30 12:48:24.812255 ntpd[1507]: Listen normally on 3 eth0 172.31.27.168:123 Apr 30 12:48:24.812302 ntpd[1507]: Listen normally on 4 lo [::1]:123 Apr 30 12:48:24.812341 ntpd[1507]: bind(21) AF_INET6 fe80::44f:82ff:fedc:8557%2#123 flags 0x11 failed: Cannot assign requested address Apr 30 12:48:24.812359 ntpd[1507]: unable to create socket on eth0 (5) for fe80::44f:82ff:fedc:8557%2#123 Apr 30 12:48:24.812379 ntpd[1507]: failed to init interface for address fe80::44f:82ff:fedc:8557%2 Apr 30 12:48:24.812408 ntpd[1507]: Listening on routing socket on fd #21 for interface updates Apr 30 12:48:24.813816 ntpd[1507]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 30 12:48:24.813843 ntpd[1507]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 30 12:48:24.965078 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Apr 30 12:48:24.969989 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Apr 30 12:48:24.977779 systemd[1]: Starting issuegen.service - Generate /run/issue... Apr 30 12:48:24.978962 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Apr 30 12:48:24.980420 systemd[1]: Starting sshkeys.service... Apr 30 12:48:24.988513 systemd[1]: issuegen.service: Deactivated successfully. Apr 30 12:48:24.988762 systemd[1]: Finished issuegen.service - Generate /run/issue. Apr 30 12:48:24.993441 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Apr 30 12:48:24.998089 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Apr 30 12:48:25.001060 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Apr 30 12:48:25.011971 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Apr 30 12:48:25.015370 systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 30 12:48:25.017769 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Apr 30 12:48:25.019289 systemd[1]: Reached target getty.target - Login Prompts. Apr 30 12:48:25.024698 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Apr 30 12:48:25.026060 dbus-daemon[1503]: [system] Successfully activated service 'org.freedesktop.hostname1' Apr 30 12:48:25.026754 dbus-daemon[1503]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1553 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Apr 30 12:48:25.030494 systemd[1]: Starting polkit.service - Authorization Manager... Apr 30 12:48:25.048371 coreos-metadata[1592]: Apr 30 12:48:25.048 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Apr 30 12:48:25.049278 coreos-metadata[1592]: Apr 30 12:48:25.049 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Apr 30 12:48:25.049853 coreos-metadata[1592]: Apr 30 12:48:25.049 INFO Fetch successful Apr 30 12:48:25.049853 coreos-metadata[1592]: Apr 30 12:48:25.049 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Apr 30 12:48:25.050421 coreos-metadata[1592]: Apr 30 12:48:25.050 INFO Fetch successful Apr 30 12:48:25.057022 polkitd[1599]: Started polkitd version 121 Apr 30 12:48:25.066554 unknown[1592]: wrote ssh authorized keys file for user: core Apr 30 12:48:25.068112 polkitd[1599]: Loading rules from directory /etc/polkit-1/rules.d Apr 30 12:48:25.068166 polkitd[1599]: Loading rules from directory /usr/share/polkit-1/rules.d Apr 30 12:48:25.068653 polkitd[1599]: Finished loading, compiling and executing 2 rules Apr 30 12:48:25.069099 dbus-daemon[1503]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 30 12:48:25.069311 systemd[1]: Started polkit.service - Authorization Manager. Apr 30 12:48:25.069344 polkitd[1599]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Apr 30 12:48:25.097470 systemd-hostnamed[1553]: Hostname set to (transient) Apr 30 12:48:25.097476 systemd-resolved[1444]: System hostname changed to 'ip-172-31-27-168'. Apr 30 12:48:25.099440 locksmithd[1576]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 30 12:48:25.112964 update-ssh-keys[1608]: Updated "/home/core/.ssh/authorized_keys" Apr 30 12:48:25.114177 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Apr 30 12:48:25.117162 systemd[1]: Finished sshkeys.service. Apr 30 12:48:25.318819 systemd-networkd[1295]: eth0: Gained IPv6LL Apr 30 12:48:25.321073 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Apr 30 12:48:25.323765 systemd[1]: Reached target network-online.target - Network is Online. Apr 30 12:48:25.339091 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Apr 30 12:48:25.341941 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Apr 30 12:48:25.365960 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Apr 30 12:48:25.406632 amazon-ssm-agent[1622]: Initializing new seelog logger Apr 30 12:48:25.406987 amazon-ssm-agent[1622]: New Seelog Logger Creation Complete Apr 30 12:48:25.406987 amazon-ssm-agent[1622]: 2025/04/30 12:48:25 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 30 12:48:25.406987 amazon-ssm-agent[1622]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 30 12:48:25.407097 amazon-ssm-agent[1622]: 2025/04/30 12:48:25 processing appconfig overrides Apr 30 12:48:25.407366 amazon-ssm-agent[1622]: 2025/04/30 12:48:25 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 30 12:48:25.407366 amazon-ssm-agent[1622]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 30 12:48:25.407454 amazon-ssm-agent[1622]: 2025/04/30 12:48:25 processing appconfig overrides Apr 30 12:48:25.407569 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO Proxy environment variables: Apr 30 12:48:25.407741 amazon-ssm-agent[1622]: 2025/04/30 12:48:25 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 30 12:48:25.407741 amazon-ssm-agent[1622]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 30 12:48:25.407810 amazon-ssm-agent[1622]: 2025/04/30 12:48:25 processing appconfig overrides Apr 30 12:48:25.409963 amazon-ssm-agent[1622]: 2025/04/30 12:48:25 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 30 12:48:25.409963 amazon-ssm-agent[1622]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 30 12:48:25.410076 amazon-ssm-agent[1622]: 2025/04/30 12:48:25 processing appconfig overrides Apr 30 12:48:25.507664 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO https_proxy: Apr 30 12:48:25.522789 containerd[1533]: time="2025-04-30T12:48:25.522498459Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Apr 30 12:48:25.543844 containerd[1533]: time="2025-04-30T12:48:25.543800049Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Apr 30 12:48:25.545374 containerd[1533]: time="2025-04-30T12:48:25.545331374Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.88-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Apr 30 12:48:25.545374 containerd[1533]: time="2025-04-30T12:48:25.545362186Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Apr 30 12:48:25.545374 containerd[1533]: time="2025-04-30T12:48:25.545378425Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Apr 30 12:48:25.545538 containerd[1533]: time="2025-04-30T12:48:25.545520248Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Apr 30 12:48:25.545572 containerd[1533]: time="2025-04-30T12:48:25.545538985Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Apr 30 12:48:25.545602 containerd[1533]: time="2025-04-30T12:48:25.545587512Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Apr 30 12:48:25.545630 containerd[1533]: time="2025-04-30T12:48:25.545601253Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Apr 30 12:48:25.545818 containerd[1533]: time="2025-04-30T12:48:25.545797277Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 Apr 30 12:48:25.545818 containerd[1533]: time="2025-04-30T12:48:25.545815537Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Apr 30 12:48:25.545876 containerd[1533]: time="2025-04-30T12:48:25.545828688Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Apr 30 12:48:25.545876 containerd[1533]: time="2025-04-30T12:48:25.545839556Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Apr 30 12:48:25.545928 containerd[1533]: time="2025-04-30T12:48:25.545903456Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Apr 30 12:48:25.546114 containerd[1533]: time="2025-04-30T12:48:25.546095464Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Apr 30 12:48:25.546240 containerd[1533]: time="2025-04-30T12:48:25.546220965Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Apr 30 12:48:25.546270 containerd[1533]: time="2025-04-30T12:48:25.546239476Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Apr 30 12:48:25.546318 containerd[1533]: time="2025-04-30T12:48:25.546302674Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Apr 30 12:48:25.546361 containerd[1533]: time="2025-04-30T12:48:25.546345079Z" level=info msg="metadata content store policy set" policy=shared Apr 30 12:48:25.557641 containerd[1533]: time="2025-04-30T12:48:25.557597284Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Apr 30 12:48:25.557730 containerd[1533]: time="2025-04-30T12:48:25.557650068Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Apr 30 12:48:25.557730 containerd[1533]: time="2025-04-30T12:48:25.557667048Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Apr 30 12:48:25.557730 containerd[1533]: time="2025-04-30T12:48:25.557700065Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Apr 30 12:48:25.557730 containerd[1533]: time="2025-04-30T12:48:25.557720429Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Apr 30 12:48:25.557879 containerd[1533]: time="2025-04-30T12:48:25.557856584Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Apr 30 12:48:25.558106 containerd[1533]: time="2025-04-30T12:48:25.558085144Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Apr 30 12:48:25.558194 containerd[1533]: time="2025-04-30T12:48:25.558173598Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Apr 30 12:48:25.558223 containerd[1533]: time="2025-04-30T12:48:25.558192479Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Apr 30 12:48:25.558223 containerd[1533]: time="2025-04-30T12:48:25.558208679Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Apr 30 12:48:25.558272 containerd[1533]: time="2025-04-30T12:48:25.558223005Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Apr 30 12:48:25.558272 containerd[1533]: time="2025-04-30T12:48:25.558236239Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Apr 30 12:48:25.558272 containerd[1533]: time="2025-04-30T12:48:25.558248658Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Apr 30 12:48:25.558272 containerd[1533]: time="2025-04-30T12:48:25.558265573Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Apr 30 12:48:25.558367 containerd[1533]: time="2025-04-30T12:48:25.558280466Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Apr 30 12:48:25.558367 containerd[1533]: time="2025-04-30T12:48:25.558294991Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Apr 30 12:48:25.558367 containerd[1533]: time="2025-04-30T12:48:25.558307343Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Apr 30 12:48:25.558367 containerd[1533]: time="2025-04-30T12:48:25.558319784Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Apr 30 12:48:25.558367 containerd[1533]: time="2025-04-30T12:48:25.558338646Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558367 containerd[1533]: time="2025-04-30T12:48:25.558352093Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558367 containerd[1533]: time="2025-04-30T12:48:25.558363628Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558382650Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558395910Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558408724Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558420339Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558432870Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558444938Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558458591Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558470060Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558482147Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558495341Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558509756Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558529677Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558541982Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558613 containerd[1533]: time="2025-04-30T12:48:25.558556823Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Apr 30 12:48:25.558951 containerd[1533]: time="2025-04-30T12:48:25.558599848Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Apr 30 12:48:25.558951 containerd[1533]: time="2025-04-30T12:48:25.558617263Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Apr 30 12:48:25.558951 containerd[1533]: time="2025-04-30T12:48:25.558628328Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Apr 30 12:48:25.558951 containerd[1533]: time="2025-04-30T12:48:25.558645770Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Apr 30 12:48:25.558951 containerd[1533]: time="2025-04-30T12:48:25.558655489Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.558951 containerd[1533]: time="2025-04-30T12:48:25.558671081Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Apr 30 12:48:25.558951 containerd[1533]: time="2025-04-30T12:48:25.558707158Z" level=info msg="NRI interface is disabled by configuration." Apr 30 12:48:25.558951 containerd[1533]: time="2025-04-30T12:48:25.558718791Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Apr 30 12:48:25.559145 containerd[1533]: time="2025-04-30T12:48:25.558974215Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} 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}" Apr 30 12:48:25.559145 containerd[1533]: time="2025-04-30T12:48:25.559017200Z" level=info msg="Connect containerd service" Apr 30 12:48:25.559145 containerd[1533]: time="2025-04-30T12:48:25.559047018Z" level=info msg="using legacy CRI server" Apr 30 12:48:25.559145 containerd[1533]: time="2025-04-30T12:48:25.559054436Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 30 12:48:25.559356 containerd[1533]: time="2025-04-30T12:48:25.559165703Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Apr 30 12:48:25.561052 containerd[1533]: time="2025-04-30T12:48:25.560946677Z" 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" Apr 30 12:48:25.561145 containerd[1533]: time="2025-04-30T12:48:25.561108661Z" level=info msg="Start subscribing containerd event" Apr 30 12:48:25.561192 containerd[1533]: time="2025-04-30T12:48:25.561165789Z" level=info msg="Start recovering state" Apr 30 12:48:25.561318 containerd[1533]: time="2025-04-30T12:48:25.561281293Z" level=info msg="Start event monitor" Apr 30 12:48:25.561471 containerd[1533]: time="2025-04-30T12:48:25.561440193Z" level=info msg="Start snapshots syncer" Apr 30 12:48:25.561519 containerd[1533]: time="2025-04-30T12:48:25.561477195Z" level=info msg="Start cni network conf syncer for default" Apr 30 12:48:25.561519 containerd[1533]: time="2025-04-30T12:48:25.561492834Z" level=info msg="Start streaming server" Apr 30 12:48:25.561627 containerd[1533]: time="2025-04-30T12:48:25.561603244Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 30 12:48:25.561704 containerd[1533]: time="2025-04-30T12:48:25.561666364Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 30 12:48:25.561777 containerd[1533]: time="2025-04-30T12:48:25.561758558Z" level=info msg="containerd successfully booted in 0.040105s" Apr 30 12:48:25.561857 systemd[1]: Started containerd.service - containerd container runtime. Apr 30 12:48:25.564342 systemd[1]: Reached target multi-user.target - Multi-User System. Apr 30 12:48:25.566899 systemd[1]: Startup finished in 819ms (kernel) + 5.997s (initrd) + 5.915s (userspace) = 12.732s. Apr 30 12:48:25.605388 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO http_proxy: Apr 30 12:48:25.704103 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO no_proxy: Apr 30 12:48:25.802384 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO Checking if agent identity type OnPrem can be assumed Apr 30 12:48:25.900905 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO Checking if agent identity type EC2 can be assumed Apr 30 12:48:25.999300 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO Agent will take identity from EC2 Apr 30 12:48:26.029479 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 30 12:48:26.029479 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 30 12:48:26.029479 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 30 12:48:26.029479 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Apr 30 12:48:26.029479 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [amazon-ssm-agent] OS: linux, Arch: amd64 Apr 30 12:48:26.029479 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [amazon-ssm-agent] Starting Core Agent Apr 30 12:48:26.029479 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [amazon-ssm-agent] registrar detected. Attempting registration Apr 30 12:48:26.029795 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [Registrar] Starting registrar module Apr 30 12:48:26.029795 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Apr 30 12:48:26.029795 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [EC2Identity] EC2 registration was successful. Apr 30 12:48:26.029795 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [CredentialRefresher] credentialRefresher has started Apr 30 12:48:26.029795 amazon-ssm-agent[1622]: 2025-04-30 12:48:25 INFO [CredentialRefresher] Starting credentials refresher loop Apr 30 12:48:26.029795 amazon-ssm-agent[1622]: 2025-04-30 12:48:26 INFO EC2RoleProvider Successfully connected with instance profile role credentials Apr 30 12:48:26.098255 amazon-ssm-agent[1622]: 2025-04-30 12:48:26 INFO [CredentialRefresher] Next credential rotation will be in 31.749994609333335 minutes Apr 30 12:48:27.044718 amazon-ssm-agent[1622]: 2025-04-30 12:48:27 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Apr 30 12:48:27.145969 amazon-ssm-agent[1622]: 2025-04-30 12:48:27 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:1657) started Apr 30 12:48:27.214403 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Apr 30 12:48:27.215593 systemd[1]: Started sshd@0-172.31.27.168:22-147.75.109.163:45592.service - OpenSSH per-connection server daemon (147.75.109.163:45592). Apr 30 12:48:27.246375 amazon-ssm-agent[1622]: 2025-04-30 12:48:27 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Apr 30 12:48:27.518048 sshd[1672]: Accepted publickey for core from 147.75.109.163 port 45592 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:27.520513 sshd-session[1672]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:27.531694 systemd-logind[1512]: New session 1 of user core. Apr 30 12:48:27.532756 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Apr 30 12:48:27.544254 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Apr 30 12:48:27.555746 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Apr 30 12:48:27.558516 systemd[1]: Starting user@500.service - User Manager for UID 500... Apr 30 12:48:27.566414 (systemd)[1676]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Apr 30 12:48:27.568450 systemd-logind[1512]: New session c1 of user core. Apr 30 12:48:27.669797 systemd[1676]: Queued start job for default target default.target. Apr 30 12:48:27.678639 systemd[1676]: Created slice app.slice - User Application Slice. Apr 30 12:48:27.678674 systemd[1676]: Reached target paths.target - Paths. Apr 30 12:48:27.678742 systemd[1676]: Reached target timers.target - Timers. Apr 30 12:48:27.679945 systemd[1676]: Starting dbus.socket - D-Bus User Message Bus Socket... Apr 30 12:48:27.691552 systemd[1676]: Listening on dbus.socket - D-Bus User Message Bus Socket. Apr 30 12:48:27.691675 systemd[1676]: Reached target sockets.target - Sockets. Apr 30 12:48:27.691744 systemd[1676]: Reached target basic.target - Basic System. Apr 30 12:48:27.691790 systemd[1676]: Reached target default.target - Main User Target. Apr 30 12:48:27.691819 systemd[1676]: Startup finished in 117ms. Apr 30 12:48:27.691874 systemd[1]: Started user@500.service - User Manager for UID 500. Apr 30 12:48:27.693331 systemd[1]: Started session-1.scope - Session 1 of User core. Apr 30 12:48:27.806910 ntpd[1507]: Listen normally on 6 eth0 [fe80::44f:82ff:fedc:8557%2]:123 Apr 30 12:48:27.807253 ntpd[1507]: 30 Apr 12:48:27 ntpd[1507]: Listen normally on 6 eth0 [fe80::44f:82ff:fedc:8557%2]:123 Apr 30 12:48:27.899095 systemd[1]: Started sshd@1-172.31.27.168:22-147.75.109.163:45598.service - OpenSSH per-connection server daemon (147.75.109.163:45598). Apr 30 12:48:28.149133 sshd[1687]: Accepted publickey for core from 147.75.109.163 port 45598 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:28.150794 sshd-session[1687]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:28.154959 systemd-logind[1512]: New session 2 of user core. Apr 30 12:48:28.169859 systemd[1]: Started session-2.scope - Session 2 of User core. Apr 30 12:48:28.340604 sshd[1689]: Connection closed by 147.75.109.163 port 45598 Apr 30 12:48:28.340937 sshd-session[1687]: pam_unix(sshd:session): session closed for user core Apr 30 12:48:28.344455 systemd[1]: sshd@1-172.31.27.168:22-147.75.109.163:45598.service: Deactivated successfully. Apr 30 12:48:28.346048 systemd[1]: session-2.scope: Deactivated successfully. Apr 30 12:48:28.347345 systemd-logind[1512]: Session 2 logged out. Waiting for processes to exit. Apr 30 12:48:28.348449 systemd-logind[1512]: Removed session 2. Apr 30 12:48:28.394723 systemd[1]: Started sshd@2-172.31.27.168:22-147.75.109.163:45612.service - OpenSSH per-connection server daemon (147.75.109.163:45612). Apr 30 12:48:28.647279 sshd[1695]: Accepted publickey for core from 147.75.109.163 port 45612 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:28.648519 sshd-session[1695]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:28.653385 systemd-logind[1512]: New session 3 of user core. Apr 30 12:48:28.662950 systemd[1]: Started session-3.scope - Session 3 of User core. Apr 30 12:48:28.836314 sshd[1697]: Connection closed by 147.75.109.163 port 45612 Apr 30 12:48:28.836672 sshd-session[1695]: pam_unix(sshd:session): session closed for user core Apr 30 12:48:28.839773 systemd[1]: sshd@2-172.31.27.168:22-147.75.109.163:45612.service: Deactivated successfully. Apr 30 12:48:28.841751 systemd[1]: session-3.scope: Deactivated successfully. Apr 30 12:48:28.842321 systemd-logind[1512]: Session 3 logged out. Waiting for processes to exit. Apr 30 12:48:28.843921 systemd-logind[1512]: Removed session 3. Apr 30 12:48:28.882489 systemd[1]: Started sshd@3-172.31.27.168:22-147.75.109.163:45628.service - OpenSSH per-connection server daemon (147.75.109.163:45628). Apr 30 12:48:29.134991 sshd[1704]: Accepted publickey for core from 147.75.109.163 port 45628 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:29.136192 sshd-session[1704]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:29.141208 systemd-logind[1512]: New session 4 of user core. Apr 30 12:48:29.151806 systemd[1]: Started session-4.scope - Session 4 of User core. Apr 30 12:48:29.326831 sshd[1706]: Connection closed by 147.75.109.163 port 45628 Apr 30 12:48:29.327183 sshd-session[1704]: pam_unix(sshd:session): session closed for user core Apr 30 12:48:29.330310 systemd[1]: sshd@3-172.31.27.168:22-147.75.109.163:45628.service: Deactivated successfully. Apr 30 12:48:29.331916 systemd[1]: session-4.scope: Deactivated successfully. Apr 30 12:48:29.332497 systemd-logind[1512]: Session 4 logged out. Waiting for processes to exit. Apr 30 12:48:29.333673 systemd-logind[1512]: Removed session 4. Apr 30 12:48:29.382974 systemd[1]: Started sshd@4-172.31.27.168:22-147.75.109.163:45638.service - OpenSSH per-connection server daemon (147.75.109.163:45638). Apr 30 12:48:29.637490 sshd[1712]: Accepted publickey for core from 147.75.109.163 port 45638 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:29.638772 sshd-session[1712]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:29.643464 systemd-logind[1512]: New session 5 of user core. Apr 30 12:48:29.657833 systemd[1]: Started session-5.scope - Session 5 of User core. Apr 30 12:48:29.893391 sudo[1715]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Apr 30 12:48:29.893665 sudo[1715]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 30 12:48:29.909762 sudo[1715]: pam_unix(sudo:session): session closed for user root Apr 30 12:48:29.947000 sshd[1714]: Connection closed by 147.75.109.163 port 45638 Apr 30 12:48:29.947471 sshd-session[1712]: pam_unix(sshd:session): session closed for user core Apr 30 12:48:29.950815 systemd[1]: sshd@4-172.31.27.168:22-147.75.109.163:45638.service: Deactivated successfully. Apr 30 12:48:29.952767 systemd[1]: session-5.scope: Deactivated successfully. Apr 30 12:48:29.953399 systemd-logind[1512]: Session 5 logged out. Waiting for processes to exit. Apr 30 12:48:29.954621 systemd-logind[1512]: Removed session 5. Apr 30 12:48:30.001664 systemd[1]: Started sshd@5-172.31.27.168:22-147.75.109.163:45646.service - OpenSSH per-connection server daemon (147.75.109.163:45646). Apr 30 12:48:30.255340 sshd[1721]: Accepted publickey for core from 147.75.109.163 port 45646 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:30.256918 sshd-session[1721]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:30.261114 systemd-logind[1512]: New session 6 of user core. Apr 30 12:48:30.272868 systemd[1]: Started session-6.scope - Session 6 of User core. Apr 30 12:48:30.411882 sudo[1725]: 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 Apr 30 12:48:30.412156 sudo[1725]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 30 12:48:30.415223 sudo[1725]: pam_unix(sudo:session): session closed for user root Apr 30 12:48:30.420404 sudo[1724]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Apr 30 12:48:30.420668 sudo[1724]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 30 12:48:30.443803 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 30 12:48:30.472733 augenrules[1747]: No rules Apr 30 12:48:30.473860 systemd[1]: audit-rules.service: Deactivated successfully. Apr 30 12:48:30.474520 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 30 12:48:30.475373 sudo[1724]: pam_unix(sudo:session): session closed for user root Apr 30 12:48:30.512464 sshd[1723]: Connection closed by 147.75.109.163 port 45646 Apr 30 12:48:30.512768 sshd-session[1721]: pam_unix(sshd:session): session closed for user core Apr 30 12:48:30.516320 systemd[1]: sshd@5-172.31.27.168:22-147.75.109.163:45646.service: Deactivated successfully. Apr 30 12:48:30.518310 systemd[1]: session-6.scope: Deactivated successfully. Apr 30 12:48:30.518912 systemd-logind[1512]: Session 6 logged out. Waiting for processes to exit. Apr 30 12:48:30.520098 systemd-logind[1512]: Removed session 6. Apr 30 12:48:30.560291 systemd[1]: Started sshd@6-172.31.27.168:22-147.75.109.163:45648.service - OpenSSH per-connection server daemon (147.75.109.163:45648). Apr 30 12:48:30.813459 sshd[1756]: Accepted publickey for core from 147.75.109.163 port 45648 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:30.815087 sshd-session[1756]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:30.819296 systemd-logind[1512]: New session 7 of user core. Apr 30 12:48:30.827891 systemd[1]: Started session-7.scope - Session 7 of User core. Apr 30 12:48:30.969016 sudo[1759]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mkdir -p . Apr 30 12:48:30.969282 sudo[1759]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 30 12:48:30.972775 sudo[1759]: pam_unix(sudo:session): session closed for user root Apr 30 12:48:31.009745 sshd[1758]: Connection closed by 147.75.109.163 port 45648 Apr 30 12:48:31.010146 sshd-session[1756]: pam_unix(sshd:session): session closed for user core Apr 30 12:48:31.013152 systemd[1]: sshd@6-172.31.27.168:22-147.75.109.163:45648.service: Deactivated successfully. Apr 30 12:48:31.014648 systemd[1]: session-7.scope: Deactivated successfully. Apr 30 12:48:31.015220 systemd-logind[1512]: Session 7 logged out. Waiting for processes to exit. Apr 30 12:48:31.016391 systemd-logind[1512]: Removed session 7. Apr 30 12:48:31.058607 systemd[1]: Started sshd@7-172.31.27.168:22-147.75.109.163:45658.service - OpenSSH per-connection server daemon (147.75.109.163:45658). Apr 30 12:48:31.312558 sshd[1765]: Accepted publickey for core from 147.75.109.163 port 45658 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:31.313920 sshd-session[1765]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:31.318083 systemd-logind[1512]: New session 8 of user core. Apr 30 12:48:31.327855 systemd[1]: Started session-8.scope - Session 8 of User core. Apr 30 12:48:31.468826 sudo[1768]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/install -m 0755 /dev/stdin kolet Apr 30 12:48:31.469089 sudo[1768]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 30 12:48:32.673418 systemd-resolved[1444]: Clock change detected. Flushing caches. Apr 30 12:48:33.505066 sudo[1768]: pam_unix(sudo:session): session closed for user root Apr 30 12:48:33.542916 sshd[1767]: Connection closed by 147.75.109.163 port 45658 Apr 30 12:48:33.543913 sshd-session[1765]: pam_unix(sshd:session): session closed for user core Apr 30 12:48:33.547239 systemd[1]: sshd@7-172.31.27.168:22-147.75.109.163:45658.service: Deactivated successfully. Apr 30 12:48:33.548820 systemd[1]: session-8.scope: Deactivated successfully. Apr 30 12:48:33.550179 systemd-logind[1512]: Session 8 logged out. Waiting for processes to exit. Apr 30 12:48:33.551431 systemd-logind[1512]: Removed session 8. Apr 30 12:48:33.593527 systemd[1]: Started sshd@8-172.31.27.168:22-147.75.109.163:45662.service - OpenSSH per-connection server daemon (147.75.109.163:45662). Apr 30 12:48:33.847010 sshd[1775]: Accepted publickey for core from 147.75.109.163 port 45662 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:33.848223 sshd-session[1775]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:33.853400 systemd-logind[1512]: New session 9 of user core. Apr 30 12:48:33.863504 systemd[1]: Started session-9.scope - Session 9 of User core. Apr 30 12:48:34.067089 sshd[1777]: Connection closed by 147.75.109.163 port 45662 Apr 30 12:48:34.067488 sshd-session[1775]: pam_unix(sshd:session): session closed for user core Apr 30 12:48:34.071455 systemd[1]: sshd@8-172.31.27.168:22-147.75.109.163:45662.service: Deactivated successfully. Apr 30 12:48:34.073035 systemd[1]: session-9.scope: Deactivated successfully. Apr 30 12:48:34.073642 systemd-logind[1512]: Session 9 logged out. Waiting for processes to exit. Apr 30 12:48:34.075165 systemd-logind[1512]: Removed session 9. Apr 30 12:48:34.120854 systemd[1]: Started sshd@9-172.31.27.168:22-147.75.109.163:45674.service - OpenSSH per-connection server daemon (147.75.109.163:45674). Apr 30 12:48:34.378152 sshd[1795]: Accepted publickey for core from 147.75.109.163 port 45674 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:34.379431 sshd-session[1795]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:34.383850 systemd-logind[1512]: New session 10 of user core. Apr 30 12:48:34.398535 systemd[1]: Started session-10.scope - Session 10 of User core. Apr 30 12:48:34.768628 systemd[1]: Starting docker.service - Docker Application Container Engine... Apr 30 12:48:34.768830 (dockerd)[1820]: 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 Apr 30 12:48:35.494788 dockerd[1820]: time="2025-04-30T12:48:35.494728972Z" level=info msg="Starting up" Apr 30 12:48:35.711955 dockerd[1820]: time="2025-04-30T12:48:35.711908455Z" level=info msg="Loading containers: start." Apr 30 12:48:35.919391 kernel: Initializing XFRM netlink socket Apr 30 12:48:35.971896 (udev-worker)[1850]: Network interface NamePolicy= disabled on kernel command line. Apr 30 12:48:36.035504 systemd-networkd[1295]: docker0: Link UP Apr 30 12:48:36.083965 dockerd[1820]: time="2025-04-30T12:48:36.083920649Z" level=info msg="Loading containers: done." Apr 30 12:48:36.100083 dockerd[1820]: time="2025-04-30T12:48:36.100038415Z" 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 Apr 30 12:48:36.100229 dockerd[1820]: time="2025-04-30T12:48:36.100132211Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 Apr 30 12:48:36.100229 dockerd[1820]: time="2025-04-30T12:48:36.100224301Z" level=info msg="Daemon has completed initialization" Apr 30 12:48:36.134950 dockerd[1820]: time="2025-04-30T12:48:36.134892829Z" level=info msg="API listen on /run/docker.sock" Apr 30 12:48:36.135111 systemd[1]: Started docker.service - Docker Application Container Engine. Apr 30 12:48:37.304331 systemd[1]: var-lib-docker-overlay2-421c23b1b9c1e0368fae2780d10b0ad6467eadd3c83fa4b360a9dbce8a7af024\x2dinit-merged.mount: Deactivated successfully. Apr 30 12:48:37.364745 kernel: docker0: port 1(vethec6b71f) entered blocking state Apr 30 12:48:37.364859 kernel: docker0: port 1(vethec6b71f) entered disabled state Apr 30 12:48:37.364891 kernel: vethec6b71f: entered allmulticast mode Apr 30 12:48:37.365599 kernel: vethec6b71f: entered promiscuous mode Apr 30 12:48:37.365830 (udev-worker)[1936]: Network interface NamePolicy= disabled on kernel command line. Apr 30 12:48:37.366161 systemd-networkd[1295]: vethec6b71f: Link UP Apr 30 12:48:37.615952 containerd[1533]: time="2025-04-30T12:48:37.615278660Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 30 12:48:37.615952 containerd[1533]: time="2025-04-30T12:48:37.615858338Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 30 12:48:37.615952 containerd[1533]: time="2025-04-30T12:48:37.615870890Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 30 12:48:37.615952 containerd[1533]: time="2025-04-30T12:48:37.615941046Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 30 12:48:37.646552 systemd[1]: Started docker-3657f26e4345a9a2fc12ce0dd5b54389fad8f6a047387307e50e8b6a1b92d7ed.scope - libcontainer container 3657f26e4345a9a2fc12ce0dd5b54389fad8f6a047387307e50e8b6a1b92d7ed. Apr 30 12:48:37.702393 kernel: eth0: renamed from veth6fd731c Apr 30 12:48:37.717028 systemd-networkd[1295]: vethec6b71f: Gained carrier Apr 30 12:48:37.717331 systemd-networkd[1295]: docker0: Gained carrier Apr 30 12:48:37.717402 kernel: docker0: port 1(vethec6b71f) entered blocking state Apr 30 12:48:37.717433 kernel: docker0: port 1(vethec6b71f) entered forwarding state Apr 30 12:48:39.305514 systemd-networkd[1295]: vethec6b71f: Gained IPv6LL Apr 30 12:48:39.369513 systemd-networkd[1295]: docker0: Gained IPv6LL Apr 30 12:48:40.789485 systemd[1]: docker-3657f26e4345a9a2fc12ce0dd5b54389fad8f6a047387307e50e8b6a1b92d7ed.scope: Deactivated successfully. Apr 30 12:48:40.802239 containerd[1533]: time="2025-04-30T12:48:40.802169516Z" level=info msg="shim disconnected" id=3657f26e4345a9a2fc12ce0dd5b54389fad8f6a047387307e50e8b6a1b92d7ed namespace=moby Apr 30 12:48:40.802239 containerd[1533]: time="2025-04-30T12:48:40.802233581Z" level=warning msg="cleaning up after shim disconnected" id=3657f26e4345a9a2fc12ce0dd5b54389fad8f6a047387307e50e8b6a1b92d7ed namespace=moby Apr 30 12:48:40.802239 containerd[1533]: time="2025-04-30T12:48:40.802243176Z" level=info msg="cleaning up dead shim" namespace=moby Apr 30 12:48:40.802624 dockerd[1820]: time="2025-04-30T12:48:40.802216038Z" level=info msg="ignoring event" container=3657f26e4345a9a2fc12ce0dd5b54389fad8f6a047387307e50e8b6a1b92d7ed module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Apr 30 12:48:40.826642 systemd-networkd[1295]: vethec6b71f: Lost carrier Apr 30 12:48:40.827386 kernel: docker0: port 1(vethec6b71f) entered disabled state Apr 30 12:48:40.827427 kernel: veth6fd731c: renamed from eth0 Apr 30 12:48:40.851509 systemd-networkd[1295]: vethec6b71f: Link DOWN Apr 30 12:48:40.852404 kernel: docker0: port 1(vethec6b71f) entered disabled state Apr 30 12:48:40.854660 kernel: vethec6b71f (unregistering): left allmulticast mode Apr 30 12:48:40.854707 kernel: vethec6b71f (unregistering): left promiscuous mode Apr 30 12:48:40.854745 kernel: docker0: port 1(vethec6b71f) entered disabled state Apr 30 12:48:40.883107 systemd[1]: run-docker-netns-f73640552fda.mount: Deactivated successfully. Apr 30 12:48:40.887074 systemd[1]: var-lib-docker-overlay2-421c23b1b9c1e0368fae2780d10b0ad6467eadd3c83fa4b360a9dbce8a7af024-merged.mount: Deactivated successfully. Apr 30 12:48:40.940282 sshd[1797]: Connection closed by 147.75.109.163 port 45674 Apr 30 12:48:40.940689 sshd-session[1795]: pam_unix(sshd:session): session closed for user core Apr 30 12:48:40.944066 systemd[1]: sshd@9-172.31.27.168:22-147.75.109.163:45674.service: Deactivated successfully. Apr 30 12:48:40.945708 systemd[1]: session-10.scope: Deactivated successfully. Apr 30 12:48:40.946304 systemd-logind[1512]: Session 10 logged out. Waiting for processes to exit. Apr 30 12:48:40.947780 systemd-logind[1512]: Removed session 10. Apr 30 12:48:40.989453 systemd[1]: Started sshd@10-172.31.27.168:22-147.75.109.163:35484.service - OpenSSH per-connection server daemon (147.75.109.163:35484). Apr 30 12:48:41.240336 sshd[2123]: Accepted publickey for core from 147.75.109.163 port 35484 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:41.241599 sshd-session[2123]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:41.245708 systemd-logind[1512]: New session 11 of user core. Apr 30 12:48:41.257513 systemd[1]: Started session-11.scope - Session 11 of User core. Apr 30 12:48:41.445684 systemd[1]: var-lib-docker-overlay2-d303f9eef1cb421cd1eef0c758a082923a3fadf194dccbf99b5cd2e68a915a16\x2dinit-merged.mount: Deactivated successfully. Apr 30 12:48:41.477663 kernel: docker0: port 1(veth386bf18) entered blocking state Apr 30 12:48:41.477780 kernel: docker0: port 1(veth386bf18) entered disabled state Apr 30 12:48:41.477811 kernel: veth386bf18: entered allmulticast mode Apr 30 12:48:41.478531 kernel: veth386bf18: entered promiscuous mode Apr 30 12:48:41.479125 systemd-networkd[1295]: veth386bf18: Link UP Apr 30 12:48:41.479711 kernel: docker0: port 1(veth386bf18) entered blocking state Apr 30 12:48:41.479776 kernel: docker0: port 1(veth386bf18) entered forwarding state Apr 30 12:48:41.479803 (udev-worker)[2118]: Network interface NamePolicy= disabled on kernel command line. Apr 30 12:48:41.479855 (udev-worker)[2112]: Network interface NamePolicy= disabled on kernel command line. Apr 30 12:48:41.594042 containerd[1533]: time="2025-04-30T12:48:41.593398268Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 30 12:48:41.594042 containerd[1533]: time="2025-04-30T12:48:41.593921812Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 30 12:48:41.594042 containerd[1533]: time="2025-04-30T12:48:41.593934575Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 30 12:48:41.594042 containerd[1533]: time="2025-04-30T12:48:41.594021221Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 30 12:48:41.620562 systemd[1]: Started docker-42576ec7e0c0fe135991a0171b60f93fa4e41472133a387a91e5a18fc3893eae.scope - libcontainer container 42576ec7e0c0fe135991a0171b60f93fa4e41472133a387a91e5a18fc3893eae. Apr 30 12:48:41.674392 kernel: eth0: renamed from veth8cf62ef Apr 30 12:48:41.685000 systemd-networkd[1295]: veth386bf18: Gained carrier Apr 30 12:48:41.720000 systemd[1]: docker-42576ec7e0c0fe135991a0171b60f93fa4e41472133a387a91e5a18fc3893eae.scope: Deactivated successfully. Apr 30 12:48:41.733791 containerd[1533]: time="2025-04-30T12:48:41.733640981Z" level=info msg="shim disconnected" id=42576ec7e0c0fe135991a0171b60f93fa4e41472133a387a91e5a18fc3893eae namespace=moby Apr 30 12:48:41.733791 containerd[1533]: time="2025-04-30T12:48:41.733708339Z" level=warning msg="cleaning up after shim disconnected" id=42576ec7e0c0fe135991a0171b60f93fa4e41472133a387a91e5a18fc3893eae namespace=moby Apr 30 12:48:41.733791 containerd[1533]: time="2025-04-30T12:48:41.733720653Z" level=info msg="cleaning up dead shim" namespace=moby Apr 30 12:48:41.733940 dockerd[1820]: time="2025-04-30T12:48:41.733723116Z" level=info msg="ignoring event" container=42576ec7e0c0fe135991a0171b60f93fa4e41472133a387a91e5a18fc3893eae module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Apr 30 12:48:41.757085 systemd-networkd[1295]: veth386bf18: Lost carrier Apr 30 12:48:41.757391 kernel: docker0: port 1(veth386bf18) entered disabled state Apr 30 12:48:41.757455 kernel: veth8cf62ef: renamed from eth0 Apr 30 12:48:41.777086 (udev-worker)[2173]: Network interface NamePolicy= disabled on kernel command line. Apr 30 12:48:41.779232 systemd-networkd[1295]: veth386bf18: Link DOWN Apr 30 12:48:41.780388 kernel: docker0: port 1(veth386bf18) entered disabled state Apr 30 12:48:41.782426 kernel: veth386bf18 (unregistering): left allmulticast mode Apr 30 12:48:41.782459 kernel: veth386bf18 (unregistering): left promiscuous mode Apr 30 12:48:41.782483 kernel: docker0: port 1(veth386bf18) entered disabled state Apr 30 12:48:41.833565 systemd-networkd[1295]: docker0: Lost carrier Apr 30 12:48:41.861667 sshd[2125]: Connection closed by 147.75.109.163 port 35484 Apr 30 12:48:41.862010 sshd-session[2123]: pam_unix(sshd:session): session closed for user core Apr 30 12:48:41.865591 systemd[1]: sshd@10-172.31.27.168:22-147.75.109.163:35484.service: Deactivated successfully. Apr 30 12:48:41.867200 systemd[1]: session-11.scope: Deactivated successfully. Apr 30 12:48:41.867871 systemd-logind[1512]: Session 11 logged out. Waiting for processes to exit. Apr 30 12:48:41.869477 systemd-logind[1512]: Removed session 11. Apr 30 12:48:41.913435 systemd[1]: Started sshd@11-172.31.27.168:22-147.75.109.163:35496.service - OpenSSH per-connection server daemon (147.75.109.163:35496). Apr 30 12:48:42.162449 sshd[2255]: Accepted publickey for core from 147.75.109.163 port 35496 ssh2: RSA SHA256:e8FTwHF7/r7GDmdecJWbdRS/rw14D45w8a2pCHcoTTY Apr 30 12:48:42.163330 sshd-session[2255]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 30 12:48:42.167341 systemd-logind[1512]: New session 12 of user core. Apr 30 12:48:42.175026 systemd[1]: Started session-12.scope - Session 12 of User core. Apr 30 12:48:42.349360 ntpdate[2270]: ntpdate 4.2.8p17@1.4004-o Tue Apr 29 21:38:48 UTC 2025 (1) Apr 30 12:48:49.063485 ntpdate[2270]: adjust time server 23.186.168.127 offset -0.008009 sec Apr 30 12:48:49.100675 sshd[2257]: Connection closed by 147.75.109.163 port 35496 Apr 30 12:48:49.101044 sshd-session[2255]: pam_unix(sshd:session): session closed for user core Apr 30 12:48:49.104593 systemd[1]: sshd@11-172.31.27.168:22-147.75.109.163:35496.service: Deactivated successfully. Apr 30 12:48:49.106219 systemd[1]: session-12.scope: Deactivated successfully. Apr 30 12:48:49.107191 systemd-logind[1512]: Session 12 logged out. Waiting for processes to exit. Apr 30 12:48:49.108334 systemd-logind[1512]: Removed session 12.