Oct 8 19:53:32.842899 kernel: Linux version 6.6.54-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT_DYNAMIC Tue Oct 8 18:24:27 -00 2024 Oct 8 19:53:32.842939 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=ed527eaf992abc270af9987554566193214d123941456fd3066b47855e5178a5 Oct 8 19:53:32.842956 kernel: BIOS-provided physical RAM map: Oct 8 19:53:32.842966 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009dfff] usable Oct 8 19:53:32.842975 kernel: BIOS-e820: [mem 0x000000000009e000-0x000000000009ffff] reserved Oct 8 19:53:32.842987 kernel: BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved Oct 8 19:53:32.843001 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000efffffff] usable Oct 8 19:53:32.843011 kernel: BIOS-e820: [mem 0x00000000fc000000-0x00000000ffffffff] reserved Oct 8 19:53:32.843020 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000080fffffff] usable Oct 8 19:53:32.843030 kernel: NX (Execute Disable) protection: active Oct 8 19:53:32.843039 kernel: APIC: Static calls initialized Oct 8 19:53:32.843048 kernel: SMBIOS 2.7 present. Oct 8 19:53:32.843057 kernel: DMI: Xen HVM domU, BIOS 4.11.amazon 08/24/2006 Oct 8 19:53:32.843067 kernel: Hypervisor detected: Xen HVM Oct 8 19:53:32.843085 kernel: Xen version 4.11. Oct 8 19:53:32.843096 kernel: platform_pci_unplug: Netfront and the Xen platform PCI driver have been compiled for this kernel: unplug emulated NICs. Oct 8 19:53:32.843110 kernel: platform_pci_unplug: Blkfront and the Xen platform PCI driver have been compiled for this kernel: unplug emulated disks. You might have to change the root device from /dev/hd[a-d] to /dev/xvd[a-d] in your root= kernel command line option Oct 8 19:53:32.843121 kernel: HVMOP_pagetable_dying not supported Oct 8 19:53:32.843135 kernel: tsc: Detected 2299.998 MHz processor Oct 8 19:53:32.843147 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 8 19:53:32.843158 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 8 19:53:32.843169 kernel: last_pfn = 0x810000 max_arch_pfn = 0x400000000 Oct 8 19:53:32.843197 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Oct 8 19:53:32.843208 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 8 19:53:32.843219 kernel: last_pfn = 0xf0000 max_arch_pfn = 0x400000000 Oct 8 19:53:32.843230 kernel: Using GB pages for direct mapping Oct 8 19:53:32.843241 kernel: ACPI: Early table checksum verification disabled Oct 8 19:53:32.843255 kernel: ACPI: RSDP 0x00000000000EA020 000024 (v02 Xen ) Oct 8 19:53:32.843265 kernel: ACPI: XSDT 0x00000000FC00D4F0 00005C (v01 Xen HVM 00000000 HVML 00000000) Oct 8 19:53:32.843276 kernel: ACPI: FACP 0x00000000FC00D3F0 0000F4 (v04 Xen HVM 00000000 HVML 00000000) Oct 8 19:53:32.843287 kernel: ACPI: DSDT 0x00000000FC001000 00BD14 (v02 Xen HVM 00000000 INTL 20090123) Oct 8 19:53:32.843298 kernel: ACPI: FACS 0x00000000FC00D2F0 000040 Oct 8 19:53:32.843308 kernel: ACPI: FACS 0x00000000FC00D2F0 000040 Oct 8 19:53:32.843319 kernel: ACPI: SSDT 0x00000000FC00CD20 000033 (v02 Xen HVM 00000000 INTL 20090123) Oct 8 19:53:32.843329 kernel: ACPI: SSDT 0x00000000FC00CD60 000031 (v02 Xen HVM 00000000 INTL 20090123) Oct 8 19:53:32.843340 kernel: ACPI: APIC 0x00000000FC00CDA0 0000D8 (v02 Xen HVM 00000000 HVML 00000000) Oct 8 19:53:32.843353 kernel: ACPI: HPET 0x00000000FC00D280 000038 (v01 Xen HVM 00000000 HVML 00000000) Oct 8 19:53:32.843363 kernel: ACPI: WAET 0x00000000FC00D2C0 000028 (v01 Xen HVM 00000000 HVML 00000000) Oct 8 19:53:32.843374 kernel: ACPI: Reserving FACP table memory at [mem 0xfc00d3f0-0xfc00d4e3] Oct 8 19:53:32.843385 kernel: ACPI: Reserving DSDT table memory at [mem 0xfc001000-0xfc00cd13] Oct 8 19:53:32.843403 kernel: ACPI: Reserving FACS table memory at [mem 0xfc00d2f0-0xfc00d32f] Oct 8 19:53:32.843414 kernel: ACPI: Reserving FACS table memory at [mem 0xfc00d2f0-0xfc00d32f] Oct 8 19:53:32.843425 kernel: ACPI: Reserving SSDT table memory at [mem 0xfc00cd20-0xfc00cd52] Oct 8 19:53:32.843439 kernel: ACPI: Reserving SSDT table memory at [mem 0xfc00cd60-0xfc00cd90] Oct 8 19:53:32.843450 kernel: ACPI: Reserving APIC table memory at [mem 0xfc00cda0-0xfc00ce77] Oct 8 19:53:32.843461 kernel: ACPI: Reserving HPET table memory at [mem 0xfc00d280-0xfc00d2b7] Oct 8 19:53:32.843473 kernel: ACPI: Reserving WAET table memory at [mem 0xfc00d2c0-0xfc00d2e7] Oct 8 19:53:32.843483 kernel: No NUMA configuration found Oct 8 19:53:32.843495 kernel: Faking a node at [mem 0x0000000000000000-0x000000080fffffff] Oct 8 19:53:32.843506 kernel: NODE_DATA(0) allocated [mem 0x80fffa000-0x80fffffff] Oct 8 19:53:32.843517 kernel: Zone ranges: Oct 8 19:53:32.843530 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 8 19:53:32.843542 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Oct 8 19:53:32.843553 kernel: Normal [mem 0x0000000100000000-0x000000080fffffff] Oct 8 19:53:32.843564 kernel: Movable zone start for each node Oct 8 19:53:32.843575 kernel: Early memory node ranges Oct 8 19:53:32.843586 kernel: node 0: [mem 0x0000000000001000-0x000000000009dfff] Oct 8 19:53:32.843597 kernel: node 0: [mem 0x0000000000100000-0x00000000efffffff] Oct 8 19:53:32.843608 kernel: node 0: [mem 0x0000000100000000-0x000000080fffffff] Oct 8 19:53:32.843619 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000080fffffff] Oct 8 19:53:32.843633 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 8 19:53:32.843644 kernel: On node 0, zone DMA: 98 pages in unavailable ranges Oct 8 19:53:32.843655 kernel: ACPI: PM-Timer IO Port: 0xb008 Oct 8 19:53:32.843667 kernel: IOAPIC[0]: apic_id 1, version 17, address 0xfec00000, GSI 0-47 Oct 8 19:53:32.843678 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Oct 8 19:53:32.843689 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 low level) Oct 8 19:53:32.843700 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 low level) Oct 8 19:53:32.843720 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 low level) Oct 8 19:53:32.843731 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 8 19:53:32.843745 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Oct 8 19:53:32.843756 kernel: TSC deadline timer available Oct 8 19:53:32.843767 kernel: smpboot: Allowing 15 CPUs, 7 hotplug CPUs Oct 8 19:53:32.843778 kernel: [mem 0xf0000000-0xfbffffff] available for PCI devices Oct 8 19:53:32.843790 kernel: Booting paravirtualized kernel on Xen HVM Oct 8 19:53:32.843801 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 8 19:53:32.843812 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:15 nr_cpu_ids:15 nr_node_ids:1 Oct 8 19:53:32.843824 kernel: percpu: Embedded 58 pages/cpu s196904 r8192 d32472 u262144 Oct 8 19:53:32.843835 kernel: pcpu-alloc: s196904 r8192 d32472 u262144 alloc=1*2097152 Oct 8 19:53:32.843848 kernel: pcpu-alloc: [0] 00 01 02 03 04 05 06 07 [0] 08 09 10 11 12 13 14 -- Oct 8 19:53:32.843859 kernel: xen: PV spinlocks enabled Oct 8 19:53:32.843871 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Oct 8 19:53:32.843883 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=ed527eaf992abc270af9987554566193214d123941456fd3066b47855e5178a5 Oct 8 19:53:32.843895 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 8 19:53:32.843906 kernel: random: crng init done Oct 8 19:53:32.843917 kernel: Dentry cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear) Oct 8 19:53:32.843928 kernel: Inode-cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear) Oct 8 19:53:32.843942 kernel: Fallback order for Node 0: 0 Oct 8 19:53:32.843953 kernel: Built 1 zonelists, mobility grouping on. Total pages: 8257280 Oct 8 19:53:32.843964 kernel: Policy zone: Normal Oct 8 19:53:32.843975 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 8 19:53:32.843986 kernel: software IO TLB: area num 16. Oct 8 19:53:32.843998 kernel: Memory: 32821580K/33554036K available (12288K kernel code, 2305K rwdata, 22716K rodata, 42828K init, 2360K bss, 732196K reserved, 0K cma-reserved) Oct 8 19:53:32.844009 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=15, Nodes=1 Oct 8 19:53:32.844020 kernel: Kernel/User page tables isolation: enabled Oct 8 19:53:32.844031 kernel: ftrace: allocating 37784 entries in 148 pages Oct 8 19:53:32.844045 kernel: ftrace: allocated 148 pages with 3 groups Oct 8 19:53:32.844056 kernel: Dynamic Preempt: voluntary Oct 8 19:53:32.844067 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 8 19:53:32.844078 kernel: rcu: RCU event tracing is enabled. Oct 8 19:53:32.844089 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=15. Oct 8 19:53:32.844101 kernel: Trampoline variant of Tasks RCU enabled. Oct 8 19:53:32.844112 kernel: Rude variant of Tasks RCU enabled. Oct 8 19:53:32.844123 kernel: Tracing variant of Tasks RCU enabled. Oct 8 19:53:32.844134 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 8 19:53:32.844148 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=15 Oct 8 19:53:32.844159 kernel: NR_IRQS: 33024, nr_irqs: 952, preallocated irqs: 16 Oct 8 19:53:32.844170 kernel: xen:events: Using 2-level ABI Oct 8 19:53:32.844196 kernel: xen:events: Xen HVM callback vector for event delivery is enabled Oct 8 19:53:32.844208 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 8 19:53:32.844219 kernel: Console: colour VGA+ 80x25 Oct 8 19:53:32.844230 kernel: Cannot get hvm parameter CONSOLE_EVTCHN (18): -22! Oct 8 19:53:32.844242 kernel: printk: console [ttyS0] enabled Oct 8 19:53:32.844253 kernel: ACPI: Core revision 20230628 Oct 8 19:53:32.844266 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 30580167144 ns Oct 8 19:53:32.844278 kernel: APIC: Switch to symmetric I/O mode setup Oct 8 19:53:32.844289 kernel: x2apic enabled Oct 8 19:53:32.844300 kernel: APIC: Switched APIC routing to: physical x2apic Oct 8 19:53:32.844312 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=0 pin2=0 Oct 8 19:53:32.844335 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x212733415c7, max_idle_ns: 440795236380 ns Oct 8 19:53:32.844349 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4599.99 BogoMIPS (lpj=2299998) Oct 8 19:53:32.844361 kernel: Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8 Oct 8 19:53:32.844372 kernel: Last level dTLB entries: 4KB 64, 2MB 0, 4MB 0, 1GB 4 Oct 8 19:53:32.844384 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 8 19:53:32.844395 kernel: Spectre V2 : Mitigation: Retpolines Oct 8 19:53:32.844407 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Oct 8 19:53:32.844421 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Oct 8 19:53:32.844433 kernel: Speculative Store Bypass: Vulnerable Oct 8 19:53:32.844445 kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Oct 8 19:53:32.844456 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Oct 8 19:53:32.844469 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 8 19:53:32.844483 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 8 19:53:32.844494 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 8 19:53:32.844506 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 8 19:53:32.844518 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Oct 8 19:53:32.844529 kernel: Freeing SMP alternatives memory: 32K Oct 8 19:53:32.844541 kernel: pid_max: default: 32768 minimum: 301 Oct 8 19:53:32.844553 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Oct 8 19:53:32.844564 kernel: landlock: Up and running. Oct 8 19:53:32.844579 kernel: SELinux: Initializing. Oct 8 19:53:32.844590 kernel: Mount-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 8 19:53:32.844602 kernel: Mountpoint-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 8 19:53:32.844614 kernel: clocksource: xen: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 8 19:53:32.844626 kernel: Xen: using vcpuop timer interface Oct 8 19:53:32.844637 kernel: installing Xen timer for CPU 0 Oct 8 19:53:32.844649 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2686 v4 @ 2.30GHz (family: 0x6, model: 0x4f, stepping: 0x1) Oct 8 19:53:32.844660 kernel: cpu 0 spinlock event irq 53 Oct 8 19:53:32.844673 kernel: RCU Tasks: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1. Oct 8 19:53:32.844687 kernel: RCU Tasks Rude: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1. Oct 8 19:53:32.844698 kernel: RCU Tasks Trace: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1. Oct 8 19:53:32.844710 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only. Oct 8 19:53:32.844722 kernel: signal: max sigframe size: 1776 Oct 8 19:53:32.844733 kernel: rcu: Hierarchical SRCU implementation. Oct 8 19:53:32.844745 kernel: rcu: Max phase no-delay instances is 400. Oct 8 19:53:32.844757 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Oct 8 19:53:32.844769 kernel: smp: Bringing up secondary CPUs ... Oct 8 19:53:32.844780 kernel: installing Xen timer for CPU 1 Oct 8 19:53:32.844794 kernel: smpboot: x86: Booting SMP configuration: Oct 8 19:53:32.844806 kernel: .... node #0, CPUs: #1 Oct 8 19:53:32.844817 kernel: installing Xen timer for CPU 2 Oct 8 19:53:32.844829 kernel: #2 Oct 8 19:53:32.844841 kernel: installing Xen timer for CPU 3 Oct 8 19:53:32.844852 kernel: #3 Oct 8 19:53:32.844864 kernel: cpu 1 spinlock event irq 69 Oct 8 19:53:32.844875 kernel: cpu 2 spinlock event irq 70 Oct 8 19:53:32.844887 kernel: cpu 3 spinlock event irq 71 Oct 8 19:53:32.844901 kernel: installing Xen timer for CPU 4 Oct 8 19:53:32.844913 kernel: #4 Oct 8 19:53:32.844924 kernel: installing Xen timer for CPU 5 Oct 8 19:53:32.844936 kernel: #5 Oct 8 19:53:32.844947 kernel: installing Xen timer for CPU 6 Oct 8 19:53:32.844958 kernel: #6 Oct 8 19:53:32.844970 kernel: installing Xen timer for CPU 7 Oct 8 19:53:32.844981 kernel: #7 Oct 8 19:53:32.844992 kernel: cpu 4 spinlock event irq 92 Oct 8 19:53:32.845004 kernel: MDS CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/mds.html for more details. Oct 8 19:53:32.845019 kernel: MMIO Stale Data CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/processor_mmio_stale_data.html for more details. Oct 8 19:53:32.845030 kernel: cpu 5 spinlock event irq 93 Oct 8 19:53:32.845042 kernel: cpu 6 spinlock event irq 94 Oct 8 19:53:32.845054 kernel: cpu 7 spinlock event irq 95 Oct 8 19:53:32.845065 kernel: smp: Brought up 1 node, 8 CPUs Oct 8 19:53:32.845077 kernel: smpboot: Max logical packages: 2 Oct 8 19:53:32.845088 kernel: smpboot: Total of 8 processors activated (36799.96 BogoMIPS) Oct 8 19:53:32.845100 kernel: devtmpfs: initialized Oct 8 19:53:32.845114 kernel: x86/mm: Memory block size: 128MB Oct 8 19:53:32.845126 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 8 19:53:32.845138 kernel: futex hash table entries: 4096 (order: 6, 262144 bytes, linear) Oct 8 19:53:32.845149 kernel: pinctrl core: initialized pinctrl subsystem Oct 8 19:53:32.845161 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 8 19:53:32.845173 kernel: audit: initializing netlink subsys (disabled) Oct 8 19:53:32.845199 kernel: audit: type=2000 audit(1728417213.233:1): state=initialized audit_enabled=0 res=1 Oct 8 19:53:32.845211 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 8 19:53:32.845223 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 8 19:53:32.845237 kernel: cpuidle: using governor menu Oct 8 19:53:32.845249 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 8 19:53:32.845260 kernel: dca service started, version 1.12.1 Oct 8 19:53:32.845272 kernel: PCI: Using configuration type 1 for base access Oct 8 19:53:32.845284 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 8 19:53:32.845296 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 8 19:53:32.845307 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Oct 8 19:53:32.845319 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 8 19:53:32.845331 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Oct 8 19:53:32.845345 kernel: ACPI: Added _OSI(Module Device) Oct 8 19:53:32.845356 kernel: ACPI: Added _OSI(Processor Device) Oct 8 19:53:32.845368 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 8 19:53:32.845380 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 8 19:53:32.845391 kernel: ACPI: 3 ACPI AML tables successfully acquired and loaded Oct 8 19:53:32.845403 kernel: xen: --> pirq=16 -> irq=9 (gsi=9) Oct 8 19:53:32.845414 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Oct 8 19:53:32.845426 kernel: ACPI: Interpreter enabled Oct 8 19:53:32.845437 kernel: ACPI: PM: (supports S0 S3 S5) Oct 8 19:53:32.845449 kernel: ACPI: Using IOAPIC for interrupt routing Oct 8 19:53:32.845463 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 8 19:53:32.845475 kernel: PCI: Using E820 reservations for host bridge windows Oct 8 19:53:32.845487 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Oct 8 19:53:32.845498 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 8 19:53:32.845643 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Oct 8 19:53:32.845748 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Oct 8 19:53:32.845842 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Oct 8 19:53:32.845859 kernel: acpiphp: Slot [0] registered Oct 8 19:53:32.845871 kernel: acpiphp: Slot [3] registered Oct 8 19:53:32.845883 kernel: acpiphp: Slot [4] registered Oct 8 19:53:32.845895 kernel: acpiphp: Slot [5] registered Oct 8 19:53:32.845906 kernel: acpiphp: Slot [6] registered Oct 8 19:53:32.845917 kernel: acpiphp: Slot [7] registered Oct 8 19:53:32.845928 kernel: acpiphp: Slot [8] registered Oct 8 19:53:32.845940 kernel: acpiphp: Slot [9] registered Oct 8 19:53:32.845952 kernel: acpiphp: Slot [10] registered Oct 8 19:53:32.845966 kernel: acpiphp: Slot [11] registered Oct 8 19:53:32.845977 kernel: acpiphp: Slot [12] registered Oct 8 19:53:32.845989 kernel: acpiphp: Slot [13] registered Oct 8 19:53:32.846000 kernel: acpiphp: Slot [14] registered Oct 8 19:53:32.846012 kernel: acpiphp: Slot [15] registered Oct 8 19:53:32.846024 kernel: acpiphp: Slot [16] registered Oct 8 19:53:32.846035 kernel: acpiphp: Slot [17] registered Oct 8 19:53:32.846046 kernel: acpiphp: Slot [18] registered Oct 8 19:53:32.846064 kernel: acpiphp: Slot [19] registered Oct 8 19:53:32.846084 kernel: acpiphp: Slot [20] registered Oct 8 19:53:32.846106 kernel: acpiphp: Slot [21] registered Oct 8 19:53:32.846128 kernel: acpiphp: Slot [22] registered Oct 8 19:53:32.846151 kernel: acpiphp: Slot [23] registered Oct 8 19:53:32.846186 kernel: acpiphp: Slot [24] registered Oct 8 19:53:32.846209 kernel: acpiphp: Slot [25] registered Oct 8 19:53:32.846233 kernel: acpiphp: Slot [26] registered Oct 8 19:53:32.846252 kernel: acpiphp: Slot [27] registered Oct 8 19:53:32.846268 kernel: acpiphp: Slot [28] registered Oct 8 19:53:32.846291 kernel: acpiphp: Slot [29] registered Oct 8 19:53:32.846325 kernel: acpiphp: Slot [30] registered Oct 8 19:53:32.846347 kernel: acpiphp: Slot [31] registered Oct 8 19:53:32.846361 kernel: PCI host bridge to bus 0000:00 Oct 8 19:53:32.846480 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Oct 8 19:53:32.846571 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Oct 8 19:53:32.846655 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Oct 8 19:53:32.846738 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xffffffff window] Oct 8 19:53:32.846819 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 8 19:53:32.846926 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Oct 8 19:53:32.847025 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Oct 8 19:53:32.847124 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 Oct 8 19:53:32.847237 kernel: pci 0000:00:01.1: reg 0x20: [io 0xc000-0xc00f] Oct 8 19:53:32.847333 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Oct 8 19:53:32.847424 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Oct 8 19:53:32.848243 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Oct 8 19:53:32.848344 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Oct 8 19:53:32.848361 kernel: * Found PM-Timer Bug on the chipset. Due to workarounds for a bug, * this clock source is slow. Consider trying other clock sources Oct 8 19:53:32.848457 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 Oct 8 19:53:32.848610 kernel: pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI Oct 8 19:53:32.848774 kernel: pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 Oct 8 19:53:32.848939 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xf8000000-0xf9ffffff pref] Oct 8 19:53:32.849071 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xfbfff000-0xfbffffff] Oct 8 19:53:32.849241 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Oct 8 19:53:32.849350 kernel: pci 0000:00:03.0: [8086:10ed] type 00 class 0x020000 Oct 8 19:53:32.849445 kernel: pci 0000:00:03.0: reg 0x10: [mem 0xfbff4000-0xfbff7fff 64bit pref] Oct 8 19:53:32.849536 kernel: pci 0000:00:03.0: reg 0x1c: [mem 0xfbff8000-0xfbffbfff 64bit pref] Oct 8 19:53:32.849632 kernel: pci 0000:00:1f.0: [5853:0001] type 00 class 0xff8000 Oct 8 19:53:32.849725 kernel: pci 0000:00:1f.0: reg 0x10: [io 0xc100-0xc1ff] Oct 8 19:53:32.849823 kernel: pci 0000:00:1f.0: reg 0x14: [mem 0xfa000000-0xfaffffff pref] Oct 8 19:53:32.849836 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 5 Oct 8 19:53:32.849848 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Oct 8 19:53:32.849860 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Oct 8 19:53:32.849872 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 5 Oct 8 19:53:32.849884 kernel: xen:balloon: Initialising balloon driver Oct 8 19:53:32.849896 kernel: iommu: Default domain type: Translated Oct 8 19:53:32.849908 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 8 19:53:32.849919 kernel: PCI: Using ACPI for IRQ routing Oct 8 19:53:32.849934 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 8 19:53:32.849946 kernel: e820: reserve RAM buffer [mem 0x0009e000-0x0009ffff] Oct 8 19:53:32.850034 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Oct 8 19:53:32.850126 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Oct 8 19:53:32.850251 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Oct 8 19:53:32.850267 kernel: vgaarb: loaded Oct 8 19:53:32.850279 kernel: hpet: 3 channels of 0 reserved for per-cpu timers Oct 8 19:53:32.850291 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Oct 8 19:53:32.850306 kernel: hpet0: 3 comparators, 64-bit 62.500000 MHz counter Oct 8 19:53:32.850326 kernel: clocksource: Switched to clocksource xen Oct 8 19:53:32.850349 kernel: VFS: Disk quotas dquot_6.6.0 Oct 8 19:53:32.850373 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 8 19:53:32.850396 kernel: pnp: PnP ACPI init Oct 8 19:53:32.850533 kernel: system 00:00: [mem 0x00000000-0x0009ffff] could not be reserved Oct 8 19:53:32.850629 kernel: system 00:01: [io 0x08a0-0x08a3] has been reserved Oct 8 19:53:32.850716 kernel: system 00:01: [io 0x0cc0-0x0ccf] has been reserved Oct 8 19:53:32.850804 kernel: system 00:01: [io 0x04d0-0x04d1] has been reserved Oct 8 19:53:32.850818 kernel: xen: --> pirq=17 -> irq=8 (gsi=8) Oct 8 19:53:32.850830 kernel: xen: --> pirq=18 -> irq=12 (gsi=12) Oct 8 19:53:32.850841 kernel: xen: --> pirq=19 -> irq=1 (gsi=1) Oct 8 19:53:32.850853 kernel: xen: --> pirq=20 -> irq=6 (gsi=6) Oct 8 19:53:32.850939 kernel: pnp 00:05: [dma 2] Oct 8 19:53:32.850955 kernel: xen: --> pirq=21 -> irq=4 (gsi=4) Oct 8 19:53:32.851040 kernel: system 00:07: [io 0x10c0-0x1141] has been reserved Oct 8 19:53:32.851131 kernel: system 00:07: [io 0xb044-0xb047] has been reserved Oct 8 19:53:32.851146 kernel: pnp: PnP ACPI: found 8 devices Oct 8 19:53:32.851158 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 8 19:53:32.851170 kernel: NET: Registered PF_INET protocol family Oct 8 19:53:32.851200 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 8 19:53:32.851212 kernel: tcp_listen_portaddr_hash hash table entries: 16384 (order: 6, 262144 bytes, linear) Oct 8 19:53:32.851224 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 8 19:53:32.851236 kernel: TCP established hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 8 19:53:32.851270 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Oct 8 19:53:32.851293 kernel: TCP: Hash tables configured (established 262144 bind 65536) Oct 8 19:53:32.851308 kernel: UDP hash table entries: 16384 (order: 7, 524288 bytes, linear) Oct 8 19:53:32.851320 kernel: UDP-Lite hash table entries: 16384 (order: 7, 524288 bytes, linear) Oct 8 19:53:32.851332 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 8 19:53:32.851353 kernel: NET: Registered PF_XDP protocol family Oct 8 19:53:32.851445 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Oct 8 19:53:32.851531 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Oct 8 19:53:32.851616 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Oct 8 19:53:32.851699 kernel: pci_bus 0000:00: resource 7 [mem 0xf0000000-0xffffffff window] Oct 8 19:53:32.851805 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Oct 8 19:53:32.851901 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Oct 8 19:53:32.851917 kernel: PCI: CLS 0 bytes, default 64 Oct 8 19:53:32.851929 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Oct 8 19:53:32.851941 kernel: software IO TLB: mapped [mem 0x00000000ec000000-0x00000000f0000000] (64MB) Oct 8 19:53:32.851953 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 655360 ms ovfl timer Oct 8 19:53:32.851968 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x212733415c7, max_idle_ns: 440795236380 ns Oct 8 19:53:32.851980 kernel: Initialise system trusted keyrings Oct 8 19:53:32.851992 kernel: workingset: timestamp_bits=39 max_order=23 bucket_order=0 Oct 8 19:53:32.852004 kernel: Key type asymmetric registered Oct 8 19:53:32.852015 kernel: Asymmetric key parser 'x509' registered Oct 8 19:53:32.852027 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 8 19:53:32.852039 kernel: io scheduler mq-deadline registered Oct 8 19:53:32.852051 kernel: io scheduler kyber registered Oct 8 19:53:32.852063 kernel: io scheduler bfq registered Oct 8 19:53:32.852077 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 8 19:53:32.852089 kernel: xen: --> pirq=22 -> irq=47 (gsi=47) Oct 8 19:53:32.852100 kernel: xen:grant_table: Grant tables using version 1 layout Oct 8 19:53:32.852112 kernel: Grant table initialized Oct 8 19:53:32.852124 kernel: Cannot get hvm parameter CONSOLE_EVTCHN (18): -22! Oct 8 19:53:32.852136 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 8 19:53:32.852148 kernel: 00:06: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 8 19:53:32.852159 kernel: i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12 Oct 8 19:53:32.852171 kernel: i8042: Warning: Keylock active Oct 8 19:53:32.852202 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Oct 8 19:53:32.852214 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Oct 8 19:53:32.852312 kernel: rtc_cmos 00:02: registered as rtc0 Oct 8 19:53:32.852422 kernel: rtc_cmos 00:02: setting system clock to 2024-10-08T19:53:32 UTC (1728417212) Oct 8 19:53:32.852511 kernel: rtc_cmos 00:02: alarms up to one day, 114 bytes nvram, hpet irqs Oct 8 19:53:32.852525 kernel: intel_pstate: CPU model not supported Oct 8 19:53:32.852538 kernel: NET: Registered PF_INET6 protocol family Oct 8 19:53:32.852551 kernel: Segment Routing with IPv6 Oct 8 19:53:32.852566 kernel: In-situ OAM (IOAM) with IPv6 Oct 8 19:53:32.852578 kernel: NET: Registered PF_PACKET protocol family Oct 8 19:53:32.852590 kernel: Key type dns_resolver registered Oct 8 19:53:32.852602 kernel: IPI shorthand broadcast: enabled Oct 8 19:53:32.852615 kernel: sched_clock: Marking stable (680005129, 127805692)->(848924003, -41113182) Oct 8 19:53:32.852627 kernel: registered taskstats version 1 Oct 8 19:53:32.852639 kernel: Loading compiled-in X.509 certificates Oct 8 19:53:32.852652 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.54-flatcar: 14ce23fc5070d0471461f1dd6e298a5588e7ba8f' Oct 8 19:53:32.852664 kernel: Key type .fscrypt registered Oct 8 19:53:32.852680 kernel: Key type fscrypt-provisioning registered Oct 8 19:53:32.852693 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 8 19:53:32.852705 kernel: ima: Allocated hash algorithm: sha1 Oct 8 19:53:32.852717 kernel: ima: No architecture policies found Oct 8 19:53:32.852730 kernel: xenbus_probe_frontend: Device with no driver: device/vbd/51712 Oct 8 19:53:32.852742 kernel: clk: Disabling unused clocks Oct 8 19:53:32.852754 kernel: Freeing unused kernel image (initmem) memory: 42828K Oct 8 19:53:32.852767 kernel: Write protecting the kernel read-only data: 36864k Oct 8 19:53:32.852779 kernel: Freeing unused kernel image (rodata/data gap) memory: 1860K Oct 8 19:53:32.852793 kernel: Run /init as init process Oct 8 19:53:32.852806 kernel: with arguments: Oct 8 19:53:32.852818 kernel: /init Oct 8 19:53:32.852830 kernel: with environment: Oct 8 19:53:32.852842 kernel: HOME=/ Oct 8 19:53:32.852854 kernel: TERM=linux Oct 8 19:53:32.852866 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 8 19:53:32.852880 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) Oct 8 19:53:32.852899 systemd[1]: Detected virtualization xen. Oct 8 19:53:32.852914 systemd[1]: Detected architecture x86-64. Oct 8 19:53:32.852926 systemd[1]: Running in initrd. Oct 8 19:53:32.852938 systemd[1]: No hostname configured, using default hostname. Oct 8 19:53:32.852951 systemd[1]: Hostname set to . Oct 8 19:53:32.852965 systemd[1]: Initializing machine ID from VM UUID. Oct 8 19:53:32.852978 systemd[1]: Queued start job for default target initrd.target. Oct 8 19:53:32.852990 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:53:32.853005 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:53:32.853019 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 8 19:53:32.853031 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 8 19:53:32.853044 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 8 19:53:32.853057 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 8 19:53:32.853073 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 8 19:53:32.853088 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 8 19:53:32.853100 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:53:32.853113 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:53:32.853126 systemd[1]: Reached target paths.target - Path Units. Oct 8 19:53:32.853138 systemd[1]: Reached target slices.target - Slice Units. Oct 8 19:53:32.853151 systemd[1]: Reached target swap.target - Swaps. Oct 8 19:53:32.853164 systemd[1]: Reached target timers.target - Timer Units. Oct 8 19:53:32.853193 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 8 19:53:32.853206 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 8 19:53:32.853222 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 8 19:53:32.853235 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 8 19:53:32.853247 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 8 19:53:32.853260 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 8 19:53:32.853273 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:53:32.853286 systemd[1]: Reached target sockets.target - Socket Units. Oct 8 19:53:32.853301 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 8 19:53:32.853314 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 8 19:53:32.853327 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 8 19:53:32.853339 systemd[1]: Starting systemd-fsck-usr.service... Oct 8 19:53:32.853352 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 8 19:53:32.853364 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 8 19:53:32.853377 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:53:32.853390 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 8 19:53:32.853405 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:53:32.853418 systemd[1]: Finished systemd-fsck-usr.service. Oct 8 19:53:32.853433 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 8 19:53:32.853463 systemd-journald[219]: Collecting audit messages is disabled. Oct 8 19:53:32.853503 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 8 19:53:32.853517 systemd-journald[219]: Journal started Oct 8 19:53:32.853551 systemd-journald[219]: Runtime Journal (/run/log/journal/ec2df8dcfd2e28463067896a0aea3542) is 8.0M, max 641.9M, 633.9M free. Oct 8 19:53:32.849254 systemd-modules-load[220]: Inserted module 'overlay' Oct 8 19:53:32.883030 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 8 19:53:32.883063 kernel: Bridge firewalling registered Oct 8 19:53:32.882144 systemd-modules-load[220]: Inserted module 'br_netfilter' Oct 8 19:53:32.886442 systemd[1]: Started systemd-journald.service - Journal Service. Oct 8 19:53:32.886766 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 8 19:53:32.888042 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:53:32.905364 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:53:32.907126 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 8 19:53:32.909468 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 8 19:53:32.910016 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 8 19:53:32.917916 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:53:32.918214 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:53:32.924432 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:53:32.924800 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 8 19:53:32.951297 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 8 19:53:32.952642 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 8 19:53:32.964923 dracut-cmdline[258]: dracut-dracut-053 Oct 8 19:53:32.968141 dracut-cmdline[258]: 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=ed527eaf992abc270af9987554566193214d123941456fd3066b47855e5178a5 Oct 8 19:53:32.983163 systemd-resolved[260]: Positive Trust Anchors: Oct 8 19:53:32.983196 systemd-resolved[260]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 8 19:53:32.983232 systemd-resolved[260]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 8 19:53:32.985724 systemd-resolved[260]: Defaulting to hostname 'linux'. Oct 8 19:53:32.991313 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 8 19:53:32.995232 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 8 19:53:33.006197 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Oct 8 19:53:33.048201 kernel: SCSI subsystem initialized Oct 8 19:53:33.058202 kernel: Loading iSCSI transport class v2.0-870. Oct 8 19:53:33.069198 kernel: iscsi: registered transport (tcp) Oct 8 19:53:33.092196 kernel: iscsi: registered transport (qla4xxx) Oct 8 19:53:33.092236 kernel: QLogic iSCSI HBA Driver Oct 8 19:53:33.131652 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 8 19:53:33.149362 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 8 19:53:33.174822 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 8 19:53:33.174894 kernel: device-mapper: uevent: version 1.0.3 Oct 8 19:53:33.174914 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 8 19:53:33.216193 kernel: raid6: avx2x4 gen() 17229 MB/s Oct 8 19:53:33.233193 kernel: raid6: avx2x2 gen() 16782 MB/s Oct 8 19:53:33.250186 kernel: raid6: avx2x1 gen() 12814 MB/s Oct 8 19:53:33.250212 kernel: raid6: using algorithm avx2x4 gen() 17229 MB/s Oct 8 19:53:33.267193 kernel: raid6: .... xor() 8144 MB/s, rmw enabled Oct 8 19:53:33.267218 kernel: raid6: using avx2x2 recovery algorithm Oct 8 19:53:33.287193 kernel: xor: automatically using best checksumming function avx Oct 8 19:53:33.482230 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 8 19:53:33.492770 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 8 19:53:33.512363 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:53:33.524406 systemd-udevd[445]: Using default interface naming scheme 'v255'. Oct 8 19:53:33.528853 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:53:33.532222 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 8 19:53:33.550304 dracut-pre-trigger[454]: rd.md=0: removing MD RAID activation Oct 8 19:53:33.577767 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 8 19:53:33.587369 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 8 19:53:33.702022 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:53:33.729651 kernel: cryptd: max_cpu_qlen set to 1000 Oct 8 19:53:33.731313 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 8 19:53:33.734580 kernel: ixgbevf: Intel(R) 10 Gigabit PCI Express Virtual Function Network Driver Oct 8 19:53:33.734628 kernel: ixgbevf: Copyright (c) 2009 - 2018 Intel Corporation. Oct 8 19:53:33.748464 kernel: ixgbevf 0000:00:03.0: 06:e3:81:79:cb:af Oct 8 19:53:33.748714 kernel: ixgbevf 0000:00:03.0: MAC: 1 Oct 8 19:53:33.748880 kernel: ixgbevf 0000:00:03.0: Intel(R) 82599 Virtual Function Oct 8 19:53:33.751370 kernel: AVX2 version of gcm_enc/dec engaged. Oct 8 19:53:33.751424 kernel: AES CTR mode by8 optimization enabled Oct 8 19:53:33.755002 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 8 19:53:33.757357 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 8 19:53:33.760085 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:53:33.784433 kernel: libata version 3.00 loaded. Oct 8 19:53:33.784466 kernel: ata_piix 0000:00:01.1: version 2.13 Oct 8 19:53:33.784630 kernel: scsi host0: ata_piix Oct 8 19:53:33.784753 kernel: blkfront: xvda: barrier or flush: disabled; persistent grants: disabled; indirect descriptors: enabled; bounce buffer: disabled; Oct 8 19:53:33.784771 kernel: scsi host1: ata_piix Oct 8 19:53:33.784882 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc000 irq 14 Oct 8 19:53:33.784899 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc008 irq 15 Oct 8 19:53:33.762162 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 8 19:53:33.763874 (udev-worker)[492]: Network interface NamePolicy= disabled on kernel command line. Oct 8 19:53:33.783356 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 8 19:53:33.792329 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 8 19:53:33.792353 kernel: GPT:9289727 != 16777215 Oct 8 19:53:33.792369 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 8 19:53:33.792385 kernel: GPT:9289727 != 16777215 Oct 8 19:53:33.792401 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 8 19:53:33.792417 kernel: xvda: xvda1 xvda2 xvda3 xvda4 xvda6 xvda7 xvda9 Oct 8 19:53:33.789471 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 8 19:53:33.789602 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:53:33.796621 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:53:33.796991 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 8 19:53:33.797152 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:53:33.799959 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:53:33.802826 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:53:33.811458 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 8 19:53:33.863866 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:53:33.878370 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:53:33.895017 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:53:34.461245 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 8 19:53:34.514200 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/xvda6 scanned by (udev-worker) (494) Oct 8 19:53:34.523709 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 8 19:53:34.604205 kernel: BTRFS: device fsid a8680da2-059a-4648-a8e8-f62925ab33ec devid 1 transid 38 /dev/xvda3 scanned by (udev-worker) (489) Oct 8 19:53:34.613224 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 8 19:53:34.617426 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 8 19:53:34.620680 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 8 19:53:34.629319 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 8 19:53:34.635446 disk-uuid[606]: Primary Header is updated. Oct 8 19:53:34.635446 disk-uuid[606]: Secondary Entries is updated. Oct 8 19:53:34.635446 disk-uuid[606]: Secondary Header is updated. Oct 8 19:53:34.642195 kernel: xvda: xvda1 xvda2 xvda3 xvda4 xvda6 xvda7 xvda9 Oct 8 19:53:34.647192 kernel: xvda: xvda1 xvda2 xvda3 xvda4 xvda6 xvda7 xvda9 Oct 8 19:53:34.653193 kernel: xvda: xvda1 xvda2 xvda3 xvda4 xvda6 xvda7 xvda9 Oct 8 19:53:35.659976 disk-uuid[607]: The operation has completed successfully. Oct 8 19:53:35.661126 kernel: xvda: xvda1 xvda2 xvda3 xvda4 xvda6 xvda7 xvda9 Oct 8 19:53:35.714242 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 8 19:53:35.714339 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 8 19:53:35.725411 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 8 19:53:35.730818 sh[624]: Success Oct 8 19:53:35.820199 kernel: device-mapper: verity: sha256 using implementation "sha256-avx2" Oct 8 19:53:36.093481 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 8 19:53:36.105334 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 8 19:53:36.107025 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 8 19:53:36.133779 kernel: BTRFS info (device dm-0): first mount of filesystem a8680da2-059a-4648-a8e8-f62925ab33ec Oct 8 19:53:36.133815 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Oct 8 19:53:36.133833 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 8 19:53:36.134550 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 8 19:53:36.136434 kernel: BTRFS info (device dm-0): using free space tree Oct 8 19:53:36.895205 kernel: BTRFS info (device dm-0): enabling ssd optimizations Oct 8 19:53:37.170790 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 8 19:53:37.172065 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 8 19:53:37.184300 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 8 19:53:37.186837 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 8 19:53:37.222629 kernel: BTRFS info (device xvda6): first mount of filesystem bfaca09e-98f3-46e8-bdd8-6fce748bf2b6 Oct 8 19:53:37.222672 kernel: BTRFS info (device xvda6): using crc32c (crc32c-intel) checksum algorithm Oct 8 19:53:37.222690 kernel: BTRFS info (device xvda6): using free space tree Oct 8 19:53:37.229192 kernel: BTRFS info (device xvda6): enabling ssd optimizations Oct 8 19:53:37.236475 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 8 19:53:37.237926 kernel: BTRFS info (device xvda6): last unmount of filesystem bfaca09e-98f3-46e8-bdd8-6fce748bf2b6 Oct 8 19:53:37.244585 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 8 19:53:37.251334 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 8 19:53:37.274132 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 8 19:53:37.286344 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 8 19:53:37.304738 systemd-networkd[806]: lo: Link UP Oct 8 19:53:37.304747 systemd-networkd[806]: lo: Gained carrier Oct 8 19:53:37.306255 systemd-networkd[806]: Enumeration completed Oct 8 19:53:37.306358 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 8 19:53:37.306879 systemd[1]: Reached target network.target - Network. Oct 8 19:53:37.307021 systemd-networkd[806]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:53:37.307025 systemd-networkd[806]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 8 19:53:37.319563 systemd-networkd[806]: eth0: Link UP Oct 8 19:53:37.323941 kernel: ixgbevf 0000:00:03.0: NIC Link is Up 10 Gbps Oct 8 19:53:37.321344 systemd-networkd[806]: eth0: Gained carrier Oct 8 19:53:37.321352 systemd-networkd[806]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:53:37.343214 systemd-networkd[806]: eth0: DHCPv4 address 172.31.30.118/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 8 19:53:37.390199 kernel: ixgbevf 0000:00:03.0: NIC Link is Up 10 Gbps Oct 8 19:53:38.433265 systemd-networkd[806]: eth0: Gained IPv6LL Oct 8 19:53:39.718615 ignition[769]: Ignition 2.19.0 Oct 8 19:53:39.718627 ignition[769]: Stage: fetch-offline Oct 8 19:53:39.718815 ignition[769]: no configs at "/usr/lib/ignition/base.d" Oct 8 19:53:39.718825 ignition[769]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:53:39.719550 ignition[769]: Ignition finished successfully Oct 8 19:53:39.723312 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 8 19:53:39.737103 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 8 19:53:39.749527 ignition[822]: Ignition 2.19.0 Oct 8 19:53:39.749538 ignition[822]: Stage: fetch Oct 8 19:53:39.749820 ignition[822]: no configs at "/usr/lib/ignition/base.d" Oct 8 19:53:39.749830 ignition[822]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:53:39.749914 ignition[822]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:53:39.760951 ignition[822]: PUT result: OK Oct 8 19:53:39.770227 ignition[822]: parsed url from cmdline: "" Oct 8 19:53:39.770236 ignition[822]: no config URL provided Oct 8 19:53:39.770245 ignition[822]: reading system config file "/usr/lib/ignition/user.ign" Oct 8 19:53:39.770255 ignition[822]: no config at "/usr/lib/ignition/user.ign" Oct 8 19:53:39.770273 ignition[822]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:53:39.771963 ignition[822]: PUT result: OK Oct 8 19:53:39.772235 ignition[822]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Oct 8 19:53:39.778613 unknown[822]: fetched base config from "system" Oct 8 19:53:39.774232 ignition[822]: GET result: OK Oct 8 19:53:39.778620 unknown[822]: fetched base config from "system" Oct 8 19:53:39.774283 ignition[822]: parsing config with SHA512: 192ef2ef5ba09b3c210c52c993fee8479ce25b236e58549f4a2eb25d39e6a142786533efab848c5d73806ae60b91533bd2be2c7aa7c1ddf9896e77880ee807ac Oct 8 19:53:39.778625 unknown[822]: fetched user config from "aws" Oct 8 19:53:39.778765 ignition[822]: fetch: fetch complete Oct 8 19:53:39.780588 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 8 19:53:39.778770 ignition[822]: fetch: fetch passed Oct 8 19:53:39.778800 ignition[822]: Ignition finished successfully Oct 8 19:53:39.798264 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 8 19:53:39.811815 ignition[834]: Ignition 2.19.0 Oct 8 19:53:39.811825 ignition[834]: Stage: kargs Oct 8 19:53:39.812108 ignition[834]: no configs at "/usr/lib/ignition/base.d" Oct 8 19:53:39.812118 ignition[834]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:53:39.812208 ignition[834]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:53:39.813013 ignition[834]: PUT result: OK Oct 8 19:53:39.828854 ignition[834]: kargs: kargs passed Oct 8 19:53:39.828893 ignition[834]: Ignition finished successfully Oct 8 19:53:39.830349 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 8 19:53:39.842339 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 8 19:53:39.854440 ignition[842]: Ignition 2.19.0 Oct 8 19:53:39.854453 ignition[842]: Stage: disks Oct 8 19:53:39.854843 ignition[842]: no configs at "/usr/lib/ignition/base.d" Oct 8 19:53:39.854856 ignition[842]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:53:39.854959 ignition[842]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:53:39.858226 ignition[842]: PUT result: OK Oct 8 19:53:39.871049 ignition[842]: disks: disks passed Oct 8 19:53:39.871280 ignition[842]: Ignition finished successfully Oct 8 19:53:39.873492 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 8 19:53:39.874116 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 8 19:53:39.875660 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 8 19:53:39.877420 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 8 19:53:39.882402 systemd[1]: Reached target sysinit.target - System Initialization. Oct 8 19:53:39.883800 systemd[1]: Reached target basic.target - Basic System. Oct 8 19:53:39.906284 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 8 19:53:40.058067 systemd-fsck[855]: ROOT: clean, 14/553520 files, 52654/553472 blocks Oct 8 19:53:40.062283 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 8 19:53:40.076304 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 8 19:53:40.196192 kernel: EXT4-fs (xvda9): mounted filesystem 1df90f14-3ad0-4280-9b7d-a34f65d70e4d r/w with ordered data mode. Quota mode: none. Oct 8 19:53:40.196319 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 8 19:53:40.198327 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 8 19:53:40.347245 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 8 19:53:40.349295 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 8 19:53:40.350853 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 8 19:53:40.350892 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 8 19:53:40.350915 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 8 19:53:40.356910 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 8 19:53:40.362706 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 8 19:53:40.387196 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/xvda6 scanned by mount (864) Oct 8 19:53:40.390343 kernel: BTRFS info (device xvda6): first mount of filesystem bfaca09e-98f3-46e8-bdd8-6fce748bf2b6 Oct 8 19:53:40.390381 kernel: BTRFS info (device xvda6): using crc32c (crc32c-intel) checksum algorithm Oct 8 19:53:40.390399 kernel: BTRFS info (device xvda6): using free space tree Oct 8 19:53:40.426203 kernel: BTRFS info (device xvda6): enabling ssd optimizations Oct 8 19:53:40.426907 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 8 19:53:42.971079 initrd-setup-root[888]: cut: /sysroot/etc/passwd: No such file or directory Oct 8 19:53:42.975743 initrd-setup-root[895]: cut: /sysroot/etc/group: No such file or directory Oct 8 19:53:42.980793 initrd-setup-root[902]: cut: /sysroot/etc/shadow: No such file or directory Oct 8 19:53:42.984641 initrd-setup-root[909]: cut: /sysroot/etc/gshadow: No such file or directory Oct 8 19:53:44.520009 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 8 19:53:44.531314 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 8 19:53:44.533054 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 8 19:53:44.537511 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 8 19:53:44.538725 kernel: BTRFS info (device xvda6): last unmount of filesystem bfaca09e-98f3-46e8-bdd8-6fce748bf2b6 Oct 8 19:53:44.558758 ignition[976]: INFO : Ignition 2.19.0 Oct 8 19:53:44.558758 ignition[976]: INFO : Stage: mount Oct 8 19:53:44.560869 ignition[976]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 8 19:53:44.560869 ignition[976]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:53:44.562843 ignition[976]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:53:44.573407 ignition[976]: INFO : PUT result: OK Oct 8 19:53:44.575535 ignition[976]: INFO : mount: mount passed Oct 8 19:53:44.576307 ignition[976]: INFO : Ignition finished successfully Oct 8 19:53:44.578107 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 8 19:53:44.588299 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 8 19:53:44.590163 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 8 19:53:44.594127 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 8 19:53:44.620711 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/xvda6 scanned by mount (993) Oct 8 19:53:44.622477 kernel: BTRFS info (device xvda6): first mount of filesystem bfaca09e-98f3-46e8-bdd8-6fce748bf2b6 Oct 8 19:53:44.622500 kernel: BTRFS info (device xvda6): using crc32c (crc32c-intel) checksum algorithm Oct 8 19:53:44.622517 kernel: BTRFS info (device xvda6): using free space tree Oct 8 19:53:44.627201 kernel: BTRFS info (device xvda6): enabling ssd optimizations Oct 8 19:53:44.628988 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 8 19:53:44.652999 ignition[1010]: INFO : Ignition 2.19.0 Oct 8 19:53:44.652999 ignition[1010]: INFO : Stage: files Oct 8 19:53:44.654587 ignition[1010]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 8 19:53:44.654587 ignition[1010]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:53:44.654587 ignition[1010]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:53:44.658413 ignition[1010]: INFO : PUT result: OK Oct 8 19:53:44.659387 ignition[1010]: DEBUG : files: compiled without relabeling support, skipping Oct 8 19:53:44.669151 ignition[1010]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 8 19:53:44.669151 ignition[1010]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 8 19:53:44.810979 ignition[1010]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 8 19:53:44.813195 ignition[1010]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 8 19:53:44.813195 ignition[1010]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 8 19:53:44.813047 unknown[1010]: wrote ssh authorized keys file for user: core Oct 8 19:53:44.825126 ignition[1010]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 8 19:53:44.825126 ignition[1010]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 8 19:53:44.825126 ignition[1010]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 8 19:53:44.825126 ignition[1010]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 8 19:53:44.825126 ignition[1010]: INFO : files: files passed Oct 8 19:53:44.825126 ignition[1010]: INFO : Ignition finished successfully Oct 8 19:53:44.816846 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 8 19:53:44.846345 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 8 19:53:44.850050 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 8 19:53:44.851710 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 8 19:53:44.851795 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 8 19:53:44.874886 initrd-setup-root-after-ignition[1043]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 8 19:53:44.874886 initrd-setup-root-after-ignition[1043]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 8 19:53:44.871297 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 8 19:53:44.887240 initrd-setup-root-after-ignition[1047]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 8 19:53:44.873548 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 8 19:53:44.876171 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 8 19:53:44.910026 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 8 19:53:44.910497 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 8 19:53:44.911534 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 8 19:53:44.922384 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 8 19:53:44.922725 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 8 19:53:44.923412 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 8 19:53:44.948338 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 8 19:53:44.949808 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 8 19:53:44.962506 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 8 19:53:44.962962 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:53:44.965713 systemd[1]: Stopped target timers.target - Timer Units. Oct 8 19:53:44.967556 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 8 19:53:44.967668 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 8 19:53:44.971469 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 8 19:53:44.971749 systemd[1]: Stopped target basic.target - Basic System. Oct 8 19:53:44.981887 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 8 19:53:44.984016 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 8 19:53:44.986052 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 8 19:53:44.987520 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 8 19:53:44.989267 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 8 19:53:44.991252 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 8 19:53:44.993297 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 8 19:53:45.005885 systemd[1]: Stopped target swap.target - Swaps. Oct 8 19:53:45.007431 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 8 19:53:45.007535 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 8 19:53:45.018964 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:53:45.029669 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:53:45.030096 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 8 19:53:45.030354 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:53:45.032778 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 8 19:53:45.032883 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 8 19:53:45.053959 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 8 19:53:45.054112 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 8 19:53:45.055865 systemd[1]: ignition-files.service: Deactivated successfully. Oct 8 19:53:45.055961 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 8 19:53:45.082323 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 8 19:53:45.082707 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 8 19:53:45.082807 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:53:45.086445 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 8 19:53:45.089548 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 8 19:53:45.089686 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:53:45.091539 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 8 19:53:45.100647 ignition[1067]: INFO : Ignition 2.19.0 Oct 8 19:53:45.100647 ignition[1067]: INFO : Stage: umount Oct 8 19:53:45.100647 ignition[1067]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 8 19:53:45.100647 ignition[1067]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:53:45.100647 ignition[1067]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:53:45.091668 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 8 19:53:45.119657 ignition[1067]: INFO : PUT result: OK Oct 8 19:53:45.119657 ignition[1067]: INFO : umount: umount passed Oct 8 19:53:45.119657 ignition[1067]: INFO : Ignition finished successfully Oct 8 19:53:45.102404 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 8 19:53:45.102490 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 8 19:53:45.120377 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 8 19:53:45.121556 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 8 19:53:45.121640 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 8 19:53:45.137589 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 8 19:53:45.137628 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 8 19:53:45.138729 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 8 19:53:45.138773 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 8 19:53:45.140490 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 8 19:53:45.140528 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 8 19:53:45.150290 systemd[1]: Stopped target network.target - Network. Oct 8 19:53:45.151934 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 8 19:53:45.151980 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 8 19:53:45.161759 systemd[1]: Stopped target paths.target - Path Units. Oct 8 19:53:45.163053 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 8 19:53:45.166237 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:53:45.172851 systemd[1]: Stopped target slices.target - Slice Units. Oct 8 19:53:45.174760 systemd[1]: Stopped target sockets.target - Socket Units. Oct 8 19:53:45.176235 systemd[1]: iscsid.socket: Deactivated successfully. Oct 8 19:53:45.176271 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 8 19:53:45.185521 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 8 19:53:45.185555 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 8 19:53:45.197503 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 8 19:53:45.197540 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 8 19:53:45.209886 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 8 19:53:45.209921 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 8 19:53:45.211704 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 8 19:53:45.219204 systemd-networkd[806]: eth0: DHCPv6 lease lost Oct 8 19:53:45.221633 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 8 19:53:45.234686 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 8 19:53:45.234780 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 8 19:53:45.236621 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 8 19:53:45.236743 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 8 19:53:45.246656 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 8 19:53:45.246736 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 8 19:53:45.248602 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 8 19:53:45.248638 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 8 19:53:45.258371 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 8 19:53:45.258428 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 8 19:53:45.271293 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 8 19:53:45.271564 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 8 19:53:45.271632 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 8 19:53:45.281531 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 8 19:53:45.281573 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:53:45.283590 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 8 19:53:45.283638 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 8 19:53:45.286234 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 8 19:53:45.286273 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 8 19:53:45.286593 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:53:45.306090 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 8 19:53:45.306286 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:53:45.308069 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 8 19:53:45.308106 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 8 19:53:45.318514 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 8 19:53:45.318546 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:53:45.329548 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 8 19:53:45.329585 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 8 19:53:45.338998 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 8 19:53:45.339035 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 8 19:53:45.343255 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 8 19:53:45.343292 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:53:45.367538 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 8 19:53:45.377725 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 8 19:53:45.377791 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:53:45.378432 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 8 19:53:45.378469 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:53:45.381228 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 8 19:53:45.381306 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 8 19:53:45.390376 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 8 19:53:45.390459 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 8 19:53:45.392434 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 8 19:53:45.417336 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 8 19:53:45.438106 systemd[1]: Switching root. Oct 8 19:53:45.645942 systemd-journald[219]: Journal stopped Oct 8 19:53:52.246440 systemd-journald[219]: Received SIGTERM from PID 1 (systemd). Oct 8 19:53:52.246550 kernel: SELinux: policy capability network_peer_controls=1 Oct 8 19:53:52.246583 kernel: SELinux: policy capability open_perms=1 Oct 8 19:53:52.246613 kernel: SELinux: policy capability extended_socket_class=1 Oct 8 19:53:52.246645 kernel: SELinux: policy capability always_check_network=0 Oct 8 19:53:52.246678 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 8 19:53:52.246712 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 8 19:53:52.246747 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 8 19:53:52.246776 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 8 19:53:52.246812 kernel: audit: type=1403 audit(1728417227.363:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 8 19:53:52.246849 systemd[1]: Successfully loaded SELinux policy in 146.601ms. Oct 8 19:53:52.246895 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.242ms. Oct 8 19:53:52.246930 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) Oct 8 19:53:52.246959 systemd[1]: Detected virtualization xen. Oct 8 19:53:52.246976 systemd[1]: Detected architecture x86-64. Oct 8 19:53:52.246991 systemd[1]: Detected first boot. Oct 8 19:53:52.247009 systemd[1]: Initializing machine ID from VM UUID. Oct 8 19:53:52.247024 zram_generator::config[1117]: No configuration found. Oct 8 19:53:52.247049 systemd[1]: Populated /etc with preset unit settings. Oct 8 19:53:52.247067 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 8 19:53:52.247083 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 8 19:53:52.247116 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 8 19:53:52.247135 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 8 19:53:52.247151 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 8 19:53:52.247167 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 8 19:53:52.247197 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 8 19:53:52.247214 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 8 19:53:52.247233 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 8 19:53:52.247255 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 8 19:53:52.247273 systemd[1]: Created slice user.slice - User and Session Slice. Oct 8 19:53:52.247289 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:53:52.247304 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:53:52.247319 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 8 19:53:52.247337 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 8 19:53:52.247353 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 8 19:53:52.247369 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 8 19:53:52.247384 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 8 19:53:52.247402 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:53:52.247418 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 8 19:53:52.247433 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 8 19:53:52.247450 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 8 19:53:52.247468 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 8 19:53:52.247484 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:53:52.247504 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 8 19:53:52.247520 systemd[1]: Reached target slices.target - Slice Units. Oct 8 19:53:52.247535 systemd[1]: Reached target swap.target - Swaps. Oct 8 19:53:52.247551 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 8 19:53:52.247575 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 8 19:53:52.247591 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 8 19:53:52.247606 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 8 19:53:52.247624 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:53:52.247639 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 8 19:53:52.247655 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 8 19:53:52.247670 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 8 19:53:52.247686 systemd[1]: Mounting media.mount - External Media Directory... Oct 8 19:53:52.247701 systemd[1]: Mounting proc-xen.mount - /proc/xen... Oct 8 19:53:52.247717 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 8 19:53:52.247733 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 8 19:53:52.247748 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 8 19:53:52.247767 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). Oct 8 19:53:52.247782 systemd[1]: Reached target machines.target - Containers. Oct 8 19:53:52.247798 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 8 19:53:52.247816 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 8 19:53:52.247832 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 8 19:53:52.247848 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 8 19:53:52.247864 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:53:52.247882 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 8 19:53:52.247900 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:53:52.247915 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 8 19:53:52.247931 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:53:52.247946 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 8 19:53:52.247962 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 8 19:53:52.247978 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 8 19:53:52.247993 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 8 19:53:52.248009 systemd[1]: Stopped systemd-fsck-usr.service. Oct 8 19:53:52.248025 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 8 19:53:52.248043 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 8 19:53:52.248058 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 8 19:53:52.248073 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 8 19:53:52.248089 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 8 19:53:52.248119 systemd[1]: verity-setup.service: Deactivated successfully. Oct 8 19:53:52.248135 systemd[1]: Stopped verity-setup.service. Oct 8 19:53:52.248151 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:53:52.248167 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:53:52.248197 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:53:52.248218 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:53:52.248235 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:53:52.248250 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 8 19:53:52.248266 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 8 19:53:52.248281 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 8 19:53:52.248299 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 8 19:53:52.248315 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 8 19:53:52.248330 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 8 19:53:52.248346 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 8 19:53:52.248362 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 8 19:53:52.248377 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 8 19:53:52.248393 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 8 19:53:52.248408 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 8 19:53:52.248426 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 8 19:53:52.248442 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 8 19:53:52.248460 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 8 19:53:52.248499 systemd-journald[1190]: Collecting audit messages is disabled. Oct 8 19:53:52.248532 systemd-journald[1190]: Journal started Oct 8 19:53:52.248563 systemd-journald[1190]: Runtime Journal (/run/log/journal/ec2df8dcfd2e28463067896a0aea3542) is 8.0M, max 641.9M, 633.9M free. Oct 8 19:53:51.440563 systemd[1]: Queued start job for default target multi-user.target. Oct 8 19:53:51.792389 systemd[1]: Unnecessary job was removed for dev-xvda6.device - /dev/xvda6. Oct 8 19:53:51.792796 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 8 19:53:52.250377 systemd[1]: Started systemd-journald.service - Journal Service. Oct 8 19:53:52.250729 kernel: loop: module loaded Oct 8 19:53:52.252125 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:53:52.252315 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:53:52.259373 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 8 19:53:52.260603 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 8 19:53:52.296547 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 8 19:53:52.297761 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 8 19:53:52.299019 systemd[1]: Mounted media.mount - External Media Directory. Oct 8 19:53:52.300171 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 8 19:53:52.301374 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 8 19:53:52.312789 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 8 19:53:52.313921 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 8 19:53:52.317458 systemd[1]: Mounted proc-xen.mount - /proc/xen. Oct 8 19:53:52.322438 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 8 19:53:52.324699 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Oct 8 19:53:52.357261 kernel: fuse: init (API version 7.39) Oct 8 19:53:52.366521 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 8 19:53:52.368662 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 8 19:53:52.369911 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:53:52.370822 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Oct 8 19:53:52.372912 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 8 19:53:52.375493 systemd[1]: Starting xenserver-pv-version.service - Set fake PV driver version for XenServer... Oct 8 19:53:52.377812 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 8 19:53:52.379569 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 8 19:53:52.379701 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 8 19:53:52.381137 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:53:52.382490 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 8 19:53:52.387105 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 8 19:53:52.389079 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 8 19:53:52.390685 systemd[1]: Finished xenserver-pv-version.service - Set fake PV driver version for XenServer. Oct 8 19:53:52.394456 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 8 19:53:52.399090 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Oct 8 19:53:52.404977 systemd-journald[1190]: Time spent on flushing to /var/log/journal/ec2df8dcfd2e28463067896a0aea3542 is 29.373ms for 974 entries. Oct 8 19:53:52.404977 systemd-journald[1190]: System Journal (/var/log/journal/ec2df8dcfd2e28463067896a0aea3542) is 8.0M, max 195.6M, 187.6M free. Oct 8 19:53:52.462318 systemd-journald[1190]: Received client request to flush runtime journal. Oct 8 19:53:52.462398 kernel: ACPI: bus type drm_connector registered Oct 8 19:53:52.437507 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:53:52.439989 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 8 19:53:52.453632 udevadm[1263]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 8 19:53:52.462579 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 8 19:53:52.462714 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 8 19:53:52.464013 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 8 19:53:52.514206 kernel: loop0: detected capacity change from 0 to 140768 Oct 8 19:53:52.534857 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 8 19:53:52.550301 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 8 19:53:52.568989 systemd-tmpfiles[1267]: ACLs are not supported, ignoring. Oct 8 19:53:52.569015 systemd-tmpfiles[1267]: ACLs are not supported, ignoring. Oct 8 19:53:52.573391 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:53:53.155204 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 8 19:53:53.186298 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 8 19:53:53.351226 kernel: loop1: detected capacity change from 0 to 142488 Oct 8 19:53:53.365939 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 8 19:53:53.381375 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:53:53.403161 systemd-udevd[1274]: Using default interface naming scheme 'v255'. Oct 8 19:53:53.607336 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:53:53.618345 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 8 19:53:53.626219 (udev-worker)[1277]: Network interface NamePolicy= disabled on kernel command line. Oct 8 19:53:53.627195 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 8 19:53:53.642212 kernel: BTRFS warning: duplicate device /dev/xvda3 devid 1 generation 38 scanned by (udev-worker) (1283) Oct 8 19:53:53.668197 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1280) Oct 8 19:53:53.673228 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1280) Oct 8 19:53:53.686204 kernel: piix4_smbus 0000:00:01.3: SMBus base address uninitialized - upgrade BIOS or use force_addr=0xaddr Oct 8 19:53:53.687286 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 8 19:53:53.700332 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 8 19:53:53.705347 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:53:53.713294 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 8 19:53:53.762318 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 8 19:53:53.764192 kernel: input: ImPS/2 Generic Wheel Mouse as /devices/platform/i8042/serio1/input/input2 Oct 8 19:53:53.768199 kernel: mousedev: PS/2 mouse device common for all mice Oct 8 19:53:53.785201 kernel: EDAC MC: Ver: 3.0.0 Oct 8 19:53:53.802198 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Oct 8 19:53:53.802625 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 8 19:53:53.806685 kernel: ACPI: button: Power Button [PWRF] Oct 8 19:53:53.806729 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input4 Oct 8 19:53:53.807241 kernel: ACPI: button: Sleep Button [SLPF] Oct 8 19:53:53.845078 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 8 19:53:53.859335 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 8 19:53:53.897559 systemd-networkd[1284]: lo: Link UP Oct 8 19:53:53.897568 systemd-networkd[1284]: lo: Gained carrier Oct 8 19:53:53.897988 lvm[1331]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 8 19:53:53.899044 systemd-networkd[1284]: Enumeration completed Oct 8 19:53:53.899144 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 8 19:53:53.900686 systemd-networkd[1284]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:53:53.900695 systemd-networkd[1284]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 8 19:53:53.913832 systemd-networkd[1284]: eth0: Link UP Oct 8 19:53:53.915200 kernel: ixgbevf 0000:00:03.0: NIC Link is Up 10 Gbps Oct 8 19:53:53.915937 systemd-networkd[1284]: eth0: Gained carrier Oct 8 19:53:53.915961 systemd-networkd[1284]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:53:53.920843 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 8 19:53:53.935217 systemd-networkd[1284]: eth0: DHCPv4 address 172.31.30.118/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 8 19:53:53.936631 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 8 19:53:53.937227 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:53:53.938330 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 8 19:53:53.945960 lvm[1336]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 8 19:53:53.984635 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 8 19:53:54.042202 kernel: loop2: detected capacity change from 0 to 61336 Oct 8 19:53:54.095203 kernel: loop3: detected capacity change from 0 to 140768 Oct 8 19:53:54.119198 kernel: loop4: detected capacity change from 0 to 142488 Oct 8 19:53:54.143202 kernel: loop5: detected capacity change from 0 to 61336 Oct 8 19:53:54.158748 (sd-merge)[1341]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Oct 8 19:53:54.159134 (sd-merge)[1341]: Merged extensions into '/usr'. Oct 8 19:53:54.162808 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 8 19:53:54.175398 systemd[1]: Starting ensure-sysext.service... Oct 8 19:53:54.176602 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 8 19:53:54.182244 systemd[1]: Reloading requested from client PID 1343 ('systemctl') (unit ensure-sysext.service)... Oct 8 19:53:54.182258 systemd[1]: Reloading... Oct 8 19:53:54.197318 systemd-tmpfiles[1344]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 8 19:53:54.197648 systemd-tmpfiles[1344]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 8 19:53:54.198561 systemd-tmpfiles[1344]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 8 19:53:54.198822 systemd-tmpfiles[1344]: ACLs are not supported, ignoring. Oct 8 19:53:54.198884 systemd-tmpfiles[1344]: ACLs are not supported, ignoring. Oct 8 19:53:54.202251 systemd-tmpfiles[1344]: Detected autofs mount point /boot during canonicalization of boot. Oct 8 19:53:54.202262 systemd-tmpfiles[1344]: Skipping /boot Oct 8 19:53:54.209923 systemd-tmpfiles[1344]: Detected autofs mount point /boot during canonicalization of boot. Oct 8 19:53:54.209940 systemd-tmpfiles[1344]: Skipping /boot Oct 8 19:53:54.226258 zram_generator::config[1379]: No configuration found. Oct 8 19:53:54.348508 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. Oct 8 19:53:54.401477 systemd[1]: Reloading finished in 218 ms. Oct 8 19:53:54.430837 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:53:54.432908 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 8 19:53:54.440436 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 8 19:53:54.442965 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 8 19:53:54.445008 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 8 19:53:54.447786 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 8 19:53:54.450049 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 8 19:53:54.456912 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 8 19:53:54.458267 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:53:54.461249 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:53:54.463535 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:53:54.464822 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:53:54.469405 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:53:54.469552 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:53:54.471456 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:53:54.471619 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:53:54.474207 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:53:54.474372 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:53:54.478802 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 8 19:53:54.483476 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 8 19:53:54.514482 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:53:54.516675 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 8 19:53:54.518555 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:53:54.521515 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:53:54.522751 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:53:54.523053 systemd[1]: Reached target time-set.target - System Time Set. Oct 8 19:53:54.525703 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 8 19:53:54.527744 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:53:54.527924 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:53:54.529511 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 8 19:53:54.529628 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 8 19:53:54.531061 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:53:54.531195 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:53:54.533139 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:53:54.533304 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:53:54.535888 systemd[1]: Finished ensure-sysext.service. Oct 8 19:53:54.540128 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 8 19:53:54.540203 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 8 19:53:54.578388 systemd-resolved[1431]: Positive Trust Anchors: Oct 8 19:53:54.578403 systemd-resolved[1431]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 8 19:53:54.578453 systemd-resolved[1431]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 8 19:53:54.584296 systemd-resolved[1431]: Defaulting to hostname 'linux'. Oct 8 19:53:54.585972 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 8 19:53:54.587099 systemd[1]: Reached target network.target - Network. Oct 8 19:53:54.587951 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 8 19:53:54.602962 augenrules[1466]: No rules Oct 8 19:53:54.605000 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 8 19:53:54.823649 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 8 19:53:54.825290 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). Oct 8 19:53:55.009311 systemd-networkd[1284]: eth0: Gained IPv6LL Oct 8 19:53:55.013231 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 8 19:53:55.014657 systemd[1]: Reached target network-online.target - Network is Online. Oct 8 19:53:58.171407 ldconfig[1245]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 8 19:53:58.183959 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 8 19:53:58.197340 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 8 19:53:58.207165 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 8 19:53:58.208459 systemd[1]: Reached target sysinit.target - System Initialization. Oct 8 19:53:58.209577 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 8 19:53:58.210773 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 8 19:53:58.212073 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 8 19:53:58.216849 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 8 19:53:58.218028 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 8 19:53:58.219210 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 8 19:53:58.219250 systemd[1]: Reached target paths.target - Path Units. Oct 8 19:53:58.220091 systemd[1]: Reached target timers.target - Timer Units. Oct 8 19:53:58.229577 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 8 19:53:58.231675 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 8 19:53:58.241846 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 8 19:53:58.243335 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 8 19:53:58.244419 systemd[1]: Reached target sockets.target - Socket Units. Oct 8 19:53:58.245323 systemd[1]: Reached target basic.target - Basic System. Oct 8 19:53:58.246222 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 8 19:53:58.246247 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 8 19:53:58.247311 systemd[1]: Starting containerd.service - containerd container runtime... Oct 8 19:53:58.249572 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Oct 8 19:53:58.251425 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 8 19:53:58.253365 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 8 19:53:58.255691 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 8 19:53:58.256158 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). Oct 8 19:53:58.257328 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 8 19:53:58.259899 systemd[1]: Started ntpd.service - Network Time Service. Oct 8 19:53:58.262089 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 8 19:53:58.264586 systemd[1]: Starting setup-oem.service - Setup OEM... Oct 8 19:53:58.266303 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 8 19:53:58.268967 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 8 19:53:58.272170 jq[1482]: false Oct 8 19:53:58.273465 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 8 19:53:58.275144 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 8 19:53:58.275623 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 8 19:53:58.277556 systemd[1]: Starting update-engine.service - Update Engine... Oct 8 19:53:58.280472 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 8 19:53:58.284427 extend-filesystems[1483]: Found loop3 Oct 8 19:53:58.284427 extend-filesystems[1483]: Found loop4 Oct 8 19:53:58.284427 extend-filesystems[1483]: Found loop5 Oct 8 19:53:58.284427 extend-filesystems[1483]: Found xvda Oct 8 19:53:58.284427 extend-filesystems[1483]: Found xvda1 Oct 8 19:53:58.284427 extend-filesystems[1483]: Found xvda2 Oct 8 19:53:58.284427 extend-filesystems[1483]: Found xvda3 Oct 8 19:53:58.284427 extend-filesystems[1483]: Found usr Oct 8 19:53:58.284427 extend-filesystems[1483]: Found xvda4 Oct 8 19:53:58.284427 extend-filesystems[1483]: Found xvda6 Oct 8 19:53:58.284427 extend-filesystems[1483]: Found xvda7 Oct 8 19:53:58.284427 extend-filesystems[1483]: Found xvda9 Oct 8 19:53:58.284427 extend-filesystems[1483]: Checking size of /dev/xvda9 Oct 8 19:53:58.285488 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 8 19:53:58.315348 jq[1500]: true Oct 8 19:53:58.286393 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 8 19:53:58.315617 update_engine[1498]: I20241008 19:53:58.313591 1498 main.cc:92] Flatcar Update Engine starting Oct 8 19:53:58.287428 systemd[1]: motdgen.service: Deactivated successfully. Oct 8 19:53:58.287642 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 8 19:53:58.316277 extend-filesystems[1483]: Resized partition /dev/xvda9 Oct 8 19:53:58.291447 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 8 19:53:58.291602 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 8 19:53:58.304435 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 8 19:53:58.322846 (ntainerd)[1515]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 8 19:53:58.323812 dbus-daemon[1481]: [system] SELinux support is enabled Oct 8 19:53:58.324833 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 8 19:53:58.326107 jq[1513]: true Oct 8 19:53:58.326465 dbus-daemon[1481]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1284 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Oct 8 19:53:58.327616 update_engine[1498]: I20241008 19:53:58.327566 1498 update_check_scheduler.cc:74] Next update check in 7m56s Oct 8 19:53:58.329539 extend-filesystems[1528]: resize2fs 1.47.1 (20-May-2024) Oct 8 19:53:58.330924 systemd[1]: Finished setup-oem.service - Setup OEM. Oct 8 19:53:58.334449 kernel: EXT4-fs (xvda9): resizing filesystem from 553472 to 1489915 blocks Oct 8 19:53:58.336032 dbus-daemon[1481]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 8 19:53:58.337853 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Oct 8 19:53:58.339311 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). Oct 8 19:53:58.339352 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 8 19:53:58.340926 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). Oct 8 19:53:58.340957 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 8 19:53:58.342387 systemd-logind[1494]: Watching system buttons on /dev/input/event2 (Power Button) Oct 8 19:53:58.342417 systemd-logind[1494]: Watching system buttons on /dev/input/event3 (Sleep Button) Oct 8 19:53:58.342440 systemd-logind[1494]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Oct 8 19:53:58.342868 systemd-logind[1494]: New seat seat0. Oct 8 19:53:58.343690 systemd[1]: Started update-engine.service - Update Engine. Oct 8 19:53:58.344995 systemd[1]: Started systemd-logind.service - User Login Management. Oct 8 19:53:58.347221 kernel: BTRFS warning: duplicate device /dev/xvda3 devid 1 generation 38 scanned by (udev-worker) (1538) Oct 8 19:53:58.386387 ntpd[1485]: ntpd 4.2.8p17@1.4004-o Tue Oct 8 17:52:25 UTC 2024 (1): Starting Oct 8 19:53:58.452608 kernel: EXT4-fs (xvda9): resized filesystem to 1489915 Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: ntpd 4.2.8p17@1.4004-o Tue Oct 8 17:52:25 UTC 2024 (1): Starting Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: ---------------------------------------------------- Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: ntp-4 is maintained by Network Time Foundation, Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: corporation. Support and training for ntp-4 are Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: available at https://www.nwtime.org/support Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: ---------------------------------------------------- Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: proto: precision = 0.637 usec (-20) Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: basedate set to 2024-09-26 Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: gps base set to 2024-09-29 (week 2334) Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: Listen and drop on 0 v6wildcard [::]:123 Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: Listen normally on 2 lo 127.0.0.1:123 Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: Listen normally on 3 eth0 172.31.30.118:123 Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: Listen normally on 4 lo [::1]:123 Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: Listen normally on 5 eth0 [fe80::4e3:81ff:fe79:cbaf%2]:123 Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: Listening on routing socket on fd #22 for interface updates Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 8 19:53:58.452706 ntpd[1485]: 8 Oct 19:53:58 ntpd[1485]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 8 19:53:58.433208 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: Initializing new seelog logger Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: New Seelog Logger Creation Complete Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: 2024/10/08 19:53:58 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: 2024/10/08 19:53:58 processing appconfig overrides Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: 2024/10/08 19:53:58 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: 2024/10/08 19:53:58 processing appconfig overrides Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: 2024/10/08 19:53:58 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: 2024/10/08 19:53:58 processing appconfig overrides Oct 8 19:53:58.453891 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO Proxy environment variables: Oct 8 19:53:58.386412 ntpd[1485]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 8 19:53:58.455721 sshd_keygen[1524]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 8 19:53:58.436041 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 8 19:53:58.386420 ntpd[1485]: ---------------------------------------------------- Oct 8 19:53:58.455606 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 8 19:53:58.386426 ntpd[1485]: ntp-4 is maintained by Network Time Foundation, Oct 8 19:53:58.386433 ntpd[1485]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 8 19:53:58.386439 ntpd[1485]: corporation. Support and training for ntp-4 are Oct 8 19:53:58.386446 ntpd[1485]: available at https://www.nwtime.org/support Oct 8 19:53:58.386452 ntpd[1485]: ---------------------------------------------------- Oct 8 19:53:58.389144 ntpd[1485]: proto: precision = 0.637 usec (-20) Oct 8 19:53:58.389534 ntpd[1485]: basedate set to 2024-09-26 Oct 8 19:53:58.389551 ntpd[1485]: gps base set to 2024-09-29 (week 2334) Oct 8 19:53:58.391357 ntpd[1485]: Listen and drop on 0 v6wildcard [::]:123 Oct 8 19:53:58.391394 ntpd[1485]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 8 19:53:58.391612 ntpd[1485]: Listen normally on 2 lo 127.0.0.1:123 Oct 8 19:53:58.391678 ntpd[1485]: Listen normally on 3 eth0 172.31.30.118:123 Oct 8 19:53:58.391721 ntpd[1485]: Listen normally on 4 lo [::1]:123 Oct 8 19:53:58.391754 ntpd[1485]: Listen normally on 5 eth0 [fe80::4e3:81ff:fe79:cbaf%2]:123 Oct 8 19:53:58.391801 ntpd[1485]: Listening on routing socket on fd #22 for interface updates Oct 8 19:53:58.393010 ntpd[1485]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 8 19:53:58.393051 ntpd[1485]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 8 19:53:58.457339 amazon-ssm-agent[1535]: 2024/10/08 19:53:58 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:53:58.457339 amazon-ssm-agent[1535]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:53:58.457436 amazon-ssm-agent[1535]: 2024/10/08 19:53:58 processing appconfig overrides Oct 8 19:53:58.458757 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 8 19:53:58.470134 systemd[1]: issuegen.service: Deactivated successfully. Oct 8 19:53:58.470321 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 8 19:53:58.472733 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 8 19:53:58.477017 extend-filesystems[1528]: Filesystem at /dev/xvda9 is mounted on /; on-line resizing required Oct 8 19:53:58.477017 extend-filesystems[1528]: old_desc_blocks = 1, new_desc_blocks = 1 Oct 8 19:53:58.477017 extend-filesystems[1528]: The filesystem on /dev/xvda9 is now 1489915 (4k) blocks long. Oct 8 19:53:58.478433 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 8 19:53:58.481973 extend-filesystems[1483]: Resized filesystem in /dev/xvda9 Oct 8 19:53:58.478609 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 8 19:53:58.493484 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 8 19:53:58.497328 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 8 19:53:58.501396 dbus-daemon[1481]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 8 19:53:58.501667 dbus-daemon[1481]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1552 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Oct 8 19:53:58.504700 bash[1566]: Updated "/home/core/.ssh/authorized_keys" Oct 8 19:53:58.506019 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 8 19:53:58.507302 systemd[1]: Reached target getty.target - Login Prompts. Oct 8 19:53:58.508755 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 8 19:53:58.510763 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Oct 8 19:53:58.512562 coreos-metadata[1480]: Oct 08 19:53:58.512 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 8 19:53:58.513367 coreos-metadata[1480]: Oct 08 19:53:58.513 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Oct 8 19:53:58.514410 coreos-metadata[1480]: Oct 08 19:53:58.514 INFO Fetch successful Oct 8 19:53:58.514410 coreos-metadata[1480]: Oct 08 19:53:58.514 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Oct 8 19:53:58.514681 coreos-metadata[1480]: Oct 08 19:53:58.514 INFO Fetch successful Oct 8 19:53:58.514681 coreos-metadata[1480]: Oct 08 19:53:58.514 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Oct 8 19:53:58.515156 coreos-metadata[1480]: Oct 08 19:53:58.515 INFO Fetch successful Oct 8 19:53:58.515265 coreos-metadata[1480]: Oct 08 19:53:58.515 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Oct 8 19:53:58.515445 systemd[1]: Starting polkit.service - Authorization Manager... Oct 8 19:53:58.515678 coreos-metadata[1480]: Oct 08 19:53:58.515 INFO Fetch successful Oct 8 19:53:58.515678 coreos-metadata[1480]: Oct 08 19:53:58.515 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Oct 8 19:53:58.516471 coreos-metadata[1480]: Oct 08 19:53:58.516 INFO Fetch failed with 404: resource not found Oct 8 19:53:58.516546 coreos-metadata[1480]: Oct 08 19:53:58.516 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Oct 8 19:53:58.517029 coreos-metadata[1480]: Oct 08 19:53:58.517 INFO Fetch successful Oct 8 19:53:58.517083 coreos-metadata[1480]: Oct 08 19:53:58.517 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Oct 8 19:53:58.517806 coreos-metadata[1480]: Oct 08 19:53:58.517 INFO Fetch successful Oct 8 19:53:58.517806 coreos-metadata[1480]: Oct 08 19:53:58.517 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Oct 8 19:53:58.518166 coreos-metadata[1480]: Oct 08 19:53:58.518 INFO Fetch successful Oct 8 19:53:58.518166 coreos-metadata[1480]: Oct 08 19:53:58.518 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Oct 8 19:53:58.518306 systemd[1]: Starting sshkeys.service... Oct 8 19:53:58.519113 coreos-metadata[1480]: Oct 08 19:53:58.519 INFO Fetch successful Oct 8 19:53:58.519113 coreos-metadata[1480]: Oct 08 19:53:58.519 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Oct 8 19:53:58.519800 coreos-metadata[1480]: Oct 08 19:53:58.519 INFO Fetch successful Oct 8 19:53:58.532453 polkitd[1600]: Started polkitd version 121 Oct 8 19:53:58.532746 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Oct 8 19:53:58.535945 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Oct 8 19:53:58.537481 polkitd[1600]: Loading rules from directory /etc/polkit-1/rules.d Oct 8 19:53:58.537527 polkitd[1600]: Loading rules from directory /usr/share/polkit-1/rules.d Oct 8 19:53:58.538106 polkitd[1600]: Finished loading, compiling and executing 2 rules Oct 8 19:53:58.538255 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Oct 8 19:53:58.538668 dbus-daemon[1481]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 8 19:53:58.539442 polkitd[1600]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Oct 8 19:53:58.540020 systemd[1]: Started polkit.service - Authorization Manager. Oct 8 19:53:58.541681 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 8 19:53:58.551990 systemd-hostnamed[1552]: Hostname set to (transient) Oct 8 19:53:58.552914 systemd-resolved[1431]: System hostname changed to 'ip-172-31-30-118'. Oct 8 19:53:58.553892 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO no_proxy: Oct 8 19:53:58.571506 coreos-metadata[1609]: Oct 08 19:53:58.571 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 8 19:53:58.572422 coreos-metadata[1609]: Oct 08 19:53:58.572 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Oct 8 19:53:58.573205 coreos-metadata[1609]: Oct 08 19:53:58.573 INFO Fetch successful Oct 8 19:53:58.573266 coreos-metadata[1609]: Oct 08 19:53:58.573 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Oct 8 19:53:58.573747 coreos-metadata[1609]: Oct 08 19:53:58.573 INFO Fetch successful Oct 8 19:53:58.576666 unknown[1609]: wrote ssh authorized keys file for user: core Oct 8 19:53:58.629029 update-ssh-keys[1620]: Updated "/home/core/.ssh/authorized_keys" Oct 8 19:53:58.629856 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Oct 8 19:53:58.632521 systemd[1]: Finished sshkeys.service. Oct 8 19:53:58.651684 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO https_proxy: Oct 8 19:53:58.677455 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO http_proxy: Oct 8 19:53:58.677455 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO Checking if agent identity type OnPrem can be assumed Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO Checking if agent identity type EC2 can be assumed Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO Agent will take identity from EC2 Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [amazon-ssm-agent] using named pipe channel for IPC Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [amazon-ssm-agent] using named pipe channel for IPC Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [amazon-ssm-agent] using named pipe channel for IPC Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [amazon-ssm-agent] OS: linux, Arch: amd64 Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [amazon-ssm-agent] Starting Core Agent Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [amazon-ssm-agent] registrar detected. Attempting registration Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [Registrar] Starting registrar module Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Oct 8 19:53:58.677535 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [EC2Identity] EC2 registration was successful. Oct 8 19:53:58.677813 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [CredentialRefresher] credentialRefresher has started Oct 8 19:53:58.677813 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [CredentialRefresher] Starting credentials refresher loop Oct 8 19:53:58.677813 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO EC2RoleProvider Successfully connected with instance profile role credentials Oct 8 19:53:58.728962 locksmithd[1577]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 8 19:53:58.749553 amazon-ssm-agent[1535]: 2024-10-08 19:53:58 INFO [CredentialRefresher] Next credential rotation will be in 31.89999415505 minutes Oct 8 19:53:59.693316 amazon-ssm-agent[1535]: 2024-10-08 19:53:59 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Oct 8 19:53:59.766953 containerd[1515]: time="2024-10-08T19:53:59.766872649Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Oct 8 19:53:59.792648 containerd[1515]: time="2024-10-08T19:53:59.792606644Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:53:59.794007 containerd[1515]: time="2024-10-08T19:53:59.793974912Z" 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.54-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 8 19:53:59.794007 containerd[1515]: time="2024-10-08T19:53:59.794003877Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 8 19:53:59.794073 containerd[1515]: time="2024-10-08T19:53:59.794019223Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 8 19:53:59.794266 containerd[1515]: time="2024-10-08T19:53:59.794219663Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 8 19:53:59.794312 containerd[1515]: time="2024-10-08T19:53:59.794268427Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 8 19:53:59.794355 containerd[1515]: time="2024-10-08T19:53:59.794335563Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 8 19:53:59.794384 containerd[1515]: time="2024-10-08T19:53:59.794354215Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:53:59.795080 containerd[1515]: time="2024-10-08T19:53:59.794625655Z" 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 Oct 8 19:53:59.795080 containerd[1515]: time="2024-10-08T19:53:59.794665260Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 8 19:53:59.795080 containerd[1515]: time="2024-10-08T19:53:59.794719851Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Oct 8 19:53:59.795080 containerd[1515]: time="2024-10-08T19:53:59.794732986Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 8 19:53:59.795080 containerd[1515]: time="2024-10-08T19:53:59.794871740Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:53:59.795356 containerd[1515]: time="2024-10-08T19:53:59.795139524Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:53:59.795356 containerd[1515]: time="2024-10-08T19:53:59.795316269Z" 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 Oct 8 19:53:59.795356 containerd[1515]: time="2024-10-08T19:53:59.795333177Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 8 19:53:59.795489 amazon-ssm-agent[1535]: 2024-10-08 19:53:59 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:1636) started Oct 8 19:53:59.795542 containerd[1515]: time="2024-10-08T19:53:59.795412471Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 8 19:53:59.795542 containerd[1515]: time="2024-10-08T19:53:59.795451568Z" level=info msg="metadata content store policy set" policy=shared Oct 8 19:53:59.802317 containerd[1515]: time="2024-10-08T19:53:59.802286623Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 8 19:53:59.802411 containerd[1515]: time="2024-10-08T19:53:59.802339117Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 8 19:53:59.802411 containerd[1515]: time="2024-10-08T19:53:59.802363284Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 8 19:53:59.802411 containerd[1515]: time="2024-10-08T19:53:59.802386313Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 8 19:53:59.802641 containerd[1515]: time="2024-10-08T19:53:59.802408579Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 8 19:53:59.802641 containerd[1515]: time="2024-10-08T19:53:59.802572469Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 8 19:53:59.803298 containerd[1515]: time="2024-10-08T19:53:59.803261066Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 8 19:53:59.803514 containerd[1515]: time="2024-10-08T19:53:59.803481291Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 8 19:53:59.803579 containerd[1515]: time="2024-10-08T19:53:59.803523458Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 8 19:53:59.803579 containerd[1515]: time="2024-10-08T19:53:59.803556025Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 8 19:53:59.803685 containerd[1515]: time="2024-10-08T19:53:59.803589153Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 8 19:53:59.803685 containerd[1515]: time="2024-10-08T19:53:59.803615282Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 8 19:53:59.803879 containerd[1515]: time="2024-10-08T19:53:59.803851764Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 8 19:53:59.803934 containerd[1515]: time="2024-10-08T19:53:59.803884016Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 8 19:53:59.803934 containerd[1515]: time="2024-10-08T19:53:59.803909964Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 8 19:53:59.804030 containerd[1515]: time="2024-10-08T19:53:59.803931635Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 8 19:53:59.804030 containerd[1515]: time="2024-10-08T19:53:59.803954271Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 8 19:53:59.804030 containerd[1515]: time="2024-10-08T19:53:59.803974888Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 8 19:53:59.804030 containerd[1515]: time="2024-10-08T19:53:59.804005358Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804205 containerd[1515]: time="2024-10-08T19:53:59.804027715Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804205 containerd[1515]: time="2024-10-08T19:53:59.804049678Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804205 containerd[1515]: time="2024-10-08T19:53:59.804072462Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804205 containerd[1515]: time="2024-10-08T19:53:59.804092768Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804205 containerd[1515]: time="2024-10-08T19:53:59.804114958Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804205 containerd[1515]: time="2024-10-08T19:53:59.804134695Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804205 containerd[1515]: time="2024-10-08T19:53:59.804156282Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804203326Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804229681Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804247626Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804266554Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804286573Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804311338Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804353778Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804378351Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804397607Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804463252Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804488135Z" 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 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804507560Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 8 19:53:59.804533 containerd[1515]: time="2024-10-08T19:53:59.804528410Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 8 19:53:59.805112 containerd[1515]: time="2024-10-08T19:53:59.804545734Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.805112 containerd[1515]: time="2024-10-08T19:53:59.804571973Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 8 19:53:59.805112 containerd[1515]: time="2024-10-08T19:53:59.804593211Z" level=info msg="NRI interface is disabled by configuration." Oct 8 19:53:59.805112 containerd[1515]: time="2024-10-08T19:53:59.804610812Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 8 19:53:59.805340 containerd[1515]: time="2024-10-08T19:53:59.805010779Z" 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}" Oct 8 19:53:59.805340 containerd[1515]: time="2024-10-08T19:53:59.805095279Z" level=info msg="Connect containerd service" Oct 8 19:53:59.805340 containerd[1515]: time="2024-10-08T19:53:59.805142568Z" level=info msg="using legacy CRI server" Oct 8 19:53:59.805340 containerd[1515]: time="2024-10-08T19:53:59.805154529Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 8 19:53:59.805340 containerd[1515]: time="2024-10-08T19:53:59.805300826Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 8 19:53:59.805979 containerd[1515]: time="2024-10-08T19:53:59.805944279Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Oct 8 19:53:59.806194 containerd[1515]: time="2024-10-08T19:53:59.806130673Z" level=info msg="Start subscribing containerd event" Oct 8 19:53:59.806194 containerd[1515]: time="2024-10-08T19:53:59.806186098Z" level=info msg="Start recovering state" Oct 8 19:53:59.806312 containerd[1515]: time="2024-10-08T19:53:59.806262546Z" level=info msg="Start event monitor" Oct 8 19:53:59.806312 containerd[1515]: time="2024-10-08T19:53:59.806272871Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 8 19:53:59.806312 containerd[1515]: time="2024-10-08T19:53:59.806285005Z" level=info msg="Start snapshots syncer" Oct 8 19:53:59.806312 containerd[1515]: time="2024-10-08T19:53:59.806313649Z" level=info msg="Start cni network conf syncer for default" Oct 8 19:53:59.806486 containerd[1515]: time="2024-10-08T19:53:59.806323302Z" level=info msg="Start streaming server" Oct 8 19:53:59.806486 containerd[1515]: time="2024-10-08T19:53:59.806362421Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 8 19:53:59.806486 containerd[1515]: time="2024-10-08T19:53:59.806456948Z" level=info msg="containerd successfully booted in 0.040976s" Oct 8 19:53:59.806550 systemd[1]: Started containerd.service - containerd container runtime. Oct 8 19:53:59.807979 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 8 19:53:59.809440 systemd[1]: Startup finished in 811ms (kernel) + 14.567s (initrd) + 12.591s (userspace) = 27.970s. Oct 8 19:53:59.896914 amazon-ssm-agent[1535]: 2024-10-08 19:53:59 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Oct 8 19:54:05.111070 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 8 19:54:05.112157 systemd[1]: Started sshd@0-172.31.30.118:22-139.178.68.195:43006.service - OpenSSH per-connection server daemon (139.178.68.195:43006). Oct 8 19:54:06.564458 systemd-resolved[1431]: Clock change detected. Flushing caches. Oct 8 19:54:06.571755 sshd[1664]: Accepted publickey for core from 139.178.68.195 port 43006 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:06.573642 sshd[1664]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:06.582716 systemd-logind[1494]: New session 1 of user core. Oct 8 19:54:06.583755 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 8 19:54:06.595146 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 8 19:54:06.607312 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 8 19:54:06.609330 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 8 19:54:06.616446 (systemd)[1668]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:54:06.800704 systemd[1668]: Queued start job for default target default.target. Oct 8 19:54:06.807035 systemd[1668]: Created slice app.slice - User Application Slice. Oct 8 19:54:06.807066 systemd[1668]: Reached target paths.target - Paths. Oct 8 19:54:06.807083 systemd[1668]: Reached target timers.target - Timers. Oct 8 19:54:06.808124 systemd[1668]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 8 19:54:06.818875 systemd[1668]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 8 19:54:06.818934 systemd[1668]: Reached target sockets.target - Sockets. Oct 8 19:54:06.818969 systemd[1668]: Reached target basic.target - Basic System. Oct 8 19:54:06.819008 systemd[1668]: Reached target default.target - Main User Target. Oct 8 19:54:06.819043 systemd[1668]: Startup finished in 196ms. Oct 8 19:54:06.819254 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 8 19:54:06.821803 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 8 19:54:06.963389 systemd[1]: Started sshd@1-172.31.30.118:22-139.178.68.195:43008.service - OpenSSH per-connection server daemon (139.178.68.195:43008). Oct 8 19:54:07.119801 sshd[1679]: Accepted publickey for core from 139.178.68.195 port 43008 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:07.122000 sshd[1679]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:07.125577 systemd-logind[1494]: New session 2 of user core. Oct 8 19:54:07.138073 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 8 19:54:07.253188 sshd[1679]: pam_unix(sshd:session): session closed for user core Oct 8 19:54:07.255878 systemd[1]: sshd@1-172.31.30.118:22-139.178.68.195:43008.service: Deactivated successfully. Oct 8 19:54:07.257307 systemd[1]: session-2.scope: Deactivated successfully. Oct 8 19:54:07.257774 systemd-logind[1494]: Session 2 logged out. Waiting for processes to exit. Oct 8 19:54:07.258885 systemd-logind[1494]: Removed session 2. Oct 8 19:54:07.285746 systemd[1]: Started sshd@2-172.31.30.118:22-139.178.68.195:43024.service - OpenSSH per-connection server daemon (139.178.68.195:43024). Oct 8 19:54:07.446452 sshd[1686]: Accepted publickey for core from 139.178.68.195 port 43024 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:07.447541 sshd[1686]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:07.450845 systemd-logind[1494]: New session 3 of user core. Oct 8 19:54:07.463096 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 8 19:54:07.577637 sshd[1686]: pam_unix(sshd:session): session closed for user core Oct 8 19:54:07.580470 systemd[1]: sshd@2-172.31.30.118:22-139.178.68.195:43024.service: Deactivated successfully. Oct 8 19:54:07.582029 systemd[1]: session-3.scope: Deactivated successfully. Oct 8 19:54:07.582608 systemd-logind[1494]: Session 3 logged out. Waiting for processes to exit. Oct 8 19:54:07.583773 systemd-logind[1494]: Removed session 3. Oct 8 19:54:07.612229 systemd[1]: Started sshd@3-172.31.30.118:22-139.178.68.195:43028.service - OpenSSH per-connection server daemon (139.178.68.195:43028). Oct 8 19:54:07.773573 sshd[1693]: Accepted publickey for core from 139.178.68.195 port 43028 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:07.775544 sshd[1693]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:07.779270 systemd-logind[1494]: New session 4 of user core. Oct 8 19:54:07.801087 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 8 19:54:07.917862 sshd[1693]: pam_unix(sshd:session): session closed for user core Oct 8 19:54:07.920542 systemd[1]: sshd@3-172.31.30.118:22-139.178.68.195:43028.service: Deactivated successfully. Oct 8 19:54:07.921931 systemd[1]: session-4.scope: Deactivated successfully. Oct 8 19:54:07.922492 systemd-logind[1494]: Session 4 logged out. Waiting for processes to exit. Oct 8 19:54:07.923645 systemd-logind[1494]: Removed session 4. Oct 8 19:54:07.949762 systemd[1]: Started sshd@4-172.31.30.118:22-139.178.68.195:43034.service - OpenSSH per-connection server daemon (139.178.68.195:43034). Oct 8 19:54:08.107869 sshd[1700]: Accepted publickey for core from 139.178.68.195 port 43034 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:08.109032 sshd[1700]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:08.112267 systemd-logind[1494]: New session 5 of user core. Oct 8 19:54:08.128053 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 8 19:54:08.401805 sudo[1703]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 8 19:54:08.402100 sudo[1703]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 8 19:54:08.417772 sudo[1703]: pam_unix(sudo:session): session closed for user root Oct 8 19:54:08.441279 sshd[1700]: pam_unix(sshd:session): session closed for user core Oct 8 19:54:08.444668 systemd[1]: sshd@4-172.31.30.118:22-139.178.68.195:43034.service: Deactivated successfully. Oct 8 19:54:08.446265 systemd[1]: session-5.scope: Deactivated successfully. Oct 8 19:54:08.446881 systemd-logind[1494]: Session 5 logged out. Waiting for processes to exit. Oct 8 19:54:08.448120 systemd-logind[1494]: Removed session 5. Oct 8 19:54:08.474408 systemd[1]: Started sshd@5-172.31.30.118:22-139.178.68.195:43040.service - OpenSSH per-connection server daemon (139.178.68.195:43040). Oct 8 19:54:08.634033 sshd[1708]: Accepted publickey for core from 139.178.68.195 port 43040 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:08.635343 sshd[1708]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:08.638668 systemd-logind[1494]: New session 6 of user core. Oct 8 19:54:08.655069 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 8 19:54:08.750703 sudo[1712]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 8 19:54:08.751014 sudo[1712]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 8 19:54:08.753821 sudo[1712]: pam_unix(sudo:session): session closed for user root Oct 8 19:54:08.759498 sudo[1711]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Oct 8 19:54:08.759748 sudo[1711]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 8 19:54:08.782175 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Oct 8 19:54:08.783382 auditctl[1715]: No rules Oct 8 19:54:08.784191 systemd[1]: audit-rules.service: Deactivated successfully. Oct 8 19:54:08.784362 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Oct 8 19:54:08.786013 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 8 19:54:08.812006 augenrules[1733]: No rules Oct 8 19:54:08.813052 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 8 19:54:08.813762 sudo[1711]: pam_unix(sudo:session): session closed for user root Oct 8 19:54:08.836682 sshd[1708]: pam_unix(sshd:session): session closed for user core Oct 8 19:54:08.840277 systemd[1]: sshd@5-172.31.30.118:22-139.178.68.195:43040.service: Deactivated successfully. Oct 8 19:54:08.841725 systemd[1]: session-6.scope: Deactivated successfully. Oct 8 19:54:08.842319 systemd-logind[1494]: Session 6 logged out. Waiting for processes to exit. Oct 8 19:54:08.843459 systemd-logind[1494]: Removed session 6. Oct 8 19:54:08.873142 systemd[1]: Started sshd@6-172.31.30.118:22-139.178.68.195:43052.service - OpenSSH per-connection server daemon (139.178.68.195:43052). Oct 8 19:54:09.034994 sshd[1741]: Accepted publickey for core from 139.178.68.195 port 43052 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:09.035325 sshd[1741]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:09.039428 systemd-logind[1494]: New session 7 of user core. Oct 8 19:54:09.050078 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 8 19:54:09.147383 sudo[1744]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mkdir -p . Oct 8 19:54:09.147649 sudo[1744]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 8 19:54:09.150332 sudo[1744]: pam_unix(sudo:session): session closed for user root Oct 8 19:54:09.175862 sshd[1741]: pam_unix(sshd:session): session closed for user core Oct 8 19:54:09.178494 systemd[1]: sshd@6-172.31.30.118:22-139.178.68.195:43052.service: Deactivated successfully. Oct 8 19:54:09.179909 systemd[1]: session-7.scope: Deactivated successfully. Oct 8 19:54:09.180609 systemd-logind[1494]: Session 7 logged out. Waiting for processes to exit. Oct 8 19:54:09.181745 systemd-logind[1494]: Removed session 7. Oct 8 19:54:09.205165 systemd[1]: Started sshd@7-172.31.30.118:22-139.178.68.195:43060.service - OpenSSH per-connection server daemon (139.178.68.195:43060). Oct 8 19:54:09.363342 sshd[1749]: Accepted publickey for core from 139.178.68.195 port 43060 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:09.364424 sshd[1749]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:09.369402 systemd-logind[1494]: New session 8 of user core. Oct 8 19:54:09.376058 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 8 19:54:09.476744 sudo[1752]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/install -m 0755 /dev/stdin kolet Oct 8 19:54:09.477028 sudo[1752]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 8 19:54:10.287526 sudo[1752]: pam_unix(sudo:session): session closed for user root Oct 8 19:54:10.310151 sshd[1749]: pam_unix(sshd:session): session closed for user core Oct 8 19:54:10.313103 systemd[1]: sshd@7-172.31.30.118:22-139.178.68.195:43060.service: Deactivated successfully. Oct 8 19:54:10.314593 systemd[1]: session-8.scope: Deactivated successfully. Oct 8 19:54:10.315134 systemd-logind[1494]: Session 8 logged out. Waiting for processes to exit. Oct 8 19:54:10.316284 systemd-logind[1494]: Removed session 8. Oct 8 19:54:10.346048 systemd[1]: Started sshd@8-172.31.30.118:22-139.178.68.195:43062.service - OpenSSH per-connection server daemon (139.178.68.195:43062). Oct 8 19:54:10.504712 sshd[1757]: Accepted publickey for core from 139.178.68.195 port 43062 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:10.505996 sshd[1757]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:10.509925 systemd-logind[1494]: New session 9 of user core. Oct 8 19:54:10.523067 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 8 19:54:10.666665 sshd[1757]: pam_unix(sshd:session): session closed for user core Oct 8 19:54:10.669660 systemd[1]: sshd@8-172.31.30.118:22-139.178.68.195:43062.service: Deactivated successfully. Oct 8 19:54:10.671109 systemd[1]: session-9.scope: Deactivated successfully. Oct 8 19:54:10.671589 systemd-logind[1494]: Session 9 logged out. Waiting for processes to exit. Oct 8 19:54:10.672855 systemd-logind[1494]: Removed session 9. Oct 8 19:54:10.704003 systemd[1]: Started sshd@9-172.31.30.118:22-139.178.68.195:53522.service - OpenSSH per-connection server daemon (139.178.68.195:53522). Oct 8 19:54:10.864243 sshd[1774]: Accepted publickey for core from 139.178.68.195 port 53522 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:10.865489 sshd[1774]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:10.869957 systemd-logind[1494]: New session 10 of user core. Oct 8 19:54:10.881079 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 8 19:54:11.693161 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 8 19:54:11.693335 (dockerd)[1794]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Oct 8 19:54:14.261517 dockerd[1794]: time="2024-10-08T19:54:14.261465062Z" level=info msg="Starting up" Oct 8 19:54:14.882537 dockerd[1794]: time="2024-10-08T19:54:14.882487581Z" level=info msg="Loading containers: start." Oct 8 19:54:15.127723 kernel: Initializing XFRM netlink socket Oct 8 19:54:15.192839 (udev-worker)[1825]: Network interface NamePolicy= disabled on kernel command line. Oct 8 19:54:15.440986 systemd-networkd[1284]: docker0: Link UP Oct 8 19:54:15.466099 dockerd[1794]: time="2024-10-08T19:54:15.466016176Z" level=info msg="Loading containers: done." Oct 8 19:54:15.612406 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1752684786-merged.mount: Deactivated successfully. Oct 8 19:54:15.617375 dockerd[1794]: time="2024-10-08T19:54:15.617333988Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Oct 8 19:54:15.617457 dockerd[1794]: time="2024-10-08T19:54:15.617436484Z" level=info msg="Docker daemon" commit=061aa95809be396a6b5542618d8a34b02a21ff77 containerd-snapshotter=false storage-driver=overlay2 version=26.1.0 Oct 8 19:54:15.617548 dockerd[1794]: time="2024-10-08T19:54:15.617528478Z" level=info msg="Daemon has completed initialization" Oct 8 19:54:15.660332 dockerd[1794]: time="2024-10-08T19:54:15.660280059Z" level=info msg="API listen on /run/docker.sock" Oct 8 19:54:15.660437 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 8 19:54:16.717116 systemd[1]: var-lib-docker-overlay2-3252dc245eadb28949454bc0ee9273a357728b2d6af38fd0f77e5cb3bb2578f9\x2dinit-merged.mount: Deactivated successfully. Oct 8 19:54:16.810364 kernel: docker0: port 1(veth74462d6) entered blocking state Oct 8 19:54:16.810491 kernel: docker0: port 1(veth74462d6) entered disabled state Oct 8 19:54:16.810518 kernel: veth74462d6: entered allmulticast mode Oct 8 19:54:16.810551 kernel: veth74462d6: entered promiscuous mode Oct 8 19:54:16.810548 systemd-networkd[1284]: veth74462d6: Link UP Oct 8 19:54:16.810614 (udev-worker)[1872]: Network interface NamePolicy= disabled on kernel command line. Oct 8 19:54:17.871220 containerd[1515]: time="2024-10-08T19:54:17.871119082Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 8 19:54:17.871801 containerd[1515]: time="2024-10-08T19:54:17.871225089Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 8 19:54:17.871801 containerd[1515]: time="2024-10-08T19:54:17.871786745Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 8 19:54:17.871913 containerd[1515]: time="2024-10-08T19:54:17.871865782Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 8 19:54:18.035079 systemd[1]: Started docker-6482d6c90180e4153ee20825bc07aae5c84e51c038d6b13826e0c3081e7aa31d.scope - libcontainer container 6482d6c90180e4153ee20825bc07aae5c84e51c038d6b13826e0c3081e7aa31d. Oct 8 19:54:18.101967 kernel: eth0: renamed from vetha08739e Oct 8 19:54:18.114974 kernel: docker0: port 1(veth74462d6) entered blocking state Oct 8 19:54:18.115039 kernel: docker0: port 1(veth74462d6) entered forwarding state Oct 8 19:54:18.115650 systemd-networkd[1284]: veth74462d6: Gained carrier Oct 8 19:54:18.116027 systemd-networkd[1284]: docker0: Gained carrier Oct 8 19:54:19.226090 systemd-networkd[1284]: docker0: Gained IPv6LL Oct 8 19:54:19.290050 systemd-networkd[1284]: veth74462d6: Gained IPv6LL Oct 8 19:54:21.191480 systemd[1]: docker-6482d6c90180e4153ee20825bc07aae5c84e51c038d6b13826e0c3081e7aa31d.scope: Deactivated successfully. Oct 8 19:54:21.204736 dockerd[1794]: time="2024-10-08T19:54:21.204655745Z" level=info msg="ignoring event" container=6482d6c90180e4153ee20825bc07aae5c84e51c038d6b13826e0c3081e7aa31d module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Oct 8 19:54:21.205416 containerd[1515]: time="2024-10-08T19:54:21.205332639Z" level=info msg="shim disconnected" id=6482d6c90180e4153ee20825bc07aae5c84e51c038d6b13826e0c3081e7aa31d namespace=moby Oct 8 19:54:21.205416 containerd[1515]: time="2024-10-08T19:54:21.205405901Z" level=warning msg="cleaning up after shim disconnected" id=6482d6c90180e4153ee20825bc07aae5c84e51c038d6b13826e0c3081e7aa31d namespace=moby Oct 8 19:54:21.205739 containerd[1515]: time="2024-10-08T19:54:21.205422174Z" level=info msg="cleaning up dead shim" namespace=moby Oct 8 19:54:21.231407 systemd-networkd[1284]: veth74462d6: Lost carrier Oct 8 19:54:21.231965 kernel: docker0: port 1(veth74462d6) entered disabled state Oct 8 19:54:21.232005 kernel: vetha08739e: renamed from eth0 Oct 8 19:54:21.255795 systemd-networkd[1284]: veth74462d6: Link DOWN Oct 8 19:54:21.256961 kernel: docker0: port 1(veth74462d6) entered disabled state Oct 8 19:54:21.258171 kernel: veth74462d6 (unregistering): left allmulticast mode Oct 8 19:54:21.258205 kernel: veth74462d6 (unregistering): left promiscuous mode Oct 8 19:54:21.258230 kernel: docker0: port 1(veth74462d6) entered disabled state Oct 8 19:54:21.283159 systemd[1]: run-docker-netns-aa66afdfebe7.mount: Deactivated successfully. Oct 8 19:54:21.284741 systemd[1]: var-lib-docker-overlay2-3252dc245eadb28949454bc0ee9273a357728b2d6af38fd0f77e5cb3bb2578f9-merged.mount: Deactivated successfully. Oct 8 19:54:21.323285 sshd[1774]: pam_unix(sshd:session): session closed for user core Oct 8 19:54:21.326130 systemd[1]: sshd@9-172.31.30.118:22-139.178.68.195:53522.service: Deactivated successfully. Oct 8 19:54:21.327536 systemd[1]: session-10.scope: Deactivated successfully. Oct 8 19:54:21.328067 systemd-logind[1494]: Session 10 logged out. Waiting for processes to exit. Oct 8 19:54:21.329167 systemd-logind[1494]: Removed session 10. Oct 8 19:54:21.352336 systemd[1]: Started sshd@10-172.31.30.118:22-139.178.68.195:44814.service - OpenSSH per-connection server daemon (139.178.68.195:44814). Oct 8 19:54:21.509013 sshd[2042]: Accepted publickey for core from 139.178.68.195 port 44814 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:21.510129 sshd[2042]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:21.513885 systemd-logind[1494]: New session 11 of user core. Oct 8 19:54:21.525066 systemd[1]: Started session-11.scope - Session 11 of User core. Oct 8 19:54:21.662519 systemd[1]: var-lib-docker-overlay2-d992115d2a52b53ac002ed4ca74ab85b7da1251dfb811f7797864552f43648e7\x2dinit-merged.mount: Deactivated successfully. Oct 8 19:54:21.697215 kernel: docker0: port 1(vethe2ca879) entered blocking state Oct 8 19:54:21.697351 kernel: docker0: port 1(vethe2ca879) entered disabled state Oct 8 19:54:21.697389 kernel: vethe2ca879: entered allmulticast mode Oct 8 19:54:21.697424 kernel: vethe2ca879: entered promiscuous mode Oct 8 19:54:21.697905 systemd-networkd[1284]: vethe2ca879: Link UP Oct 8 19:54:21.698411 kernel: docker0: port 1(vethe2ca879) entered blocking state Oct 8 19:54:21.698447 kernel: docker0: port 1(vethe2ca879) entered forwarding state Oct 8 19:54:21.699097 (udev-worker)[2038]: Network interface NamePolicy= disabled on kernel command line. Oct 8 19:54:21.699104 (udev-worker)[2034]: Network interface NamePolicy= disabled on kernel command line. Oct 8 19:54:21.741395 containerd[1515]: time="2024-10-08T19:54:21.741301720Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 8 19:54:21.741525 containerd[1515]: time="2024-10-08T19:54:21.741378292Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 8 19:54:21.741525 containerd[1515]: time="2024-10-08T19:54:21.741416777Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 8 19:54:21.741595 containerd[1515]: time="2024-10-08T19:54:21.741503914Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 8 19:54:21.764837 systemd[1]: Started docker-4619cd6ce0f995320d8b21753793b1fb1bf6d2aab7eaac92c05d89090f24f5f3.scope - libcontainer container 4619cd6ce0f995320d8b21753793b1fb1bf6d2aab7eaac92c05d89090f24f5f3. Oct 8 19:54:21.824966 kernel: eth0: renamed from veth0103405 Oct 8 19:54:21.832450 systemd-networkd[1284]: vethe2ca879: Gained carrier Oct 8 19:54:21.866461 systemd[1]: docker-4619cd6ce0f995320d8b21753793b1fb1bf6d2aab7eaac92c05d89090f24f5f3.scope: Deactivated successfully. Oct 8 19:54:21.879597 dockerd[1794]: time="2024-10-08T19:54:21.879549389Z" level=info msg="ignoring event" container=4619cd6ce0f995320d8b21753793b1fb1bf6d2aab7eaac92c05d89090f24f5f3 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Oct 8 19:54:21.879703 containerd[1515]: time="2024-10-08T19:54:21.879556521Z" level=info msg="shim disconnected" id=4619cd6ce0f995320d8b21753793b1fb1bf6d2aab7eaac92c05d89090f24f5f3 namespace=moby Oct 8 19:54:21.879703 containerd[1515]: time="2024-10-08T19:54:21.879622125Z" level=warning msg="cleaning up after shim disconnected" id=4619cd6ce0f995320d8b21753793b1fb1bf6d2aab7eaac92c05d89090f24f5f3 namespace=moby Oct 8 19:54:21.879703 containerd[1515]: time="2024-10-08T19:54:21.879634897Z" level=info msg="cleaning up dead shim" namespace=moby Oct 8 19:54:21.902133 systemd-networkd[1284]: vethe2ca879: Lost carrier Oct 8 19:54:21.902959 kernel: docker0: port 1(vethe2ca879) entered disabled state Oct 8 19:54:21.903005 kernel: veth0103405: renamed from eth0 Oct 8 19:54:21.927576 (udev-worker)[2093]: Network interface NamePolicy= disabled on kernel command line. Oct 8 19:54:21.929160 systemd-networkd[1284]: vethe2ca879: Link DOWN Oct 8 19:54:21.929968 kernel: docker0: port 1(vethe2ca879) entered disabled state Oct 8 19:54:21.932372 kernel: vethe2ca879 (unregistering): left allmulticast mode Oct 8 19:54:21.932441 kernel: vethe2ca879 (unregistering): left promiscuous mode Oct 8 19:54:21.932480 kernel: docker0: port 1(vethe2ca879) entered disabled state Oct 8 19:54:21.996393 sshd[2042]: pam_unix(sshd:session): session closed for user core Oct 8 19:54:21.999159 systemd[1]: sshd@10-172.31.30.118:22-139.178.68.195:44814.service: Deactivated successfully. Oct 8 19:54:22.000641 systemd[1]: session-11.scope: Deactivated successfully. Oct 8 19:54:22.001245 systemd-logind[1494]: Session 11 logged out. Waiting for processes to exit. Oct 8 19:54:22.002373 systemd-logind[1494]: Removed session 11. Oct 8 19:54:22.028260 systemd[1]: Started sshd@11-172.31.30.118:22-139.178.68.195:44820.service - OpenSSH per-connection server daemon (139.178.68.195:44820). Oct 8 19:54:22.184164 sshd[2171]: Accepted publickey for core from 139.178.68.195 port 44820 ssh2: RSA SHA256:IjXuZoeAljxPgM7JBl0BXdRebauULfRoxVUwUqxsdYc Oct 8 19:54:22.185398 sshd[2171]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 8 19:54:22.189076 systemd-logind[1494]: New session 12 of user core. Oct 8 19:54:22.201074 systemd[1]: Started session-12.scope - Session 12 of User core. Oct 8 19:54:22.234140 systemd-networkd[1284]: docker0: Lost carrier Oct 8 19:54:22.319466 ntpdate[2185]: ntpdate 4.2.8p17@1.4004-o Tue Oct 8 17:52:26 UTC 2024 (1) Oct 8 19:54:29.077105 ntpdate[2185]: adjust time server 99.28.14.242 offset +0.000787 sec Oct 8 19:54:29.099839 sshd[2171]: pam_unix(sshd:session): session closed for user core Oct 8 19:54:29.102832 systemd[1]: sshd@11-172.31.30.118:22-139.178.68.195:44820.service: Deactivated successfully. Oct 8 19:54:29.104324 systemd[1]: session-12.scope: Deactivated successfully. Oct 8 19:54:29.104816 systemd-logind[1494]: Session 12 logged out. Waiting for processes to exit. Oct 8 19:54:29.106043 systemd-logind[1494]: Removed session 12. Oct 8 19:54:29.761748 systemd[1]: systemd-hostnamed.service: Deactivated successfully.