Nov 12 22:48:54.992088 kernel: Linux version 6.6.60-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT_DYNAMIC Tue Nov 12 21:10:03 -00 2024 Nov 12 22:48:54.992129 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=714367a70d0d672ed3d7ccc2de5247f52d37046778a42409fc8a40b0511373b1 Nov 12 22:48:54.992144 kernel: BIOS-provided physical RAM map: Nov 12 22:48:54.992154 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Nov 12 22:48:54.992165 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Nov 12 22:48:54.992175 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Nov 12 22:48:54.992191 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000007d9e9fff] usable Nov 12 22:48:54.993436 kernel: BIOS-e820: [mem 0x000000007d9ea000-0x000000007fffffff] reserved Nov 12 22:48:54.993457 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000e03fffff] reserved Nov 12 22:48:54.993468 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Nov 12 22:48:54.993479 kernel: NX (Execute Disable) protection: active Nov 12 22:48:54.993490 kernel: APIC: Static calls initialized Nov 12 22:48:54.993500 kernel: SMBIOS 2.7 present. Nov 12 22:48:54.993511 kernel: DMI: Amazon EC2 t3.small/, BIOS 1.0 10/16/2017 Nov 12 22:48:54.993529 kernel: Hypervisor detected: KVM Nov 12 22:48:54.993548 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Nov 12 22:48:54.993561 kernel: kvm-clock: using sched offset of 8435791698 cycles Nov 12 22:48:54.993576 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Nov 12 22:48:54.993588 kernel: tsc: Detected 2499.998 MHz processor Nov 12 22:48:54.993601 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Nov 12 22:48:54.993613 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Nov 12 22:48:54.993629 kernel: last_pfn = 0x7d9ea max_arch_pfn = 0x400000000 Nov 12 22:48:54.993642 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Nov 12 22:48:54.993654 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Nov 12 22:48:54.993667 kernel: Using GB pages for direct mapping Nov 12 22:48:54.993681 kernel: ACPI: Early table checksum verification disabled Nov 12 22:48:54.993694 kernel: ACPI: RSDP 0x00000000000F8F40 000014 (v00 AMAZON) Nov 12 22:48:54.993708 kernel: ACPI: RSDT 0x000000007D9EE350 000044 (v01 AMAZON AMZNRSDT 00000001 AMZN 00000001) Nov 12 22:48:54.993722 kernel: ACPI: FACP 0x000000007D9EFF80 000074 (v01 AMAZON AMZNFACP 00000001 AMZN 00000001) Nov 12 22:48:54.993736 kernel: ACPI: DSDT 0x000000007D9EE3A0 0010E9 (v01 AMAZON AMZNDSDT 00000001 AMZN 00000001) Nov 12 22:48:54.993752 kernel: ACPI: FACS 0x000000007D9EFF40 000040 Nov 12 22:48:54.993766 kernel: ACPI: SSDT 0x000000007D9EF6C0 00087A (v01 AMAZON AMZNSSDT 00000001 AMZN 00000001) Nov 12 22:48:54.993779 kernel: ACPI: APIC 0x000000007D9EF5D0 000076 (v01 AMAZON AMZNAPIC 00000001 AMZN 00000001) Nov 12 22:48:54.993793 kernel: ACPI: SRAT 0x000000007D9EF530 0000A0 (v01 AMAZON AMZNSRAT 00000001 AMZN 00000001) Nov 12 22:48:54.993806 kernel: ACPI: SLIT 0x000000007D9EF4C0 00006C (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Nov 12 22:48:54.993820 kernel: ACPI: WAET 0x000000007D9EF490 000028 (v01 AMAZON AMZNWAET 00000001 AMZN 00000001) Nov 12 22:48:54.993832 kernel: ACPI: HPET 0x00000000000C9000 000038 (v01 AMAZON AMZNHPET 00000001 AMZN 00000001) Nov 12 22:48:54.993844 kernel: ACPI: SSDT 0x00000000000C9040 00007B (v01 AMAZON AMZNSSDT 00000001 AMZN 00000001) Nov 12 22:48:54.993858 kernel: ACPI: Reserving FACP table memory at [mem 0x7d9eff80-0x7d9efff3] Nov 12 22:48:54.993875 kernel: ACPI: Reserving DSDT table memory at [mem 0x7d9ee3a0-0x7d9ef488] Nov 12 22:48:54.993894 kernel: ACPI: Reserving FACS table memory at [mem 0x7d9eff40-0x7d9eff7f] Nov 12 22:48:54.993907 kernel: ACPI: Reserving SSDT table memory at [mem 0x7d9ef6c0-0x7d9eff39] Nov 12 22:48:54.993921 kernel: ACPI: Reserving APIC table memory at [mem 0x7d9ef5d0-0x7d9ef645] Nov 12 22:48:54.993937 kernel: ACPI: Reserving SRAT table memory at [mem 0x7d9ef530-0x7d9ef5cf] Nov 12 22:48:54.993954 kernel: ACPI: Reserving SLIT table memory at [mem 0x7d9ef4c0-0x7d9ef52b] Nov 12 22:48:54.993967 kernel: ACPI: Reserving WAET table memory at [mem 0x7d9ef490-0x7d9ef4b7] Nov 12 22:48:54.993983 kernel: ACPI: Reserving HPET table memory at [mem 0xc9000-0xc9037] Nov 12 22:48:54.993998 kernel: ACPI: Reserving SSDT table memory at [mem 0xc9040-0xc90ba] Nov 12 22:48:54.994011 kernel: SRAT: PXM 0 -> APIC 0x00 -> Node 0 Nov 12 22:48:54.994025 kernel: SRAT: PXM 0 -> APIC 0x01 -> Node 0 Nov 12 22:48:54.994040 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x7fffffff] Nov 12 22:48:54.994054 kernel: NUMA: Initialized distance table, cnt=1 Nov 12 22:48:54.994069 kernel: NODE_DATA(0) allocated [mem 0x7d9e3000-0x7d9e8fff] Nov 12 22:48:54.994089 kernel: Zone ranges: Nov 12 22:48:54.994104 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Nov 12 22:48:54.994119 kernel: DMA32 [mem 0x0000000001000000-0x000000007d9e9fff] Nov 12 22:48:54.994135 kernel: Normal empty Nov 12 22:48:54.994151 kernel: Movable zone start for each node Nov 12 22:48:54.994167 kernel: Early memory node ranges Nov 12 22:48:54.994183 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Nov 12 22:48:54.994200 kernel: node 0: [mem 0x0000000000100000-0x000000007d9e9fff] Nov 12 22:48:54.994217 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007d9e9fff] Nov 12 22:48:54.994234 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Nov 12 22:48:54.994252 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Nov 12 22:48:54.994267 kernel: On node 0, zone DMA32: 9750 pages in unavailable ranges Nov 12 22:48:54.994283 kernel: ACPI: PM-Timer IO Port: 0xb008 Nov 12 22:48:54.994299 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Nov 12 22:48:54.994335 kernel: IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23 Nov 12 22:48:54.994347 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Nov 12 22:48:54.994360 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Nov 12 22:48:54.994373 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Nov 12 22:48:54.994385 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Nov 12 22:48:54.994402 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Nov 12 22:48:54.994731 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Nov 12 22:48:54.994753 kernel: TSC deadline timer available Nov 12 22:48:54.994770 kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs Nov 12 22:48:54.994788 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Nov 12 22:48:54.994804 kernel: [mem 0x80000000-0xdfffffff] available for PCI devices Nov 12 22:48:54.994818 kernel: Booting paravirtualized kernel on KVM Nov 12 22:48:54.994833 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Nov 12 22:48:54.994847 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Nov 12 22:48:54.994866 kernel: percpu: Embedded 58 pages/cpu s197032 r8192 d32344 u1048576 Nov 12 22:48:54.994880 kernel: pcpu-alloc: s197032 r8192 d32344 u1048576 alloc=1*2097152 Nov 12 22:48:54.994894 kernel: pcpu-alloc: [0] 0 1 Nov 12 22:48:54.994909 kernel: kvm-guest: PV spinlocks enabled Nov 12 22:48:54.994923 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Nov 12 22:48:54.994941 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=714367a70d0d672ed3d7ccc2de5247f52d37046778a42409fc8a40b0511373b1 Nov 12 22:48:54.994955 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Nov 12 22:48:54.994968 kernel: random: crng init done Nov 12 22:48:54.994986 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 12 22:48:54.995001 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Nov 12 22:48:54.995017 kernel: Fallback order for Node 0: 0 Nov 12 22:48:54.995032 kernel: Built 1 zonelists, mobility grouping on. Total pages: 506242 Nov 12 22:48:54.995047 kernel: Policy zone: DMA32 Nov 12 22:48:54.995063 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 12 22:48:54.995080 kernel: Memory: 1932348K/2057760K available (12288K kernel code, 2305K rwdata, 22736K rodata, 42968K init, 2220K bss, 125152K reserved, 0K cma-reserved) Nov 12 22:48:54.995095 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Nov 12 22:48:54.995167 kernel: Kernel/User page tables isolation: enabled Nov 12 22:48:54.995189 kernel: ftrace: allocating 37801 entries in 148 pages Nov 12 22:48:54.995238 kernel: ftrace: allocated 148 pages with 3 groups Nov 12 22:48:54.995258 kernel: Dynamic Preempt: voluntary Nov 12 22:48:54.995273 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 12 22:48:54.995400 kernel: rcu: RCU event tracing is enabled. Nov 12 22:48:54.995422 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Nov 12 22:48:54.995439 kernel: Trampoline variant of Tasks RCU enabled. Nov 12 22:48:54.995491 kernel: Rude variant of Tasks RCU enabled. Nov 12 22:48:54.995508 kernel: Tracing variant of Tasks RCU enabled. Nov 12 22:48:54.995559 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 12 22:48:54.995579 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Nov 12 22:48:54.995595 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16 Nov 12 22:48:54.995611 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 12 22:48:54.995662 kernel: Console: colour VGA+ 80x25 Nov 12 22:48:54.995679 kernel: printk: console [ttyS0] enabled Nov 12 22:48:54.995695 kernel: ACPI: Core revision 20230628 Nov 12 22:48:54.996052 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 30580167144 ns Nov 12 22:48:54.996070 kernel: APIC: Switch to symmetric I/O mode setup Nov 12 22:48:54.996091 kernel: x2apic enabled Nov 12 22:48:54.996106 kernel: APIC: Switched APIC routing to: physical x2apic Nov 12 22:48:54.996179 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x240937b9988, max_idle_ns: 440795218083 ns Nov 12 22:48:54.996355 kernel: Calibrating delay loop (skipped) preset value.. 4999.99 BogoMIPS (lpj=2499998) Nov 12 22:48:54.996370 kernel: Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8 Nov 12 22:48:54.996383 kernel: Last level dTLB entries: 4KB 64, 2MB 0, 4MB 0, 1GB 4 Nov 12 22:48:54.996396 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Nov 12 22:48:54.996410 kernel: Spectre V2 : Mitigation: Retpolines Nov 12 22:48:54.996424 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Nov 12 22:48:54.996439 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Nov 12 22:48:54.996454 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Nov 12 22:48:54.996471 kernel: RETBleed: Vulnerable Nov 12 22:48:54.996485 kernel: Speculative Store Bypass: Vulnerable Nov 12 22:48:54.996502 kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Nov 12 22:48:54.996515 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Nov 12 22:48:54.996529 kernel: GDS: Unknown: Dependent on hypervisor status Nov 12 22:48:54.996542 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Nov 12 22:48:54.996556 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Nov 12 22:48:54.996571 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Nov 12 22:48:54.996589 kernel: x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers' Nov 12 22:48:54.996668 kernel: x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR' Nov 12 22:48:54.996782 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Nov 12 22:48:54.996796 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Nov 12 22:48:54.996810 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Nov 12 22:48:54.996996 kernel: x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' Nov 12 22:48:54.997018 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Nov 12 22:48:54.997033 kernel: x86/fpu: xstate_offset[3]: 832, xstate_sizes[3]: 64 Nov 12 22:48:54.997047 kernel: x86/fpu: xstate_offset[4]: 896, xstate_sizes[4]: 64 Nov 12 22:48:54.997061 kernel: x86/fpu: xstate_offset[5]: 960, xstate_sizes[5]: 64 Nov 12 22:48:54.997075 kernel: x86/fpu: xstate_offset[6]: 1024, xstate_sizes[6]: 512 Nov 12 22:48:54.997094 kernel: x86/fpu: xstate_offset[7]: 1536, xstate_sizes[7]: 1024 Nov 12 22:48:54.997109 kernel: x86/fpu: xstate_offset[9]: 2560, xstate_sizes[9]: 8 Nov 12 22:48:54.997124 kernel: x86/fpu: Enabled xstate features 0x2ff, context size is 2568 bytes, using 'compacted' format. Nov 12 22:48:54.997139 kernel: Freeing SMP alternatives memory: 32K Nov 12 22:48:54.997152 kernel: pid_max: default: 32768 minimum: 301 Nov 12 22:48:54.997166 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Nov 12 22:48:54.997179 kernel: landlock: Up and running. Nov 12 22:48:54.997193 kernel: SELinux: Initializing. Nov 12 22:48:54.997209 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Nov 12 22:48:54.997226 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Nov 12 22:48:54.997243 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8259CL CPU @ 2.50GHz (family: 0x6, model: 0x55, stepping: 0x7) Nov 12 22:48:54.997263 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Nov 12 22:48:54.997279 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Nov 12 22:48:54.997296 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Nov 12 22:48:54.997330 kernel: Performance Events: unsupported p6 CPU model 85 no PMU driver, software events only. Nov 12 22:48:54.997346 kernel: signal: max sigframe size: 3632 Nov 12 22:48:54.997363 kernel: rcu: Hierarchical SRCU implementation. Nov 12 22:48:54.997380 kernel: rcu: Max phase no-delay instances is 400. Nov 12 22:48:54.997397 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Nov 12 22:48:54.997412 kernel: smp: Bringing up secondary CPUs ... Nov 12 22:48:54.997432 kernel: smpboot: x86: Booting SMP configuration: Nov 12 22:48:54.997449 kernel: .... node #0, CPUs: #1 Nov 12 22:48:54.997512 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. Nov 12 22:48:54.997531 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. Nov 12 22:48:54.997554 kernel: smp: Brought up 1 node, 2 CPUs Nov 12 22:48:54.997570 kernel: smpboot: Max logical packages: 1 Nov 12 22:48:54.997587 kernel: smpboot: Total of 2 processors activated (9999.99 BogoMIPS) Nov 12 22:48:54.997604 kernel: devtmpfs: initialized Nov 12 22:48:54.997620 kernel: x86/mm: Memory block size: 128MB Nov 12 22:48:54.997640 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 12 22:48:54.997657 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Nov 12 22:48:54.997674 kernel: pinctrl core: initialized pinctrl subsystem Nov 12 22:48:54.997690 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 12 22:48:54.998461 kernel: audit: initializing netlink subsys (disabled) Nov 12 22:48:54.998520 kernel: audit: type=2000 audit(1731451733.474:1): state=initialized audit_enabled=0 res=1 Nov 12 22:48:54.998534 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 12 22:48:54.998550 kernel: thermal_sys: Registered thermal governor 'user_space' Nov 12 22:48:54.998571 kernel: cpuidle: using governor menu Nov 12 22:48:54.998586 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 12 22:48:54.998600 kernel: dca service started, version 1.12.1 Nov 12 22:48:54.998614 kernel: PCI: Using configuration type 1 for base access Nov 12 22:48:54.998627 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Nov 12 22:48:54.998641 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 12 22:48:54.998656 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Nov 12 22:48:54.998669 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 12 22:48:54.998685 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Nov 12 22:48:54.998705 kernel: ACPI: Added _OSI(Module Device) Nov 12 22:48:54.998721 kernel: ACPI: Added _OSI(Processor Device) Nov 12 22:48:54.998736 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 12 22:48:54.998749 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 12 22:48:54.998764 kernel: ACPI: 3 ACPI AML tables successfully acquired and loaded Nov 12 22:48:54.998779 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Nov 12 22:48:54.998796 kernel: ACPI: Interpreter enabled Nov 12 22:48:54.998812 kernel: ACPI: PM: (supports S0 S5) Nov 12 22:48:54.998827 kernel: ACPI: Using IOAPIC for interrupt routing Nov 12 22:48:54.998841 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Nov 12 22:48:54.998859 kernel: PCI: Using E820 reservations for host bridge windows Nov 12 22:48:54.998872 kernel: ACPI: Enabled 16 GPEs in block 00 to 0F Nov 12 22:48:54.998886 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 12 22:48:54.999172 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Nov 12 22:48:54.999618 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Nov 12 22:48:55.000060 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Nov 12 22:48:55.000108 kernel: acpiphp: Slot [3] registered Nov 12 22:48:55.000129 kernel: acpiphp: Slot [4] registered Nov 12 22:48:55.000164 kernel: acpiphp: Slot [5] registered Nov 12 22:48:55.000179 kernel: acpiphp: Slot [6] registered Nov 12 22:48:55.000194 kernel: acpiphp: Slot [7] registered Nov 12 22:48:55.000212 kernel: acpiphp: Slot [8] registered Nov 12 22:48:55.000224 kernel: acpiphp: Slot [9] registered Nov 12 22:48:55.000238 kernel: acpiphp: Slot [10] registered Nov 12 22:48:55.000253 kernel: acpiphp: Slot [11] registered Nov 12 22:48:55.000266 kernel: acpiphp: Slot [12] registered Nov 12 22:48:55.000284 kernel: acpiphp: Slot [13] registered Nov 12 22:48:55.000298 kernel: acpiphp: Slot [14] registered Nov 12 22:48:55.000325 kernel: acpiphp: Slot [15] registered Nov 12 22:48:55.000339 kernel: acpiphp: Slot [16] registered Nov 12 22:48:55.000352 kernel: acpiphp: Slot [17] registered Nov 12 22:48:55.000366 kernel: acpiphp: Slot [18] registered Nov 12 22:48:55.000381 kernel: acpiphp: Slot [19] registered Nov 12 22:48:55.000394 kernel: acpiphp: Slot [20] registered Nov 12 22:48:55.000408 kernel: acpiphp: Slot [21] registered Nov 12 22:48:55.000422 kernel: acpiphp: Slot [22] registered Nov 12 22:48:55.000439 kernel: acpiphp: Slot [23] registered Nov 12 22:48:55.000453 kernel: acpiphp: Slot [24] registered Nov 12 22:48:55.000467 kernel: acpiphp: Slot [25] registered Nov 12 22:48:55.000482 kernel: acpiphp: Slot [26] registered Nov 12 22:48:55.000495 kernel: acpiphp: Slot [27] registered Nov 12 22:48:55.000509 kernel: acpiphp: Slot [28] registered Nov 12 22:48:55.000522 kernel: acpiphp: Slot [29] registered Nov 12 22:48:55.000607 kernel: acpiphp: Slot [30] registered Nov 12 22:48:55.000621 kernel: acpiphp: Slot [31] registered Nov 12 22:48:55.000638 kernel: PCI host bridge to bus 0000:00 Nov 12 22:48:55.000841 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Nov 12 22:48:55.001016 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Nov 12 22:48:55.001136 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Nov 12 22:48:55.001257 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] Nov 12 22:48:55.001425 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 12 22:48:55.001606 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Nov 12 22:48:55.001824 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Nov 12 22:48:55.002151 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x000000 Nov 12 22:48:55.002354 kernel: pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI Nov 12 22:48:55.002498 kernel: pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB Nov 12 22:48:55.003150 kernel: pci 0000:00:01.3: PIIX4 devres E PIO at fff0-ffff Nov 12 22:48:55.003449 kernel: pci 0000:00:01.3: PIIX4 devres F MMIO at ffc00000-ffffffff Nov 12 22:48:55.003597 kernel: pci 0000:00:01.3: PIIX4 devres G PIO at fff0-ffff Nov 12 22:48:55.003786 kernel: pci 0000:00:01.3: PIIX4 devres H MMIO at ffc00000-ffffffff Nov 12 22:48:55.004397 kernel: pci 0000:00:01.3: PIIX4 devres I PIO at fff0-ffff Nov 12 22:48:55.004823 kernel: pci 0000:00:01.3: PIIX4 devres J PIO at fff0-ffff Nov 12 22:48:55.005066 kernel: pci 0000:00:03.0: [1d0f:1111] type 00 class 0x030000 Nov 12 22:48:55.005268 kernel: pci 0000:00:03.0: reg 0x10: [mem 0xfe400000-0xfe7fffff pref] Nov 12 22:48:55.006369 kernel: pci 0000:00:03.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] Nov 12 22:48:55.006629 kernel: pci 0000:00:03.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Nov 12 22:48:55.007177 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Nov 12 22:48:55.007353 kernel: pci 0000:00:04.0: reg 0x10: [mem 0xfebf0000-0xfebf3fff] Nov 12 22:48:55.007509 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Nov 12 22:48:55.008055 kernel: pci 0000:00:05.0: reg 0x10: [mem 0xfebf4000-0xfebf7fff] Nov 12 22:48:55.008086 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Nov 12 22:48:55.008106 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Nov 12 22:48:55.008129 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Nov 12 22:48:55.008199 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Nov 12 22:48:55.008216 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Nov 12 22:48:55.008233 kernel: iommu: Default domain type: Translated Nov 12 22:48:55.008249 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Nov 12 22:48:55.008265 kernel: PCI: Using ACPI for IRQ routing Nov 12 22:48:55.008282 kernel: PCI: pci_cache_line_size set to 64 bytes Nov 12 22:48:55.008382 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Nov 12 22:48:55.008399 kernel: e820: reserve RAM buffer [mem 0x7d9ea000-0x7fffffff] Nov 12 22:48:55.008555 kernel: pci 0000:00:03.0: vgaarb: setting as boot VGA device Nov 12 22:48:55.008759 kernel: pci 0000:00:03.0: vgaarb: bridge control possible Nov 12 22:48:55.008910 kernel: pci 0000:00:03.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Nov 12 22:48:55.008933 kernel: vgaarb: loaded Nov 12 22:48:55.008949 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0 Nov 12 22:48:55.008966 kernel: hpet0: 8 comparators, 32-bit 62.500000 MHz counter Nov 12 22:48:55.008982 kernel: clocksource: Switched to clocksource kvm-clock Nov 12 22:48:55.008999 kernel: VFS: Disk quotas dquot_6.6.0 Nov 12 22:48:55.009016 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 12 22:48:55.009038 kernel: pnp: PnP ACPI init Nov 12 22:48:55.009055 kernel: pnp: PnP ACPI: found 5 devices Nov 12 22:48:55.009072 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Nov 12 22:48:55.009088 kernel: NET: Registered PF_INET protocol family Nov 12 22:48:55.009106 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 12 22:48:55.009122 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Nov 12 22:48:55.009140 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 12 22:48:55.009156 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Nov 12 22:48:55.009173 kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) Nov 12 22:48:55.009194 kernel: TCP: Hash tables configured (established 16384 bind 16384) Nov 12 22:48:55.009211 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Nov 12 22:48:55.009227 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Nov 12 22:48:55.009364 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 12 22:48:55.009381 kernel: NET: Registered PF_XDP protocol family Nov 12 22:48:55.009546 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Nov 12 22:48:55.018949 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Nov 12 22:48:55.020405 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Nov 12 22:48:55.020543 kernel: pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] Nov 12 22:48:55.020923 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Nov 12 22:48:55.020956 kernel: PCI: CLS 0 bytes, default 64 Nov 12 22:48:55.020973 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Nov 12 22:48:55.020990 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x240937b9988, max_idle_ns: 440795218083 ns Nov 12 22:48:55.021006 kernel: clocksource: Switched to clocksource tsc Nov 12 22:48:55.021021 kernel: Initialise system trusted keyrings Nov 12 22:48:55.021039 kernel: workingset: timestamp_bits=39 max_order=19 bucket_order=0 Nov 12 22:48:55.021061 kernel: Key type asymmetric registered Nov 12 22:48:55.021075 kernel: Asymmetric key parser 'x509' registered Nov 12 22:48:55.021091 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Nov 12 22:48:55.021113 kernel: io scheduler mq-deadline registered Nov 12 22:48:55.021133 kernel: io scheduler kyber registered Nov 12 22:48:55.021148 kernel: io scheduler bfq registered Nov 12 22:48:55.021163 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Nov 12 22:48:55.021177 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 12 22:48:55.021191 kernel: 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Nov 12 22:48:55.021210 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Nov 12 22:48:55.021225 kernel: i8042: Warning: Keylock active Nov 12 22:48:55.021239 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Nov 12 22:48:55.021255 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Nov 12 22:48:55.021434 kernel: rtc_cmos 00:00: RTC can wake from S4 Nov 12 22:48:55.021632 kernel: rtc_cmos 00:00: registered as rtc0 Nov 12 22:48:55.021770 kernel: rtc_cmos 00:00: setting system clock to 2024-11-12T22:48:54 UTC (1731451734) Nov 12 22:48:55.021903 kernel: rtc_cmos 00:00: alarms up to one day, 114 bytes nvram Nov 12 22:48:55.021930 kernel: intel_pstate: CPU model not supported Nov 12 22:48:55.021947 kernel: NET: Registered PF_INET6 protocol family Nov 12 22:48:55.021962 kernel: Segment Routing with IPv6 Nov 12 22:48:55.021978 kernel: In-situ OAM (IOAM) with IPv6 Nov 12 22:48:55.021994 kernel: NET: Registered PF_PACKET protocol family Nov 12 22:48:55.022011 kernel: Key type dns_resolver registered Nov 12 22:48:55.022025 kernel: IPI shorthand broadcast: enabled Nov 12 22:48:55.022041 kernel: sched_clock: Marking stable (580001950, 211133678)->(876007535, -84871907) Nov 12 22:48:55.022057 kernel: registered taskstats version 1 Nov 12 22:48:55.022078 kernel: Loading compiled-in X.509 certificates Nov 12 22:48:55.022095 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.60-flatcar: d04cb2ddbd5c3ca82936c51f5645ef0dcbdcd3b4' Nov 12 22:48:55.022112 kernel: Key type .fscrypt registered Nov 12 22:48:55.022130 kernel: Key type fscrypt-provisioning registered Nov 12 22:48:55.022146 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 12 22:48:55.022162 kernel: ima: Allocated hash algorithm: sha1 Nov 12 22:48:55.022178 kernel: ima: No architecture policies found Nov 12 22:48:55.022195 kernel: clk: Disabling unused clocks Nov 12 22:48:55.022211 kernel: Freeing unused kernel image (initmem) memory: 42968K Nov 12 22:48:55.022233 kernel: Write protecting the kernel read-only data: 36864k Nov 12 22:48:55.022364 kernel: Freeing unused kernel image (rodata/data gap) memory: 1840K Nov 12 22:48:55.022384 kernel: Run /init as init process Nov 12 22:48:55.022400 kernel: with arguments: Nov 12 22:48:55.022415 kernel: /init Nov 12 22:48:55.022429 kernel: with environment: Nov 12 22:48:55.022443 kernel: HOME=/ Nov 12 22:48:55.022529 kernel: TERM=linux Nov 12 22:48:55.022912 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 12 22:48:55.022970 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Nov 12 22:48:55.023002 systemd[1]: Detected virtualization amazon. Nov 12 22:48:55.023047 systemd[1]: Detected architecture x86-64. Nov 12 22:48:55.023063 systemd[1]: Running in initrd. Nov 12 22:48:55.023078 systemd[1]: No hostname configured, using default hostname. Nov 12 22:48:55.023145 systemd[1]: Hostname set to . Nov 12 22:48:55.023293 systemd[1]: Initializing machine ID from VM UUID. Nov 12 22:48:55.023330 systemd[1]: Queued start job for default target initrd.target. Nov 12 22:48:55.023347 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 22:48:55.023730 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 22:48:55.023775 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 12 22:48:55.023791 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 12 22:48:55.023808 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 12 22:48:55.023829 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 12 22:48:55.023848 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Nov 12 22:48:55.024069 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Nov 12 22:48:55.024089 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 22:48:55.024105 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 12 22:48:55.024121 systemd[1]: Reached target paths.target - Path Units. Nov 12 22:48:55.024143 systemd[1]: Reached target slices.target - Slice Units. Nov 12 22:48:55.024159 systemd[1]: Reached target swap.target - Swaps. Nov 12 22:48:55.024175 systemd[1]: Reached target timers.target - Timer Units. Nov 12 22:48:55.024192 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 12 22:48:55.024208 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 12 22:48:55.024225 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 12 22:48:55.024242 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Nov 12 22:48:55.024259 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 12 22:48:55.024275 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 12 22:48:55.024296 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 22:48:55.024324 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 22:48:55.024341 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 12 22:48:55.024358 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 12 22:48:55.024375 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 12 22:48:55.024392 systemd[1]: Starting systemd-fsck-usr.service... Nov 12 22:48:55.024409 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 12 22:48:55.024430 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 12 22:48:55.024447 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:48:55.024464 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 12 22:48:55.024482 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 22:48:55.024536 systemd-journald[179]: Collecting audit messages is disabled. Nov 12 22:48:55.024577 systemd[1]: Finished systemd-fsck-usr.service. Nov 12 22:48:55.024595 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Nov 12 22:48:55.024620 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 12 22:48:55.024641 systemd-journald[179]: Journal started Nov 12 22:48:55.024712 systemd-journald[179]: Runtime Journal (/run/log/journal/ec25c77e643e38251d045a67b2380d2a) is 4.8M, max 38.6M, 33.7M free. Nov 12 22:48:55.038330 systemd[1]: Started systemd-journald.service - Journal Service. Nov 12 22:48:55.046503 systemd-modules-load[180]: Inserted module 'overlay' Nov 12 22:48:55.196645 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 12 22:48:55.196675 kernel: Bridge firewalling registered Nov 12 22:48:55.097203 systemd-modules-load[180]: Inserted module 'br_netfilter' Nov 12 22:48:55.098584 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 12 22:48:55.198118 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:48:55.202389 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 12 22:48:55.214733 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 22:48:55.230695 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 12 22:48:55.240394 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 12 22:48:55.248562 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 12 22:48:55.262695 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 12 22:48:55.277659 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:48:55.291533 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 12 22:48:55.294647 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 22:48:55.297216 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 22:48:55.307843 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 12 22:48:55.325597 dracut-cmdline[212]: dracut-dracut-053 Nov 12 22:48:55.329837 dracut-cmdline[212]: 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=714367a70d0d672ed3d7ccc2de5247f52d37046778a42409fc8a40b0511373b1 Nov 12 22:48:55.375184 systemd-resolved[215]: Positive Trust Anchors: Nov 12 22:48:55.375201 systemd-resolved[215]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 12 22:48:55.375261 systemd-resolved[215]: 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 Nov 12 22:48:55.391488 systemd-resolved[215]: Defaulting to hostname 'linux'. Nov 12 22:48:55.394348 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 12 22:48:55.397483 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 12 22:48:55.443339 kernel: SCSI subsystem initialized Nov 12 22:48:55.455415 kernel: Loading iSCSI transport class v2.0-870. Nov 12 22:48:55.469333 kernel: iscsi: registered transport (tcp) Nov 12 22:48:55.504501 kernel: iscsi: registered transport (qla4xxx) Nov 12 22:48:55.504586 kernel: QLogic iSCSI HBA Driver Nov 12 22:48:55.565781 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 12 22:48:55.578603 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 12 22:48:55.610413 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 12 22:48:55.610488 kernel: device-mapper: uevent: version 1.0.3 Nov 12 22:48:55.610510 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Nov 12 22:48:55.659344 kernel: raid6: avx512x4 gen() 12549 MB/s Nov 12 22:48:55.676353 kernel: raid6: avx512x2 gen() 14433 MB/s Nov 12 22:48:55.694382 kernel: raid6: avx512x1 gen() 14980 MB/s Nov 12 22:48:55.711346 kernel: raid6: avx2x4 gen() 13902 MB/s Nov 12 22:48:55.728546 kernel: raid6: avx2x2 gen() 9314 MB/s Nov 12 22:48:55.745356 kernel: raid6: avx2x1 gen() 10863 MB/s Nov 12 22:48:55.745497 kernel: raid6: using algorithm avx512x1 gen() 14980 MB/s Nov 12 22:48:55.762343 kernel: raid6: .... xor() 14448 MB/s, rmw enabled Nov 12 22:48:55.762427 kernel: raid6: using avx512x2 recovery algorithm Nov 12 22:48:55.789332 kernel: xor: automatically using best checksumming function avx Nov 12 22:48:55.999344 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 12 22:48:56.014551 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 12 22:48:56.028712 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 22:48:56.055113 systemd-udevd[398]: Using default interface naming scheme 'v255'. Nov 12 22:48:56.067798 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 22:48:56.081609 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 12 22:48:56.109646 dracut-pre-trigger[404]: rd.md=0: removing MD RAID activation Nov 12 22:48:56.150975 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 12 22:48:56.158722 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 12 22:48:56.242252 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 22:48:56.261571 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 12 22:48:56.309212 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 12 22:48:56.316394 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 12 22:48:56.316513 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 22:48:56.322842 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 12 22:48:56.331617 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 12 22:48:56.369834 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 12 22:48:56.374755 kernel: ena 0000:00:05.0: ENA device version: 0.10 Nov 12 22:48:56.405279 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Nov 12 22:48:56.405497 kernel: ena 0000:00:05.0: LLQ is not supported Fallback to host mode policy. Nov 12 22:48:56.405671 kernel: cryptd: max_cpu_qlen set to 1000 Nov 12 22:48:56.405694 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem febf4000, mac addr 06:2b:8a:55:68:5d Nov 12 22:48:56.414718 kernel: AVX2 version of gcm_enc/dec engaged. Nov 12 22:48:56.414818 kernel: AES CTR mode by8 optimization enabled Nov 12 22:48:56.419258 kernel: nvme nvme0: pci function 0000:00:04.0 Nov 12 22:48:56.419529 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11 Nov 12 22:48:56.429397 (udev-worker)[457]: Network interface NamePolicy= disabled on kernel command line. Nov 12 22:48:56.443361 kernel: nvme nvme0: 2/0/0 default/read/poll queues Nov 12 22:48:56.454578 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Nov 12 22:48:56.454647 kernel: GPT:9289727 != 16777215 Nov 12 22:48:56.454670 kernel: GPT:Alternate GPT header not at the end of the disk. Nov 12 22:48:56.454688 kernel: GPT:9289727 != 16777215 Nov 12 22:48:56.454707 kernel: GPT: Use GNU Parted to correct GPT errors. Nov 12 22:48:56.454725 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 12 22:48:56.453905 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 12 22:48:56.454058 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:48:56.458238 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 22:48:56.460054 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 12 22:48:56.461719 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:48:56.468235 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:48:56.477666 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:48:56.565402 kernel: BTRFS: device fsid d498af32-b44b-4318-a942-3a646ccb9d0a devid 1 transid 41 /dev/nvme0n1p3 scanned by (udev-worker) (454) Nov 12 22:48:56.584345 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by (udev-worker) (453) Nov 12 22:48:56.621767 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:48:56.631524 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 22:48:56.694973 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Nov 12 22:48:56.695361 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:48:56.706649 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Nov 12 22:48:56.713556 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Nov 12 22:48:56.719559 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Nov 12 22:48:56.719766 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Nov 12 22:48:56.732102 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 12 22:48:56.764211 disk-uuid[631]: Primary Header is updated. Nov 12 22:48:56.764211 disk-uuid[631]: Secondary Entries is updated. Nov 12 22:48:56.764211 disk-uuid[631]: Secondary Header is updated. Nov 12 22:48:56.773154 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 12 22:48:56.793337 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 12 22:48:57.797537 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 12 22:48:57.798976 disk-uuid[632]: The operation has completed successfully. Nov 12 22:48:57.990338 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 12 22:48:57.990469 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 12 22:48:58.030545 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Nov 12 22:48:58.035213 sh[890]: Success Nov 12 22:48:58.066430 kernel: device-mapper: verity: sha256 using implementation "sha256-avx2" Nov 12 22:48:58.182646 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Nov 12 22:48:58.201498 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Nov 12 22:48:58.207589 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Nov 12 22:48:58.260121 kernel: BTRFS info (device dm-0): first mount of filesystem d498af32-b44b-4318-a942-3a646ccb9d0a Nov 12 22:48:58.260193 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Nov 12 22:48:58.260213 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Nov 12 22:48:58.264386 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 12 22:48:58.264458 kernel: BTRFS info (device dm-0): using free space tree Nov 12 22:48:58.325333 kernel: BTRFS info (device dm-0): enabling ssd optimizations Nov 12 22:48:58.328366 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Nov 12 22:48:58.329466 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 12 22:48:58.349938 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 12 22:48:58.360457 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 12 22:48:58.370008 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 97a326f3-1974-446c-b178-9e746095347a Nov 12 22:48:58.370124 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Nov 12 22:48:58.370147 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 12 22:48:58.376398 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 12 22:48:58.393373 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 97a326f3-1974-446c-b178-9e746095347a Nov 12 22:48:58.393027 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 12 22:48:58.413214 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 12 22:48:58.431761 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 12 22:48:58.566895 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 12 22:48:58.578222 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 12 22:48:58.627234 systemd-networkd[1083]: lo: Link UP Nov 12 22:48:58.627903 systemd-networkd[1083]: lo: Gained carrier Nov 12 22:48:58.631238 systemd-networkd[1083]: Enumeration completed Nov 12 22:48:58.631727 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 12 22:48:58.634801 systemd[1]: Reached target network.target - Network. Nov 12 22:48:58.640369 systemd-networkd[1083]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:48:58.640379 systemd-networkd[1083]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 12 22:48:58.653051 systemd-networkd[1083]: eth0: Link UP Nov 12 22:48:58.653063 systemd-networkd[1083]: eth0: Gained carrier Nov 12 22:48:58.653080 systemd-networkd[1083]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:48:58.670471 systemd-networkd[1083]: eth0: DHCPv4 address 172.31.16.60/20, gateway 172.31.16.1 acquired from 172.31.16.1 Nov 12 22:48:58.759769 ignition[992]: Ignition 2.20.0 Nov 12 22:48:58.759783 ignition[992]: Stage: fetch-offline Nov 12 22:48:58.760027 ignition[992]: no configs at "/usr/lib/ignition/base.d" Nov 12 22:48:58.760041 ignition[992]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:48:58.760428 ignition[992]: Ignition finished successfully Nov 12 22:48:58.766228 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 12 22:48:58.775759 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Nov 12 22:48:58.792699 ignition[1091]: Ignition 2.20.0 Nov 12 22:48:58.792713 ignition[1091]: Stage: fetch Nov 12 22:48:58.793173 ignition[1091]: no configs at "/usr/lib/ignition/base.d" Nov 12 22:48:58.793183 ignition[1091]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:48:58.793989 ignition[1091]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:48:58.837053 ignition[1091]: PUT result: OK Nov 12 22:48:58.840755 ignition[1091]: parsed url from cmdline: "" Nov 12 22:48:58.840767 ignition[1091]: no config URL provided Nov 12 22:48:58.840777 ignition[1091]: reading system config file "/usr/lib/ignition/user.ign" Nov 12 22:48:58.840792 ignition[1091]: no config at "/usr/lib/ignition/user.ign" Nov 12 22:48:58.840815 ignition[1091]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:48:58.843211 ignition[1091]: PUT result: OK Nov 12 22:48:58.843276 ignition[1091]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Nov 12 22:48:58.846539 ignition[1091]: GET result: OK Nov 12 22:48:58.847336 ignition[1091]: parsing config with SHA512: 795ea894a057291b704a688b4afe69916e67a5b50ff7b65614213536b53c2a1cf8cde074611005b5503ba886dd6e8022ed123776251b43b5f86ace9421d1330f Nov 12 22:48:58.860641 unknown[1091]: fetched base config from "system" Nov 12 22:48:58.860691 unknown[1091]: fetched base config from "system" Nov 12 22:48:58.861041 ignition[1091]: fetch: fetch complete Nov 12 22:48:58.860703 unknown[1091]: fetched user config from "aws" Nov 12 22:48:58.861053 ignition[1091]: fetch: fetch passed Nov 12 22:48:58.865135 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Nov 12 22:48:58.861156 ignition[1091]: Ignition finished successfully Nov 12 22:48:58.873597 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 12 22:48:58.913331 ignition[1097]: Ignition 2.20.0 Nov 12 22:48:58.913346 ignition[1097]: Stage: kargs Nov 12 22:48:58.914988 ignition[1097]: no configs at "/usr/lib/ignition/base.d" Nov 12 22:48:58.915009 ignition[1097]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:48:58.915155 ignition[1097]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:48:58.916842 ignition[1097]: PUT result: OK Nov 12 22:48:58.922361 ignition[1097]: kargs: kargs passed Nov 12 22:48:58.922418 ignition[1097]: Ignition finished successfully Nov 12 22:48:58.927588 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 12 22:48:58.933487 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 12 22:48:58.956410 ignition[1103]: Ignition 2.20.0 Nov 12 22:48:58.956421 ignition[1103]: Stage: disks Nov 12 22:48:58.956722 ignition[1103]: no configs at "/usr/lib/ignition/base.d" Nov 12 22:48:58.956731 ignition[1103]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:48:58.956813 ignition[1103]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:48:58.961221 ignition[1103]: PUT result: OK Nov 12 22:48:58.965456 ignition[1103]: disks: disks passed Nov 12 22:48:58.965558 ignition[1103]: Ignition finished successfully Nov 12 22:48:58.967463 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 12 22:48:58.969559 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 12 22:48:58.971880 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 12 22:48:58.975177 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 12 22:48:58.978016 systemd[1]: Reached target sysinit.target - System Initialization. Nov 12 22:48:58.986572 systemd[1]: Reached target basic.target - Basic System. Nov 12 22:48:58.994526 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 12 22:48:59.019987 systemd-fsck[1112]: ROOT: clean, 14/553520 files, 52654/553472 blocks Nov 12 22:48:59.029478 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 12 22:48:59.042445 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 12 22:48:59.207325 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 62325592-ead9-4e81-b706-99baa0cf9fff r/w with ordered data mode. Quota mode: none. Nov 12 22:48:59.208077 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 12 22:48:59.211364 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 12 22:48:59.228424 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 12 22:48:59.242595 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 12 22:48:59.244800 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Nov 12 22:48:59.244845 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 12 22:48:59.244870 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 12 22:48:59.260192 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 12 22:48:59.268915 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 12 22:48:59.275657 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by mount (1131) Nov 12 22:48:59.275682 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 97a326f3-1974-446c-b178-9e746095347a Nov 12 22:48:59.275751 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Nov 12 22:48:59.275766 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 12 22:48:59.279325 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 12 22:48:59.281475 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 12 22:48:59.536996 initrd-setup-root[1155]: cut: /sysroot/etc/passwd: No such file or directory Nov 12 22:48:59.544343 initrd-setup-root[1162]: cut: /sysroot/etc/group: No such file or directory Nov 12 22:48:59.554195 initrd-setup-root[1169]: cut: /sysroot/etc/shadow: No such file or directory Nov 12 22:48:59.568394 initrd-setup-root[1176]: cut: /sysroot/etc/gshadow: No such file or directory Nov 12 22:48:59.771071 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 12 22:48:59.780505 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 12 22:48:59.786968 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 12 22:48:59.823091 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 12 22:48:59.825530 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 97a326f3-1974-446c-b178-9e746095347a Nov 12 22:48:59.858670 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 12 22:48:59.868694 ignition[1245]: INFO : Ignition 2.20.0 Nov 12 22:48:59.870045 ignition[1245]: INFO : Stage: mount Nov 12 22:48:59.870045 ignition[1245]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 22:48:59.870045 ignition[1245]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:48:59.870045 ignition[1245]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:48:59.875354 ignition[1245]: INFO : PUT result: OK Nov 12 22:48:59.879116 ignition[1245]: INFO : mount: mount passed Nov 12 22:48:59.880278 ignition[1245]: INFO : Ignition finished successfully Nov 12 22:48:59.880678 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 12 22:48:59.886452 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 12 22:48:59.911546 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 12 22:48:59.925329 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/nvme0n1p6 scanned by mount (1255) Nov 12 22:48:59.925394 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 97a326f3-1974-446c-b178-9e746095347a Nov 12 22:48:59.927572 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Nov 12 22:48:59.927645 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 12 22:48:59.933332 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 12 22:48:59.937450 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 12 22:48:59.975667 ignition[1272]: INFO : Ignition 2.20.0 Nov 12 22:48:59.975667 ignition[1272]: INFO : Stage: files Nov 12 22:48:59.977945 ignition[1272]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 22:48:59.977945 ignition[1272]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:48:59.977945 ignition[1272]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:48:59.981803 ignition[1272]: INFO : PUT result: OK Nov 12 22:48:59.986093 ignition[1272]: DEBUG : files: compiled without relabeling support, skipping Nov 12 22:48:59.987427 ignition[1272]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 12 22:48:59.987427 ignition[1272]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 12 22:49:00.007701 ignition[1272]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 12 22:49:00.009807 ignition[1272]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 12 22:49:00.011442 ignition[1272]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 12 22:49:00.009891 unknown[1272]: wrote ssh authorized keys file for user: core Nov 12 22:49:00.017651 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 12 22:49:00.026908 ignition[1272]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 12 22:49:00.026908 ignition[1272]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 12 22:49:00.026908 ignition[1272]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/var/lib/flatcar-install/user_data" Nov 12 22:49:00.026908 ignition[1272]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/var/lib/flatcar-install/user_data" Nov 12 22:49:00.026908 ignition[1272]: INFO : files: createResultFile: createFiles: op(5): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 12 22:49:00.026908 ignition[1272]: INFO : files: createResultFile: createFiles: op(5): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 12 22:49:00.026908 ignition[1272]: INFO : files: files passed Nov 12 22:49:00.026908 ignition[1272]: INFO : Ignition finished successfully Nov 12 22:49:00.037968 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 12 22:49:00.045647 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 12 22:49:00.054200 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 12 22:49:00.056169 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 12 22:49:00.073371 initrd-setup-root-after-ignition[1300]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 12 22:49:00.073371 initrd-setup-root-after-ignition[1300]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 12 22:49:00.080502 initrd-setup-root-after-ignition[1304]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 12 22:49:00.084771 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 12 22:49:00.088464 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 12 22:49:00.098881 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 12 22:49:00.163243 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 12 22:49:00.163414 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 12 22:49:00.164776 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 12 22:49:00.165708 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 12 22:49:00.166098 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 12 22:49:00.178712 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 12 22:49:00.194755 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 12 22:49:00.205713 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 12 22:49:00.289885 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 12 22:49:00.298802 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 22:49:00.309261 systemd[1]: Stopped target timers.target - Timer Units. Nov 12 22:49:00.311909 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 12 22:49:00.312218 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 12 22:49:00.321015 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 12 22:49:00.323675 systemd[1]: Stopped target basic.target - Basic System. Nov 12 22:49:00.325157 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 12 22:49:00.325267 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 12 22:49:00.325365 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 12 22:49:00.326034 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 12 22:49:00.326174 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 12 22:49:00.326371 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 12 22:49:00.326526 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 12 22:49:00.327218 systemd[1]: Stopped target swap.target - Swaps. Nov 12 22:49:00.327543 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 12 22:49:00.328362 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 12 22:49:00.329458 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 12 22:49:00.330455 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 22:49:00.331073 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 12 22:49:00.336442 systemd-networkd[1083]: eth0: Gained IPv6LL Nov 12 22:49:00.340711 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 22:49:00.342509 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 12 22:49:00.343818 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 12 22:49:00.352648 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 12 22:49:00.356113 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 12 22:49:00.362574 systemd[1]: ignition-files.service: Deactivated successfully. Nov 12 22:49:00.362708 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 12 22:49:00.370774 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 12 22:49:00.379591 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 12 22:49:00.382068 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 12 22:49:00.382316 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 22:49:00.384664 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 12 22:49:00.384857 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 12 22:49:00.417784 ignition[1324]: INFO : Ignition 2.20.0 Nov 12 22:49:00.417784 ignition[1324]: INFO : Stage: umount Nov 12 22:49:00.417784 ignition[1324]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 22:49:00.417784 ignition[1324]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:49:00.417784 ignition[1324]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:49:00.396064 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 12 22:49:00.425652 ignition[1324]: INFO : PUT result: OK Nov 12 22:49:00.396975 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 12 22:49:00.428087 ignition[1324]: INFO : umount: umount passed Nov 12 22:49:00.428087 ignition[1324]: INFO : Ignition finished successfully Nov 12 22:49:00.429138 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 12 22:49:00.429317 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 12 22:49:00.434022 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 12 22:49:00.434170 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 12 22:49:00.437560 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 12 22:49:00.437634 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 12 22:49:00.447773 systemd[1]: ignition-fetch.service: Deactivated successfully. Nov 12 22:49:00.447840 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Nov 12 22:49:00.456641 systemd[1]: Stopped target network.target - Network. Nov 12 22:49:00.467415 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 12 22:49:00.469008 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 12 22:49:00.475862 systemd[1]: Stopped target paths.target - Path Units. Nov 12 22:49:00.481733 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 12 22:49:00.481819 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 22:49:00.490482 systemd[1]: Stopped target slices.target - Slice Units. Nov 12 22:49:00.491900 systemd[1]: Stopped target sockets.target - Socket Units. Nov 12 22:49:00.505654 systemd[1]: iscsid.socket: Deactivated successfully. Nov 12 22:49:00.505722 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 12 22:49:00.514633 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 12 22:49:00.514724 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 12 22:49:00.517475 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 12 22:49:00.517646 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 12 22:49:00.519333 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 12 22:49:00.520614 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 12 22:49:00.525398 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 12 22:49:00.531569 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 12 22:49:00.536431 systemd-networkd[1083]: eth0: DHCPv6 lease lost Nov 12 22:49:00.538997 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 12 22:49:00.540584 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 12 22:49:00.540708 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 12 22:49:00.547528 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 12 22:49:00.547739 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 12 22:49:00.557901 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 12 22:49:00.558268 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 12 22:49:00.578893 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 12 22:49:00.578975 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 12 22:49:00.581435 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 12 22:49:00.581527 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 12 22:49:00.589688 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 12 22:49:00.591093 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 12 22:49:00.591173 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 12 22:49:00.596572 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 12 22:49:00.596648 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 12 22:49:00.610084 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 12 22:49:00.610163 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 12 22:49:00.611592 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 12 22:49:00.611651 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 22:49:00.619699 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 22:49:00.658840 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 12 22:49:00.659038 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 22:49:00.664220 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 12 22:49:00.664277 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 12 22:49:00.664418 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 12 22:49:00.664488 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 22:49:00.668543 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 12 22:49:00.668608 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 12 22:49:00.677410 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 12 22:49:00.677599 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 12 22:49:00.679738 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 12 22:49:00.679817 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:49:00.692512 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 12 22:49:00.692600 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 12 22:49:00.695838 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 22:49:00.697452 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Nov 12 22:49:00.697534 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 12 22:49:00.698950 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 12 22:49:00.699021 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 22:49:00.700445 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 12 22:49:00.700506 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:49:00.704399 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 12 22:49:00.704653 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 12 22:49:00.714383 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 12 22:49:00.714607 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 12 22:49:00.720319 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 12 22:49:00.758376 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 12 22:49:00.790020 systemd[1]: Switching root. Nov 12 22:49:00.830740 systemd-journald[179]: Journal stopped Nov 12 22:49:03.898490 systemd-journald[179]: Received SIGTERM from PID 1 (systemd). Nov 12 22:49:03.898592 kernel: SELinux: policy capability network_peer_controls=1 Nov 12 22:49:03.898615 kernel: SELinux: policy capability open_perms=1 Nov 12 22:49:03.898641 kernel: SELinux: policy capability extended_socket_class=1 Nov 12 22:49:03.898663 kernel: SELinux: policy capability always_check_network=0 Nov 12 22:49:03.898679 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 12 22:49:03.898696 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 12 22:49:03.898713 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 12 22:49:03.898730 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 12 22:49:03.898752 kernel: audit: type=1403 audit(1731451741.090:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 12 22:49:03.898774 systemd[1]: Successfully loaded SELinux policy in 44.916ms. Nov 12 22:49:03.898802 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 18.387ms. Nov 12 22:49:03.898823 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Nov 12 22:49:03.898847 systemd[1]: Detected virtualization amazon. Nov 12 22:49:03.898866 systemd[1]: Detected architecture x86-64. Nov 12 22:49:03.898885 systemd[1]: Detected first boot. Nov 12 22:49:03.898902 systemd[1]: Initializing machine ID from VM UUID. Nov 12 22:49:03.898920 zram_generator::config[1367]: No configuration found. Nov 12 22:49:03.898939 systemd[1]: Populated /etc with preset unit settings. Nov 12 22:49:03.898957 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 12 22:49:03.898977 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 12 22:49:03.898998 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 12 22:49:03.899020 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 12 22:49:03.899041 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 12 22:49:03.899066 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 12 22:49:03.899087 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 12 22:49:03.899107 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 12 22:49:03.899127 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 12 22:49:03.899145 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 12 22:49:03.899295 systemd[1]: Created slice user.slice - User and Session Slice. Nov 12 22:49:03.906865 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 22:49:03.906900 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 22:49:03.906922 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 12 22:49:03.907035 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 12 22:49:03.907070 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 12 22:49:03.907092 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 12 22:49:03.907110 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Nov 12 22:49:03.907130 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 22:49:03.907154 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 12 22:49:03.907177 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 12 22:49:03.907199 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 12 22:49:03.907223 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 12 22:49:03.907245 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 22:49:03.907265 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 12 22:49:03.907284 systemd[1]: Reached target slices.target - Slice Units. Nov 12 22:49:03.907333 systemd[1]: Reached target swap.target - Swaps. Nov 12 22:49:03.907354 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 12 22:49:03.907375 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 12 22:49:03.907394 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 12 22:49:03.907413 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 12 22:49:03.907433 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 22:49:03.907513 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 12 22:49:03.907534 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 12 22:49:03.907555 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 12 22:49:03.907575 systemd[1]: Mounting media.mount - External Media Directory... Nov 12 22:49:03.907595 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 12 22:49:03.907614 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 12 22:49:03.907640 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 12 22:49:03.907660 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 12 22:49:03.907685 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). Nov 12 22:49:03.907706 systemd[1]: Reached target machines.target - Containers. Nov 12 22:49:03.907726 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 12 22:49:03.907746 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:49:03.907770 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 12 22:49:03.907791 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 12 22:49:03.907811 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 22:49:03.907832 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 12 22:49:03.907852 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 12 22:49:03.907875 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 12 22:49:03.907895 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 12 22:49:03.907915 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 12 22:49:03.907936 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 12 22:49:03.907957 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 12 22:49:03.907977 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 12 22:49:03.907997 systemd[1]: Stopped systemd-fsck-usr.service. Nov 12 22:49:03.908018 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 12 22:49:03.908041 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 12 22:49:03.908061 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 12 22:49:03.908082 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 12 22:49:03.908104 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 12 22:49:03.908125 systemd[1]: verity-setup.service: Deactivated successfully. Nov 12 22:49:03.908146 systemd[1]: Stopped verity-setup.service. Nov 12 22:49:03.908223 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 12 22:49:03.908295 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 12 22:49:03.909276 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 12 22:49:03.909471 systemd[1]: Mounted media.mount - External Media Directory. Nov 12 22:49:03.909504 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 12 22:49:03.909527 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 12 22:49:03.909549 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 12 22:49:03.912413 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 22:49:03.912450 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 12 22:49:03.912469 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 12 22:49:03.912487 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 22:49:03.912507 kernel: loop: module loaded Nov 12 22:49:03.912528 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 22:49:03.912548 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 12 22:49:03.912567 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 12 22:49:03.912586 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 12 22:49:03.912612 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 12 22:49:03.912636 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 12 22:49:03.912655 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 12 22:49:03.912675 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 12 22:49:03.912697 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 12 22:49:03.912719 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Nov 12 22:49:03.912742 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 12 22:49:03.912763 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 12 22:49:03.912782 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:49:03.912800 kernel: fuse: init (API version 7.39) Nov 12 22:49:03.912859 systemd-journald[1446]: Collecting audit messages is disabled. Nov 12 22:49:03.912899 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 12 22:49:03.912921 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 12 22:49:03.912945 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 12 22:49:03.912968 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 12 22:49:03.912989 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 22:49:03.913012 systemd-journald[1446]: Journal started Nov 12 22:49:03.913612 systemd-journald[1446]: Runtime Journal (/run/log/journal/ec25c77e643e38251d045a67b2380d2a) is 4.8M, max 38.6M, 33.7M free. Nov 12 22:49:03.035738 systemd[1]: Queued start job for default target multi-user.target. Nov 12 22:49:03.059171 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Nov 12 22:49:03.060085 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 12 22:49:03.979923 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 12 22:49:03.979994 systemd[1]: Started systemd-journald.service - Journal Service. Nov 12 22:49:03.945070 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 12 22:49:03.951569 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 12 22:49:03.958901 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 12 22:49:03.965810 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 12 22:49:04.006997 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 12 22:49:04.008434 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 12 22:49:04.024466 kernel: ACPI: bus type drm_connector registered Nov 12 22:49:04.023972 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 12 22:49:04.025450 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 12 22:49:04.068365 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 12 22:49:04.075117 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 12 22:49:04.078463 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 12 22:49:04.096514 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 12 22:49:04.112944 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 12 22:49:04.127989 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Nov 12 22:49:04.148544 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 12 22:49:04.165276 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 12 22:49:04.227150 kernel: loop0: detected capacity change from 0 to 140992 Nov 12 22:49:04.227382 systemd-journald[1446]: Time spent on flushing to /var/log/journal/ec25c77e643e38251d045a67b2380d2a is 145.929ms for 941 entries. Nov 12 22:49:04.227382 systemd-journald[1446]: System Journal (/var/log/journal/ec25c77e643e38251d045a67b2380d2a) is 8.0M, max 195.6M, 187.6M free. Nov 12 22:49:04.382015 systemd-journald[1446]: Received client request to flush runtime journal. Nov 12 22:49:04.382110 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 12 22:49:04.382148 kernel: loop1: detected capacity change from 0 to 138184 Nov 12 22:49:04.251439 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 12 22:49:04.256258 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 22:49:04.272539 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Nov 12 22:49:04.316000 systemd-tmpfiles[1467]: ACLs are not supported, ignoring. Nov 12 22:49:04.316021 systemd-tmpfiles[1467]: ACLs are not supported, ignoring. Nov 12 22:49:04.334484 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 12 22:49:04.342746 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 12 22:49:04.355701 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 12 22:49:04.361553 udevadm[1504]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Nov 12 22:49:04.392521 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 12 22:49:04.450479 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 12 22:49:04.455122 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Nov 12 22:49:04.461586 kernel: loop2: detected capacity change from 0 to 62848 Nov 12 22:49:04.473221 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 12 22:49:04.489832 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 12 22:49:04.546525 kernel: loop3: detected capacity change from 0 to 140992 Nov 12 22:49:04.557674 systemd-tmpfiles[1518]: ACLs are not supported, ignoring. Nov 12 22:49:04.557862 systemd-tmpfiles[1518]: ACLs are not supported, ignoring. Nov 12 22:49:04.584919 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 22:49:04.633347 kernel: loop4: detected capacity change from 0 to 138184 Nov 12 22:49:04.675333 kernel: loop5: detected capacity change from 0 to 62848 Nov 12 22:49:04.682218 (sd-merge)[1521]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Nov 12 22:49:04.683252 (sd-merge)[1521]: Merged extensions into '/usr'. Nov 12 22:49:04.691577 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 22:49:04.703817 systemd[1]: Starting ensure-sysext.service... Nov 12 22:49:04.718745 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 12 22:49:04.749508 systemd[1]: Reloading requested from client PID 1525 ('systemctl') (unit ensure-sysext.service)... Nov 12 22:49:04.749528 systemd[1]: Reloading... Nov 12 22:49:04.795788 systemd-tmpfiles[1526]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 12 22:49:04.799211 systemd-tmpfiles[1526]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 12 22:49:04.802287 systemd-tmpfiles[1526]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 12 22:49:04.802953 systemd-tmpfiles[1526]: ACLs are not supported, ignoring. Nov 12 22:49:04.803043 systemd-tmpfiles[1526]: ACLs are not supported, ignoring. Nov 12 22:49:04.810449 systemd-tmpfiles[1526]: Detected autofs mount point /boot during canonicalization of boot. Nov 12 22:49:04.810791 systemd-tmpfiles[1526]: Skipping /boot Nov 12 22:49:04.830715 systemd-tmpfiles[1526]: Detected autofs mount point /boot during canonicalization of boot. Nov 12 22:49:04.830872 systemd-tmpfiles[1526]: Skipping /boot Nov 12 22:49:04.952438 zram_generator::config[1554]: No configuration found. Nov 12 22:49:05.174060 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. Nov 12 22:49:05.317082 systemd[1]: Reloading finished in 566 ms. Nov 12 22:49:05.358904 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 22:49:05.388542 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 12 22:49:05.401556 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 12 22:49:05.412705 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 12 22:49:05.426906 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 12 22:49:05.434011 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 12 22:49:05.452373 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 12 22:49:05.452666 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:49:05.462373 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 22:49:05.469755 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 12 22:49:05.474694 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 12 22:49:05.479466 ldconfig[1460]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 12 22:49:05.476984 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:49:05.477401 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 12 22:49:05.483679 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 22:49:05.484531 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 22:49:05.488188 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 12 22:49:05.490687 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:49:05.490958 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:49:05.491122 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 12 22:49:05.502464 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 12 22:49:05.514479 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 12 22:49:05.514969 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:49:05.524576 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 22:49:05.536194 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 12 22:49:05.538768 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:49:05.539259 systemd[1]: Reached target time-set.target - System Time Set. Nov 12 22:49:05.542206 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 12 22:49:05.564611 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 12 22:49:05.567442 systemd[1]: Finished ensure-sysext.service. Nov 12 22:49:05.569765 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 12 22:49:05.571757 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 12 22:49:05.572029 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 12 22:49:05.574043 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 12 22:49:05.574230 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 12 22:49:05.577374 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 22:49:05.577571 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 22:49:05.581873 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 12 22:49:05.582076 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 12 22:49:05.599166 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 12 22:49:05.600920 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 12 22:49:05.625165 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 12 22:49:05.655855 augenrules[1643]: No rules Nov 12 22:49:05.656999 systemd[1]: audit-rules.service: Deactivated successfully. Nov 12 22:49:05.657526 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 12 22:49:05.681103 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 12 22:49:05.698284 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 12 22:49:05.700153 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). Nov 12 22:49:05.782540 systemd-resolved[1607]: Positive Trust Anchors: Nov 12 22:49:05.782923 systemd-resolved[1607]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 12 22:49:05.783049 systemd-resolved[1607]: 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 Nov 12 22:49:05.789999 systemd-resolved[1607]: Defaulting to hostname 'linux'. Nov 12 22:49:05.793002 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 12 22:49:05.794635 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 12 22:49:06.051245 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 12 22:49:06.058555 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 22:49:06.062515 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 12 22:49:06.088742 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 12 22:49:06.102582 systemd-udevd[1656]: Using default interface naming scheme 'v255'. Nov 12 22:49:06.124869 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 22:49:06.136291 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 12 22:49:06.216698 (udev-worker)[1665]: Network interface NamePolicy= disabled on kernel command line. Nov 12 22:49:06.244333 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1673) Nov 12 22:49:06.245922 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Nov 12 22:49:06.251395 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1673) Nov 12 22:49:06.261417 systemd-networkd[1664]: lo: Link UP Nov 12 22:49:06.261808 systemd-networkd[1664]: lo: Gained carrier Nov 12 22:49:06.265827 systemd-networkd[1664]: Enumeration completed Nov 12 22:49:06.266141 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 12 22:49:06.267647 systemd[1]: Reached target network.target - Network. Nov 12 22:49:06.268275 systemd-networkd[1664]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:49:06.268526 systemd-networkd[1664]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 12 22:49:06.278494 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 12 22:49:06.278976 systemd-networkd[1664]: eth0: Link UP Nov 12 22:49:06.279142 systemd-networkd[1664]: eth0: Gained carrier Nov 12 22:49:06.279169 systemd-networkd[1664]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:49:06.291615 systemd-networkd[1664]: eth0: DHCPv4 address 172.31.16.60/20, gateway 172.31.16.1 acquired from 172.31.16.1 Nov 12 22:49:06.306620 systemd-networkd[1664]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:49:06.340359 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Nov 12 22:49:06.342324 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0xb100, revision 255 Nov 12 22:49:06.344798 kernel: ACPI: button: Power Button [PWRF] Nov 12 22:49:06.344863 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input3 Nov 12 22:49:06.350329 kernel: ACPI: button: Sleep Button [SLPF] Nov 12 22:49:06.369406 kernel: input: ImPS/2 Generic Wheel Mouse as /devices/platform/i8042/serio1/input/input4 Nov 12 22:49:06.407371 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (1665) Nov 12 22:49:06.445360 kernel: mousedev: PS/2 mouse device common for all mice Nov 12 22:49:06.453751 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:49:06.573465 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Nov 12 22:49:06.580898 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 12 22:49:06.583917 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Nov 12 22:49:06.598662 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Nov 12 22:49:06.745598 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:49:06.751439 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 12 22:49:06.765668 lvm[1777]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 12 22:49:06.797560 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Nov 12 22:49:06.799570 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 12 22:49:06.800905 systemd[1]: Reached target sysinit.target - System Initialization. Nov 12 22:49:06.802355 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 12 22:49:06.804990 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 12 22:49:06.808300 systemd[1]: Created slice system-user\x2dcloudinit.slice - Slice /system/user-cloudinit. Nov 12 22:49:06.810203 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 12 22:49:06.812651 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 12 22:49:06.818267 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 12 22:49:06.821023 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 12 22:49:06.821079 systemd[1]: Reached target paths.target - Path Units. Nov 12 22:49:06.823159 systemd[1]: Reached target timers.target - Timer Units. Nov 12 22:49:06.826071 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 12 22:49:06.829589 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 12 22:49:06.838610 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 12 22:49:06.849877 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Nov 12 22:49:06.855144 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 12 22:49:06.857667 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 22:49:06.859165 systemd[1]: Reached target basic.target - Basic System. Nov 12 22:49:06.860675 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 12 22:49:06.860732 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 12 22:49:06.868820 systemd[1]: Starting containerd.service - containerd container runtime... Nov 12 22:49:06.878439 lvm[1784]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 12 22:49:06.891339 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Nov 12 22:49:06.901823 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 12 22:49:06.920871 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 12 22:49:06.932581 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 12 22:49:06.937744 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). Nov 12 22:49:06.958245 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 12 22:49:06.983013 systemd[1]: Started ntpd.service - Network Time Service. Nov 12 22:49:06.987486 systemd[1]: Starting setup-oem.service - Setup OEM... Nov 12 22:49:06.992402 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 12 22:49:06.997968 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 12 22:49:07.027152 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 12 22:49:07.029208 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 12 22:49:07.029959 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 12 22:49:07.031506 systemd[1]: Starting update-engine.service - Update Engine... Nov 12 22:49:07.046089 jq[1788]: false Nov 12 22:49:07.041130 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 12 22:49:07.043872 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Nov 12 22:49:07.058116 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 12 22:49:07.058372 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 12 22:49:07.082107 extend-filesystems[1789]: Found loop3 Nov 12 22:49:07.087531 extend-filesystems[1789]: Found loop4 Nov 12 22:49:07.087531 extend-filesystems[1789]: Found loop5 Nov 12 22:49:07.087531 extend-filesystems[1789]: Found nvme0n1 Nov 12 22:49:07.087531 extend-filesystems[1789]: Found nvme0n1p4 Nov 12 22:49:07.087531 extend-filesystems[1789]: Found nvme0n1p6 Nov 12 22:49:07.087531 extend-filesystems[1789]: Found nvme0n1p7 Nov 12 22:49:07.087531 extend-filesystems[1789]: Found nvme0n1p9 Nov 12 22:49:07.087531 extend-filesystems[1789]: Checking size of /dev/nvme0n1p9 Nov 12 22:49:07.119410 jq[1802]: true Nov 12 22:49:07.114143 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 12 22:49:07.114792 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 12 22:49:07.144369 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: ntpd 4.2.8p17@1.4004-o Tue Nov 12 20:42:53 UTC 2024 (1): Starting Nov 12 22:49:07.144369 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Nov 12 22:49:07.144369 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: ---------------------------------------------------- Nov 12 22:49:07.144369 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: ntp-4 is maintained by Network Time Foundation, Nov 12 22:49:07.144369 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Nov 12 22:49:07.144369 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: corporation. Support and training for ntp-4 are Nov 12 22:49:07.144369 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: available at https://www.nwtime.org/support Nov 12 22:49:07.144369 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: ---------------------------------------------------- Nov 12 22:49:07.142565 ntpd[1791]: ntpd 4.2.8p17@1.4004-o Tue Nov 12 20:42:53 UTC 2024 (1): Starting Nov 12 22:49:07.147512 update_engine[1800]: I20241112 22:49:07.137692 1800 main.cc:92] Flatcar Update Engine starting Nov 12 22:49:07.146762 (ntainerd)[1815]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Nov 12 22:49:07.142591 ntpd[1791]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Nov 12 22:49:07.142601 ntpd[1791]: ---------------------------------------------------- Nov 12 22:49:07.142611 ntpd[1791]: ntp-4 is maintained by Network Time Foundation, Nov 12 22:49:07.161741 jq[1821]: true Nov 12 22:49:07.142622 ntpd[1791]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Nov 12 22:49:07.142631 ntpd[1791]: corporation. Support and training for ntp-4 are Nov 12 22:49:07.142641 ntpd[1791]: available at https://www.nwtime.org/support Nov 12 22:49:07.142652 ntpd[1791]: ---------------------------------------------------- Nov 12 22:49:07.163458 systemd[1]: motdgen.service: Deactivated successfully. Nov 12 22:49:07.163849 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 12 22:49:07.166026 ntpd[1791]: proto: precision = 0.069 usec (-24) Nov 12 22:49:07.172438 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: proto: precision = 0.069 usec (-24) Nov 12 22:49:07.170021 dbus-daemon[1787]: [system] SELinux support is enabled Nov 12 22:49:07.182486 ntpd[1791]: basedate set to 2024-10-31 Nov 12 22:49:07.207176 update_engine[1800]: I20241112 22:49:07.203630 1800 update_check_scheduler.cc:74] Next update check in 3m49s Nov 12 22:49:07.174718 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 12 22:49:07.209648 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: basedate set to 2024-10-31 Nov 12 22:49:07.209648 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: gps base set to 2024-11-03 (week 2339) Nov 12 22:49:07.182510 ntpd[1791]: gps base set to 2024-11-03 (week 2339) Nov 12 22:49:07.195218 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). Nov 12 22:49:07.209986 extend-filesystems[1789]: Resized partition /dev/nvme0n1p9 Nov 12 22:49:07.184696 dbus-daemon[1787]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1664 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Nov 12 22:49:07.195280 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 12 22:49:07.216236 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: Listen and drop on 0 v6wildcard [::]:123 Nov 12 22:49:07.216236 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 12 22:49:07.197847 dbus-daemon[1787]: [system] Successfully activated service 'org.freedesktop.systemd1' Nov 12 22:49:07.197565 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). Nov 12 22:49:07.214283 ntpd[1791]: Listen and drop on 0 v6wildcard [::]:123 Nov 12 22:49:07.205525 systemd[1]: Starting user-cloudinit@var-lib-flatcar\x2dinstall-user_data.service - Load cloud-config from /var/lib/flatcar-install/user_data... Nov 12 22:49:07.214361 ntpd[1791]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 12 22:49:07.213237 systemd[1]: Started update-engine.service - Update Engine. Nov 12 22:49:07.219925 ntpd[1791]: Listen normally on 2 lo 127.0.0.1:123 Nov 12 22:49:07.225787 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: Listen normally on 2 lo 127.0.0.1:123 Nov 12 22:49:07.225787 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: Listen normally on 3 eth0 172.31.16.60:123 Nov 12 22:49:07.225787 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: Listen normally on 4 lo [::1]:123 Nov 12 22:49:07.225787 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: bind(21) AF_INET6 fe80::42b:8aff:fe55:685d%2#123 flags 0x11 failed: Cannot assign requested address Nov 12 22:49:07.225787 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: unable to create socket on eth0 (5) for fe80::42b:8aff:fe55:685d%2#123 Nov 12 22:49:07.225787 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: failed to init interface for address fe80::42b:8aff:fe55:685d%2 Nov 12 22:49:07.225787 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: Listening on routing socket on fd #21 for interface updates Nov 12 22:49:07.219978 ntpd[1791]: Listen normally on 3 eth0 172.31.16.60:123 Nov 12 22:49:07.220020 ntpd[1791]: Listen normally on 4 lo [::1]:123 Nov 12 22:49:07.220071 ntpd[1791]: bind(21) AF_INET6 fe80::42b:8aff:fe55:685d%2#123 flags 0x11 failed: Cannot assign requested address Nov 12 22:49:07.220093 ntpd[1791]: unable to create socket on eth0 (5) for fe80::42b:8aff:fe55:685d%2#123 Nov 12 22:49:07.220110 ntpd[1791]: failed to init interface for address fe80::42b:8aff:fe55:685d%2 Nov 12 22:49:07.220145 ntpd[1791]: Listening on routing socket on fd #21 for interface updates Nov 12 22:49:07.232130 extend-filesystems[1834]: resize2fs 1.47.1 (20-May-2024) Nov 12 22:49:07.237981 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Nov 12 22:49:07.236511 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 12 22:49:07.240207 ntpd[1791]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 12 22:49:07.240254 ntpd[1791]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 12 22:49:07.240470 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 12 22:49:07.240470 ntpd[1791]: 12 Nov 22:49:07 ntpd[1791]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 12 22:49:07.248533 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Nov 12 22:49:07.256666 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 12 22:49:07.289538 systemd[1]: Finished setup-oem.service - Setup OEM. Nov 12 22:49:07.378378 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Nov 12 22:49:07.378454 coreos-cloudinit[1831]: 2024/11/12 22:49:07 Checking availability of "local-file" Nov 12 22:49:07.378454 coreos-cloudinit[1831]: 2024/11/12 22:49:07 Fetching meta-data from datasource of type "local-file" Nov 12 22:49:07.378454 coreos-cloudinit[1831]: 2024/11/12 22:49:07 Fetching user-data from datasource of type "local-file" Nov 12 22:49:07.396131 extend-filesystems[1834]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Nov 12 22:49:07.396131 extend-filesystems[1834]: old_desc_blocks = 1, new_desc_blocks = 1 Nov 12 22:49:07.396131 extend-filesystems[1834]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Nov 12 22:49:07.391776 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 12 22:49:07.401626 extend-filesystems[1789]: Resized filesystem in /dev/nvme0n1p9 Nov 12 22:49:07.401626 extend-filesystems[1789]: Found nvme0n1p1 Nov 12 22:49:07.401626 extend-filesystems[1789]: Found nvme0n1p2 Nov 12 22:49:07.401626 extend-filesystems[1789]: Found nvme0n1p3 Nov 12 22:49:07.401626 extend-filesystems[1789]: Found usr Nov 12 22:49:07.392046 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 12 22:49:07.412201 coreos-metadata[1786]: Nov 12 22:49:07.412 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Nov 12 22:49:07.412201 coreos-metadata[1786]: Nov 12 22:49:07.412 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Nov 12 22:49:07.413836 coreos-metadata[1786]: Nov 12 22:49:07.412 INFO Fetch successful Nov 12 22:49:07.413836 coreos-metadata[1786]: Nov 12 22:49:07.412 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Nov 12 22:49:07.414998 coreos-metadata[1786]: Nov 12 22:49:07.414 INFO Fetch successful Nov 12 22:49:07.414998 coreos-metadata[1786]: Nov 12 22:49:07.414 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Nov 12 22:49:07.422878 coreos-metadata[1786]: Nov 12 22:49:07.422 INFO Fetch successful Nov 12 22:49:07.422878 coreos-metadata[1786]: Nov 12 22:49:07.422 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Nov 12 22:49:07.429617 coreos-metadata[1786]: Nov 12 22:49:07.425 INFO Fetch successful Nov 12 22:49:07.429617 coreos-metadata[1786]: Nov 12 22:49:07.425 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Nov 12 22:49:07.436572 systemd-logind[1796]: Watching system buttons on /dev/input/event1 (Power Button) Nov 12 22:49:07.438715 coreos-metadata[1786]: Nov 12 22:49:07.437 INFO Fetch failed with 404: resource not found Nov 12 22:49:07.438715 coreos-metadata[1786]: Nov 12 22:49:07.437 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Nov 12 22:49:07.436644 systemd-logind[1796]: Watching system buttons on /dev/input/event2 (Sleep Button) Nov 12 22:49:07.436675 systemd-logind[1796]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Nov 12 22:49:07.439458 systemd-logind[1796]: New seat seat0. Nov 12 22:49:07.440950 coreos-metadata[1786]: Nov 12 22:49:07.439 INFO Fetch successful Nov 12 22:49:07.440950 coreos-metadata[1786]: Nov 12 22:49:07.439 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Nov 12 22:49:07.440950 coreos-metadata[1786]: Nov 12 22:49:07.440 INFO Fetch successful Nov 12 22:49:07.440950 coreos-metadata[1786]: Nov 12 22:49:07.440 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Nov 12 22:49:07.450941 coreos-metadata[1786]: Nov 12 22:49:07.442 INFO Fetch successful Nov 12 22:49:07.450941 coreos-metadata[1786]: Nov 12 22:49:07.442 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Nov 12 22:49:07.446882 systemd[1]: Started systemd-logind.service - User Login Management. Nov 12 22:49:07.451764 coreos-metadata[1786]: Nov 12 22:49:07.451 INFO Fetch successful Nov 12 22:49:07.451764 coreos-metadata[1786]: Nov 12 22:49:07.451 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Nov 12 22:49:07.460846 coreos-metadata[1786]: Nov 12 22:49:07.459 INFO Fetch successful Nov 12 22:49:07.500863 bash[1868]: Updated "/home/core/.ssh/authorized_keys" Nov 12 22:49:07.501678 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 12 22:49:07.545936 systemd[1]: Starting sshkeys.service... Nov 12 22:49:07.567453 systemd-networkd[1664]: eth0: Gained IPv6LL Nov 12 22:49:07.578955 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 12 22:49:07.589778 systemd[1]: Reached target network-online.target - Network is Online. Nov 12 22:49:07.600691 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Nov 12 22:49:07.615640 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 12 22:49:07.638779 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (1662) Nov 12 22:49:07.645704 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Nov 12 22:49:07.668544 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Nov 12 22:49:07.671093 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Nov 12 22:49:07.676047 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 12 22:49:07.700221 dbus-daemon[1787]: [system] Successfully activated service 'org.freedesktop.hostname1' Nov 12 22:49:07.702124 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Nov 12 22:49:07.711672 dbus-daemon[1787]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1837 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Nov 12 22:49:07.720746 systemd[1]: Starting polkit.service - Authorization Manager... Nov 12 22:49:07.734065 systemd-hostnamed[1837]: Hostname set to (static) Nov 12 22:49:07.734066 systemd-resolved[1607]: System hostname changed to 'cloud-config-worked'. Nov 12 22:49:07.748339 coreos-cloudinit[1831]: 2024/11/12 22:49:07 Set hostname to cloud-config-worked Nov 12 22:49:07.748339 coreos-cloudinit[1831]: 2024/11/12 22:49:07 Running part "cloud-config.yaml" (cloud-config) Nov 12 22:49:07.748339 coreos-cloudinit[1831]: 2024/11/12 22:49:07 Ensuring runtime unit file "etcd.service" is unmasked Nov 12 22:49:07.748339 coreos-cloudinit[1831]: 2024/11/12 22:49:07 Ensuring runtime unit file "etcd2.service" is unmasked Nov 12 22:49:07.748339 coreos-cloudinit[1831]: 2024/11/12 22:49:07 Ensuring runtime unit file "fleet.service" is unmasked Nov 12 22:49:07.748339 coreos-cloudinit[1831]: 2024/11/12 22:49:07 Ensuring runtime unit file "locksmithd.service" is unmasked Nov 12 22:49:07.760190 systemd[1]: Finished user-cloudinit@var-lib-flatcar\x2dinstall-user_data.service - Load cloud-config from /var/lib/flatcar-install/user_data. Nov 12 22:49:07.763222 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 12 22:49:07.812238 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 12 22:49:07.813851 polkitd[1913]: Started polkitd version 121 Nov 12 22:49:07.862665 polkitd[1913]: Loading rules from directory /etc/polkit-1/rules.d Nov 12 22:49:07.862893 polkitd[1913]: Loading rules from directory /usr/share/polkit-1/rules.d Nov 12 22:49:07.863555 polkitd[1913]: Finished loading, compiling and executing 2 rules Nov 12 22:49:07.864161 dbus-daemon[1787]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Nov 12 22:49:07.864366 systemd[1]: Started polkit.service - Authorization Manager. Nov 12 22:49:07.867209 polkitd[1913]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Nov 12 22:49:07.945798 amazon-ssm-agent[1877]: Initializing new seelog logger Nov 12 22:49:07.946499 locksmithd[1838]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 12 22:49:07.949526 amazon-ssm-agent[1877]: New Seelog Logger Creation Complete Nov 12 22:49:07.949526 amazon-ssm-agent[1877]: 2024/11/12 22:49:07 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:49:07.949526 amazon-ssm-agent[1877]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:49:07.949526 amazon-ssm-agent[1877]: 2024/11/12 22:49:07 processing appconfig overrides Nov 12 22:49:07.953333 amazon-ssm-agent[1877]: 2024/11/12 22:49:07 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:49:07.953333 amazon-ssm-agent[1877]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:49:07.953333 amazon-ssm-agent[1877]: 2024/11/12 22:49:07 processing appconfig overrides Nov 12 22:49:07.953333 amazon-ssm-agent[1877]: 2024/11/12 22:49:07 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:49:07.953333 amazon-ssm-agent[1877]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:49:07.953333 amazon-ssm-agent[1877]: 2024/11/12 22:49:07 processing appconfig overrides Nov 12 22:49:07.953594 coreos-metadata[1884]: Nov 12 22:49:07.950 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Nov 12 22:49:07.953594 coreos-metadata[1884]: Nov 12 22:49:07.952 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Nov 12 22:49:07.953594 coreos-metadata[1884]: Nov 12 22:49:07.953 INFO Fetch successful Nov 12 22:49:07.953594 coreos-metadata[1884]: Nov 12 22:49:07.953 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Nov 12 22:49:07.956318 coreos-metadata[1884]: Nov 12 22:49:07.955 INFO Fetch successful Nov 12 22:49:07.966248 amazon-ssm-agent[1877]: 2024-11-12 22:49:07 INFO Proxy environment variables: Nov 12 22:49:07.966248 amazon-ssm-agent[1877]: 2024/11/12 22:49:07 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:49:07.966248 amazon-ssm-agent[1877]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:49:07.966248 amazon-ssm-agent[1877]: 2024/11/12 22:49:07 processing appconfig overrides Nov 12 22:49:07.969417 unknown[1884]: wrote ssh authorized keys file for user: core Nov 12 22:49:08.009368 containerd[1815]: time="2024-11-12T22:49:08.009283249Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Nov 12 22:49:08.017744 update-ssh-keys[1989]: Updated "/home/core/.ssh/authorized_keys" Nov 12 22:49:08.019240 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Nov 12 22:49:08.026478 systemd[1]: Finished sshkeys.service. Nov 12 22:49:08.060791 amazon-ssm-agent[1877]: 2024-11-12 22:49:07 INFO https_proxy: Nov 12 22:49:08.132536 sshd_keygen[1810]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 12 22:49:08.141899 containerd[1815]: time="2024-11-12T22:49:08.141809927Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:49:08.152128 containerd[1815]: time="2024-11-12T22:49:08.150667934Z" 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.60-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 12 22:49:08.152128 containerd[1815]: time="2024-11-12T22:49:08.150719674Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Nov 12 22:49:08.152128 containerd[1815]: time="2024-11-12T22:49:08.150749734Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 12 22:49:08.152128 containerd[1815]: time="2024-11-12T22:49:08.150951636Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Nov 12 22:49:08.152128 containerd[1815]: time="2024-11-12T22:49:08.150978368Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Nov 12 22:49:08.152128 containerd[1815]: time="2024-11-12T22:49:08.151060374Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Nov 12 22:49:08.152128 containerd[1815]: time="2024-11-12T22:49:08.151079295Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:49:08.152128 containerd[1815]: time="2024-11-12T22:49:08.151300345Z" 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 Nov 12 22:49:08.152128 containerd[1815]: time="2024-11-12T22:49:08.151348387Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 12 22:49:08.152128 containerd[1815]: time="2024-11-12T22:49:08.151370605Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Nov 12 22:49:08.152128 containerd[1815]: time="2024-11-12T22:49:08.151385445Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 12 22:49:08.152651 containerd[1815]: time="2024-11-12T22:49:08.151485658Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:49:08.152651 containerd[1815]: time="2024-11-12T22:49:08.151737560Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:49:08.152651 containerd[1815]: time="2024-11-12T22:49:08.151886054Z" 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 Nov 12 22:49:08.152651 containerd[1815]: time="2024-11-12T22:49:08.151912139Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 12 22:49:08.152651 containerd[1815]: time="2024-11-12T22:49:08.152031032Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 12 22:49:08.152651 containerd[1815]: time="2024-11-12T22:49:08.152087055Z" level=info msg="metadata content store policy set" policy=shared Nov 12 22:49:08.159647 containerd[1815]: time="2024-11-12T22:49:08.159595838Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 12 22:49:08.160484 containerd[1815]: time="2024-11-12T22:49:08.160402210Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 12 22:49:08.160754 containerd[1815]: time="2024-11-12T22:49:08.160571868Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Nov 12 22:49:08.160754 containerd[1815]: time="2024-11-12T22:49:08.160602673Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Nov 12 22:49:08.160754 containerd[1815]: time="2024-11-12T22:49:08.160643013Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 12 22:49:08.162866 amazon-ssm-agent[1877]: 2024-11-12 22:49:07 INFO http_proxy: Nov 12 22:49:08.162969 containerd[1815]: time="2024-11-12T22:49:08.162334247Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 12 22:49:08.162969 containerd[1815]: time="2024-11-12T22:49:08.162796877Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 12 22:49:08.163178 containerd[1815]: time="2024-11-12T22:49:08.163158811Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Nov 12 22:49:08.163248 containerd[1815]: time="2024-11-12T22:49:08.163234740Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Nov 12 22:49:08.163330 containerd[1815]: time="2024-11-12T22:49:08.163315738Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Nov 12 22:49:08.163405 containerd[1815]: time="2024-11-12T22:49:08.163392236Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 12 22:49:08.163509 containerd[1815]: time="2024-11-12T22:49:08.163495018Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 12 22:49:08.163579 containerd[1815]: time="2024-11-12T22:49:08.163567233Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 12 22:49:08.163651 containerd[1815]: time="2024-11-12T22:49:08.163637826Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 12 22:49:08.163723 containerd[1815]: time="2024-11-12T22:49:08.163710681Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 12 22:49:08.163787 containerd[1815]: time="2024-11-12T22:49:08.163775518Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 12 22:49:08.163849 containerd[1815]: time="2024-11-12T22:49:08.163837107Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 12 22:49:08.163912 containerd[1815]: time="2024-11-12T22:49:08.163900510Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 12 22:49:08.164003 containerd[1815]: time="2024-11-12T22:49:08.163987134Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.164078 containerd[1815]: time="2024-11-12T22:49:08.164066646Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.164146 containerd[1815]: time="2024-11-12T22:49:08.164132565Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.164274 containerd[1815]: time="2024-11-12T22:49:08.164254015Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165617374Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165649491Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165668263Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165689767Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165708677Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165730927Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165748787Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165787196Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165806060Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165828310Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165865644Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165893530Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165910757Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 12 22:49:08.166329 containerd[1815]: time="2024-11-12T22:49:08.165989243Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Nov 12 22:49:08.166866 containerd[1815]: time="2024-11-12T22:49:08.166017641Z" 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 Nov 12 22:49:08.166866 containerd[1815]: time="2024-11-12T22:49:08.166098816Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Nov 12 22:49:08.166866 containerd[1815]: time="2024-11-12T22:49:08.166119359Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Nov 12 22:49:08.166866 containerd[1815]: time="2024-11-12T22:49:08.166133620Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.166866 containerd[1815]: time="2024-11-12T22:49:08.166152930Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Nov 12 22:49:08.166866 containerd[1815]: time="2024-11-12T22:49:08.166167415Z" level=info msg="NRI interface is disabled by configuration." Nov 12 22:49:08.166866 containerd[1815]: time="2024-11-12T22:49:08.166185668Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Nov 12 22:49:08.169270 containerd[1815]: time="2024-11-12T22:49:08.167436887Z" 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}" Nov 12 22:49:08.169270 containerd[1815]: time="2024-11-12T22:49:08.167513693Z" level=info msg="Connect containerd service" Nov 12 22:49:08.169270 containerd[1815]: time="2024-11-12T22:49:08.167562059Z" level=info msg="using legacy CRI server" Nov 12 22:49:08.169270 containerd[1815]: time="2024-11-12T22:49:08.167572738Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 12 22:49:08.169270 containerd[1815]: time="2024-11-12T22:49:08.167772064Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Nov 12 22:49:08.170139 containerd[1815]: time="2024-11-12T22:49:08.170110828Z" 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" Nov 12 22:49:08.170918 containerd[1815]: time="2024-11-12T22:49:08.170881095Z" level=info msg="Start subscribing containerd event" Nov 12 22:49:08.171105 containerd[1815]: time="2024-11-12T22:49:08.171088032Z" level=info msg="Start recovering state" Nov 12 22:49:08.171617 containerd[1815]: time="2024-11-12T22:49:08.171297197Z" level=info msg="Start event monitor" Nov 12 22:49:08.171617 containerd[1815]: time="2024-11-12T22:49:08.171347373Z" level=info msg="Start snapshots syncer" Nov 12 22:49:08.171617 containerd[1815]: time="2024-11-12T22:49:08.171361578Z" level=info msg="Start cni network conf syncer for default" Nov 12 22:49:08.171617 containerd[1815]: time="2024-11-12T22:49:08.171374818Z" level=info msg="Start streaming server" Nov 12 22:49:08.173762 containerd[1815]: time="2024-11-12T22:49:08.173630071Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 12 22:49:08.173853 containerd[1815]: time="2024-11-12T22:49:08.173831243Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 12 22:49:08.174071 systemd[1]: Started containerd.service - containerd container runtime. Nov 12 22:49:08.179019 containerd[1815]: time="2024-11-12T22:49:08.177358824Z" level=info msg="containerd successfully booted in 0.172356s" Nov 12 22:49:08.181429 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 12 22:49:08.192708 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 12 22:49:08.202778 systemd[1]: Started sshd@0-172.31.16.60:22-147.75.109.163:48836.service - OpenSSH per-connection server daemon (147.75.109.163:48836). Nov 12 22:49:08.212969 systemd[1]: issuegen.service: Deactivated successfully. Nov 12 22:49:08.213224 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 12 22:49:08.225212 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 12 22:49:08.262388 amazon-ssm-agent[1877]: 2024-11-12 22:49:07 INFO no_proxy: Nov 12 22:49:08.264916 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 12 22:49:08.275808 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 12 22:49:08.286776 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Nov 12 22:49:08.288712 systemd[1]: Reached target getty.target - Login Prompts. Nov 12 22:49:08.290205 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 12 22:49:08.291537 systemd[1]: Startup finished in 708ms (kernel) + 6.401s (initrd) + 7.242s (userspace) = 14.352s. Nov 12 22:49:08.367367 amazon-ssm-agent[1877]: 2024-11-12 22:49:07 INFO Checking if agent identity type OnPrem can be assumed Nov 12 22:49:08.450037 sshd[2019]: Accepted publickey for core from 147.75.109.163 port 48836 ssh2: RSA SHA256:tyUOhHL3Sp/l3WFGbjWa7rrAhn1IgH76eohJNuEqC3E Nov 12 22:49:08.451319 sshd-session[2019]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:49:08.464871 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 12 22:49:08.467533 amazon-ssm-agent[1877]: 2024-11-12 22:49:07 INFO Checking if agent identity type EC2 can be assumed Nov 12 22:49:08.474997 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 12 22:49:08.480893 systemd-logind[1796]: New session 1 of user core. Nov 12 22:49:08.496670 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 12 22:49:08.505918 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 12 22:49:08.516574 (systemd)[2035]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 12 22:49:08.565570 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO Agent will take identity from EC2 Nov 12 22:49:08.629427 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [amazon-ssm-agent] using named pipe channel for IPC Nov 12 22:49:08.629637 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [amazon-ssm-agent] using named pipe channel for IPC Nov 12 22:49:08.629714 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [amazon-ssm-agent] using named pipe channel for IPC Nov 12 22:49:08.629822 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Nov 12 22:49:08.629899 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [amazon-ssm-agent] OS: linux, Arch: amd64 Nov 12 22:49:08.629981 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [amazon-ssm-agent] Starting Core Agent Nov 12 22:49:08.630082 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [amazon-ssm-agent] registrar detected. Attempting registration Nov 12 22:49:08.630158 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [Registrar] Starting registrar module Nov 12 22:49:08.630231 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Nov 12 22:49:08.630313 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [EC2Identity] EC2 registration was successful. Nov 12 22:49:08.630399 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [CredentialRefresher] credentialRefresher has started Nov 12 22:49:08.630473 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [CredentialRefresher] Starting credentials refresher loop Nov 12 22:49:08.630546 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO EC2RoleProvider Successfully connected with instance profile role credentials Nov 12 22:49:08.636289 systemd[2035]: Queued start job for default target default.target. Nov 12 22:49:08.647483 systemd[2035]: Created slice app.slice - User Application Slice. Nov 12 22:49:08.647526 systemd[2035]: Reached target paths.target - Paths. Nov 12 22:49:08.647547 systemd[2035]: Reached target timers.target - Timers. Nov 12 22:49:08.648994 systemd[2035]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 12 22:49:08.661386 systemd[2035]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 12 22:49:08.661550 systemd[2035]: Reached target sockets.target - Sockets. Nov 12 22:49:08.661571 systemd[2035]: Reached target basic.target - Basic System. Nov 12 22:49:08.661624 systemd[2035]: Reached target default.target - Main User Target. Nov 12 22:49:08.661666 systemd[2035]: Startup finished in 132ms. Nov 12 22:49:08.661861 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 12 22:49:08.663735 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 12 22:49:08.664818 amazon-ssm-agent[1877]: 2024-11-12 22:49:08 INFO [CredentialRefresher] Next credential rotation will be in 31.7999748603 minutes Nov 12 22:49:08.806228 systemd[1]: Started sshd@1-172.31.16.60:22-147.75.109.163:48844.service - OpenSSH per-connection server daemon (147.75.109.163:48844). Nov 12 22:49:08.973835 sshd[2047]: Accepted publickey for core from 147.75.109.163 port 48844 ssh2: RSA SHA256:tyUOhHL3Sp/l3WFGbjWa7rrAhn1IgH76eohJNuEqC3E Nov 12 22:49:08.975246 sshd-session[2047]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:49:08.980729 systemd-logind[1796]: New session 2 of user core. Nov 12 22:49:08.989544 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 12 22:49:09.109208 sshd[2049]: Connection closed by 147.75.109.163 port 48844 Nov 12 22:49:09.110339 sshd-session[2047]: pam_unix(sshd:session): session closed for user core Nov 12 22:49:09.113128 systemd[1]: sshd@1-172.31.16.60:22-147.75.109.163:48844.service: Deactivated successfully. Nov 12 22:49:09.115038 systemd[1]: session-2.scope: Deactivated successfully. Nov 12 22:49:09.116471 systemd-logind[1796]: Session 2 logged out. Waiting for processes to exit. Nov 12 22:49:09.117804 systemd-logind[1796]: Removed session 2. Nov 12 22:49:09.144622 systemd[1]: Started sshd@2-172.31.16.60:22-147.75.109.163:32792.service - OpenSSH per-connection server daemon (147.75.109.163:32792). Nov 12 22:49:09.332691 sshd[2054]: Accepted publickey for core from 147.75.109.163 port 32792 ssh2: RSA SHA256:tyUOhHL3Sp/l3WFGbjWa7rrAhn1IgH76eohJNuEqC3E Nov 12 22:49:09.334139 sshd-session[2054]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:49:09.339613 systemd-logind[1796]: New session 3 of user core. Nov 12 22:49:09.348536 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 12 22:49:09.462586 sshd[2056]: Connection closed by 147.75.109.163 port 32792 Nov 12 22:49:09.463831 sshd-session[2054]: pam_unix(sshd:session): session closed for user core Nov 12 22:49:09.466879 systemd[1]: sshd@2-172.31.16.60:22-147.75.109.163:32792.service: Deactivated successfully. Nov 12 22:49:09.468682 systemd[1]: session-3.scope: Deactivated successfully. Nov 12 22:49:09.470116 systemd-logind[1796]: Session 3 logged out. Waiting for processes to exit. Nov 12 22:49:09.471444 systemd-logind[1796]: Removed session 3. Nov 12 22:49:09.499198 systemd[1]: Started sshd@3-172.31.16.60:22-147.75.109.163:32798.service - OpenSSH per-connection server daemon (147.75.109.163:32798). Nov 12 22:49:09.647625 amazon-ssm-agent[1877]: 2024-11-12 22:49:09 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Nov 12 22:49:09.659975 sshd[2061]: Accepted publickey for core from 147.75.109.163 port 32798 ssh2: RSA SHA256:tyUOhHL3Sp/l3WFGbjWa7rrAhn1IgH76eohJNuEqC3E Nov 12 22:49:09.662502 sshd-session[2061]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:49:09.669589 systemd-logind[1796]: New session 4 of user core. Nov 12 22:49:09.679745 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 12 22:49:09.748516 amazon-ssm-agent[1877]: 2024-11-12 22:49:09 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2065) started Nov 12 22:49:09.819404 sshd[2070]: Connection closed by 147.75.109.163 port 32798 Nov 12 22:49:09.820134 sshd-session[2061]: pam_unix(sshd:session): session closed for user core Nov 12 22:49:09.827075 systemd-logind[1796]: Session 4 logged out. Waiting for processes to exit. Nov 12 22:49:09.827794 systemd[1]: sshd@3-172.31.16.60:22-147.75.109.163:32798.service: Deactivated successfully. Nov 12 22:49:09.830553 systemd[1]: session-4.scope: Deactivated successfully. Nov 12 22:49:09.832106 systemd-logind[1796]: Removed session 4. Nov 12 22:49:09.849027 amazon-ssm-agent[1877]: 2024-11-12 22:49:09 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Nov 12 22:49:09.860880 systemd[1]: Started sshd@4-172.31.16.60:22-147.75.109.163:32802.service - OpenSSH per-connection server daemon (147.75.109.163:32802). Nov 12 22:49:10.049166 sshd[2080]: Accepted publickey for core from 147.75.109.163 port 32802 ssh2: RSA SHA256:tyUOhHL3Sp/l3WFGbjWa7rrAhn1IgH76eohJNuEqC3E Nov 12 22:49:10.051135 sshd-session[2080]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:49:10.056390 systemd-logind[1796]: New session 5 of user core. Nov 12 22:49:10.066553 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 12 22:49:10.143106 ntpd[1791]: Listen normally on 6 eth0 [fe80::42b:8aff:fe55:685d%2]:123 Nov 12 22:49:10.143500 ntpd[1791]: 12 Nov 22:49:10 ntpd[1791]: Listen normally on 6 eth0 [fe80::42b:8aff:fe55:685d%2]:123 Nov 12 22:49:10.190527 sudo[2084]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Nov 12 22:49:10.191841 sudo[2084]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:49:10.231711 sudo[2084]: pam_unix(sudo:session): session closed for user root Nov 12 22:49:10.254509 sshd[2083]: Connection closed by 147.75.109.163 port 32802 Nov 12 22:49:10.255627 sshd-session[2080]: pam_unix(sshd:session): session closed for user core Nov 12 22:49:10.260349 systemd[1]: sshd@4-172.31.16.60:22-147.75.109.163:32802.service: Deactivated successfully. Nov 12 22:49:10.262589 systemd[1]: session-5.scope: Deactivated successfully. Nov 12 22:49:10.263652 systemd-logind[1796]: Session 5 logged out. Waiting for processes to exit. Nov 12 22:49:10.265327 systemd-logind[1796]: Removed session 5. Nov 12 22:49:10.287493 systemd[1]: Started sshd@5-172.31.16.60:22-147.75.109.163:32812.service - OpenSSH per-connection server daemon (147.75.109.163:32812). Nov 12 22:49:10.460137 sshd[2089]: Accepted publickey for core from 147.75.109.163 port 32812 ssh2: RSA SHA256:tyUOhHL3Sp/l3WFGbjWa7rrAhn1IgH76eohJNuEqC3E Nov 12 22:49:10.461761 sshd-session[2089]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:49:10.479103 systemd-logind[1796]: New session 6 of user core. Nov 12 22:49:10.491484 systemd[1]: Started session-6.scope - Session 6 of User core. Nov 12 22:49:10.603519 sudo[2093]: 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 Nov 12 22:49:10.606055 sudo[2093]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:49:10.618455 sudo[2093]: pam_unix(sudo:session): session closed for user root Nov 12 22:49:10.638604 sudo[2092]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Nov 12 22:49:10.638998 sudo[2092]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:49:10.691111 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 12 22:49:10.746228 augenrules[2115]: No rules Nov 12 22:49:10.746814 systemd[1]: audit-rules.service: Deactivated successfully. Nov 12 22:49:10.747029 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 12 22:49:10.748459 sudo[2092]: pam_unix(sudo:session): session closed for user root Nov 12 22:49:10.770287 sshd[2091]: Connection closed by 147.75.109.163 port 32812 Nov 12 22:49:10.770972 sshd-session[2089]: pam_unix(sshd:session): session closed for user core Nov 12 22:49:10.775296 systemd[1]: sshd@5-172.31.16.60:22-147.75.109.163:32812.service: Deactivated successfully. Nov 12 22:49:10.777255 systemd[1]: session-6.scope: Deactivated successfully. Nov 12 22:49:10.778291 systemd-logind[1796]: Session 6 logged out. Waiting for processes to exit. Nov 12 22:49:10.779756 systemd-logind[1796]: Removed session 6. Nov 12 22:49:10.803807 systemd[1]: Started sshd@6-172.31.16.60:22-147.75.109.163:32828.service - OpenSSH per-connection server daemon (147.75.109.163:32828). Nov 12 22:49:10.968885 sshd[2123]: Accepted publickey for core from 147.75.109.163 port 32828 ssh2: RSA SHA256:tyUOhHL3Sp/l3WFGbjWa7rrAhn1IgH76eohJNuEqC3E Nov 12 22:49:10.970537 sshd-session[2123]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:49:10.977447 systemd-logind[1796]: New session 7 of user core. Nov 12 22:49:10.983897 systemd[1]: Started session-7.scope - Session 7 of User core. Nov 12 22:49:11.097524 sshd[2125]: Connection closed by 147.75.109.163 port 32828 Nov 12 22:49:11.098231 sshd-session[2123]: pam_unix(sshd:session): session closed for user core Nov 12 22:49:11.101697 systemd[1]: sshd@6-172.31.16.60:22-147.75.109.163:32828.service: Deactivated successfully. Nov 12 22:49:11.103969 systemd[1]: session-7.scope: Deactivated successfully. Nov 12 22:49:11.105716 systemd-logind[1796]: Session 7 logged out. Waiting for processes to exit. Nov 12 22:49:11.107108 systemd-logind[1796]: Removed session 7.