Jul 2 08:05:14.213965 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Jul 2 08:05:14.214015 kernel: Linux version 6.6.36-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.2.1_p20240210 p14) 13.2.1 20240210, GNU ld (Gentoo 2.41 p5) 2.41.0) #1 SMP PREEMPT Mon Jul 1 22:48:46 -00 2024 Jul 2 08:05:14.214042 kernel: KASLR disabled due to lack of seed Jul 2 08:05:14.214101 kernel: efi: EFI v2.7 by EDK II Jul 2 08:05:14.214123 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7ac1aa98 MEMRESERVE=0x7852ee18 Jul 2 08:05:14.214139 kernel: ACPI: Early table checksum verification disabled Jul 2 08:05:14.214158 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Jul 2 08:05:14.214174 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Jul 2 08:05:14.214190 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Jul 2 08:05:14.214206 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Jul 2 08:05:14.214229 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Jul 2 08:05:14.214245 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Jul 2 08:05:14.214261 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Jul 2 08:05:14.214277 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Jul 2 08:05:14.214295 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Jul 2 08:05:14.214320 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Jul 2 08:05:14.214338 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Jul 2 08:05:14.214355 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Jul 2 08:05:14.214372 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Jul 2 08:05:14.214390 kernel: printk: bootconsole [uart0] enabled Jul 2 08:05:14.214407 kernel: NUMA: Failed to initialise from firmware Jul 2 08:05:14.214425 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Jul 2 08:05:14.214442 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] Jul 2 08:05:14.214460 kernel: Zone ranges: Jul 2 08:05:14.214478 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Jul 2 08:05:14.214496 kernel: DMA32 empty Jul 2 08:05:14.214519 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Jul 2 08:05:14.214537 kernel: Movable zone start for each node Jul 2 08:05:14.214554 kernel: Early memory node ranges Jul 2 08:05:14.214576 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Jul 2 08:05:14.214594 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Jul 2 08:05:14.214613 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Jul 2 08:05:14.214631 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Jul 2 08:05:14.214650 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Jul 2 08:05:14.214668 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Jul 2 08:05:14.214685 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Jul 2 08:05:14.214703 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Jul 2 08:05:14.214720 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Jul 2 08:05:14.214744 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Jul 2 08:05:14.214762 kernel: psci: probing for conduit method from ACPI. Jul 2 08:05:14.214788 kernel: psci: PSCIv1.0 detected in firmware. Jul 2 08:05:14.214806 kernel: psci: Using standard PSCI v0.2 function IDs Jul 2 08:05:14.214825 kernel: psci: Trusted OS migration not required Jul 2 08:05:14.214848 kernel: psci: SMC Calling Convention v1.1 Jul 2 08:05:14.214867 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Jul 2 08:05:14.214884 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Jul 2 08:05:14.214906 kernel: pcpu-alloc: [0] 0 [0] 1 Jul 2 08:05:14.214926 kernel: Detected PIPT I-cache on CPU0 Jul 2 08:05:14.214944 kernel: CPU features: detected: GIC system register CPU interface Jul 2 08:05:14.214961 kernel: CPU features: detected: Spectre-v2 Jul 2 08:05:14.214978 kernel: CPU features: detected: Spectre-v3a Jul 2 08:05:14.214996 kernel: CPU features: detected: Spectre-BHB Jul 2 08:05:14.215014 kernel: CPU features: detected: ARM erratum 1742098 Jul 2 08:05:14.215031 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Jul 2 08:05:14.215054 kernel: alternatives: applying boot alternatives Jul 2 08:05:14.215150 kernel: 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=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=19e11d11f09b621c4c7d739b39b57f4bac8caa3f9723d7ceb0e9d7c7445769b7 Jul 2 08:05:14.215171 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 2 08:05:14.215189 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 2 08:05:14.215208 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 2 08:05:14.215226 kernel: Fallback order for Node 0: 0 Jul 2 08:05:14.215244 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Jul 2 08:05:14.215261 kernel: Policy zone: Normal Jul 2 08:05:14.215279 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 2 08:05:14.215297 kernel: software IO TLB: area num 2. Jul 2 08:05:14.215315 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Jul 2 08:05:14.215345 kernel: Memory: 3820536K/4030464K available (10240K kernel code, 2182K rwdata, 8072K rodata, 39040K init, 897K bss, 209928K reserved, 0K cma-reserved) Jul 2 08:05:14.215363 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jul 2 08:05:14.215381 kernel: trace event string verifier disabled Jul 2 08:05:14.215399 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 2 08:05:14.215419 kernel: rcu: RCU event tracing is enabled. Jul 2 08:05:14.215436 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jul 2 08:05:14.215454 kernel: Trampoline variant of Tasks RCU enabled. Jul 2 08:05:14.215472 kernel: Tracing variant of Tasks RCU enabled. Jul 2 08:05:14.215489 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 2 08:05:14.215507 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jul 2 08:05:14.215524 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jul 2 08:05:14.215549 kernel: GICv3: 96 SPIs implemented Jul 2 08:05:14.215567 kernel: GICv3: 0 Extended SPIs implemented Jul 2 08:05:14.215585 kernel: Root IRQ handler: gic_handle_irq Jul 2 08:05:14.215602 kernel: GICv3: GICv3 features: 16 PPIs Jul 2 08:05:14.215619 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Jul 2 08:05:14.215636 kernel: ITS [mem 0x10080000-0x1009ffff] Jul 2 08:05:14.215654 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000c0000 (indirect, esz 8, psz 64K, shr 1) Jul 2 08:05:14.215672 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000d0000 (flat, esz 8, psz 64K, shr 1) Jul 2 08:05:14.215689 kernel: GICv3: using LPI property table @0x00000004000e0000 Jul 2 08:05:14.215706 kernel: ITS: Using hypervisor restricted LPI range [128] Jul 2 08:05:14.215724 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000f0000 Jul 2 08:05:14.215742 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 2 08:05:14.215766 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Jul 2 08:05:14.215785 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Jul 2 08:05:14.215802 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Jul 2 08:05:14.215820 kernel: Console: colour dummy device 80x25 Jul 2 08:05:14.215838 kernel: printk: console [tty1] enabled Jul 2 08:05:14.215856 kernel: ACPI: Core revision 20230628 Jul 2 08:05:14.215874 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Jul 2 08:05:14.215892 kernel: pid_max: default: 32768 minimum: 301 Jul 2 08:05:14.215910 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Jul 2 08:05:14.215928 kernel: SELinux: Initializing. Jul 2 08:05:14.215952 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 2 08:05:14.215970 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 2 08:05:14.216340 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1. Jul 2 08:05:14.216668 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1. Jul 2 08:05:14.216975 kernel: rcu: Hierarchical SRCU implementation. Jul 2 08:05:14.217417 kernel: rcu: Max phase no-delay instances is 400. Jul 2 08:05:14.217441 kernel: Platform MSI: ITS@0x10080000 domain created Jul 2 08:05:14.217459 kernel: PCI/MSI: ITS@0x10080000 domain created Jul 2 08:05:14.217478 kernel: Remapping and enabling EFI services. Jul 2 08:05:14.217510 kernel: smp: Bringing up secondary CPUs ... Jul 2 08:05:14.217527 kernel: Detected PIPT I-cache on CPU1 Jul 2 08:05:14.217546 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Jul 2 08:05:14.217564 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000400100000 Jul 2 08:05:14.217583 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Jul 2 08:05:14.217601 kernel: smp: Brought up 1 node, 2 CPUs Jul 2 08:05:14.217619 kernel: SMP: Total of 2 processors activated. Jul 2 08:05:14.217637 kernel: CPU features: detected: 32-bit EL0 Support Jul 2 08:05:14.217655 kernel: CPU features: detected: 32-bit EL1 Support Jul 2 08:05:14.217681 kernel: CPU features: detected: CRC32 instructions Jul 2 08:05:14.217699 kernel: CPU: All CPU(s) started at EL1 Jul 2 08:05:14.217731 kernel: alternatives: applying system-wide alternatives Jul 2 08:05:14.217755 kernel: devtmpfs: initialized Jul 2 08:05:14.217774 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 2 08:05:14.217793 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jul 2 08:05:14.217811 kernel: pinctrl core: initialized pinctrl subsystem Jul 2 08:05:14.217830 kernel: SMBIOS 3.0.0 present. Jul 2 08:05:14.217849 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Jul 2 08:05:14.217874 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 2 08:05:14.217894 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jul 2 08:05:14.217912 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jul 2 08:05:14.217931 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jul 2 08:05:14.217950 kernel: audit: initializing netlink subsys (disabled) Jul 2 08:05:14.217969 kernel: audit: type=2000 audit(0.378:1): state=initialized audit_enabled=0 res=1 Jul 2 08:05:14.217989 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 2 08:05:14.218013 kernel: cpuidle: using governor menu Jul 2 08:05:14.218032 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jul 2 08:05:14.218083 kernel: ASID allocator initialised with 65536 entries Jul 2 08:05:14.218114 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 2 08:05:14.218132 kernel: Serial: AMBA PL011 UART driver Jul 2 08:05:14.218156 kernel: Modules: 17600 pages in range for non-PLT usage Jul 2 08:05:14.218175 kernel: Modules: 509120 pages in range for PLT usage Jul 2 08:05:14.218194 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 2 08:05:14.218213 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jul 2 08:05:14.218245 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jul 2 08:05:14.218265 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jul 2 08:05:14.218283 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 2 08:05:14.218302 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jul 2 08:05:14.218321 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jul 2 08:05:14.218340 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jul 2 08:05:14.218358 kernel: ACPI: Added _OSI(Module Device) Jul 2 08:05:14.218376 kernel: ACPI: Added _OSI(Processor Device) Jul 2 08:05:14.218395 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jul 2 08:05:14.218420 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 2 08:05:14.218440 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 2 08:05:14.218458 kernel: ACPI: Interpreter enabled Jul 2 08:05:14.218477 kernel: ACPI: Using GIC for interrupt routing Jul 2 08:05:14.218495 kernel: ACPI: MCFG table detected, 1 entries Jul 2 08:05:14.218514 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Jul 2 08:05:14.218861 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 2 08:05:14.219163 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jul 2 08:05:14.219411 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jul 2 08:05:14.219627 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Jul 2 08:05:14.219877 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Jul 2 08:05:14.219908 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Jul 2 08:05:14.219927 kernel: acpiphp: Slot [1] registered Jul 2 08:05:14.219946 kernel: acpiphp: Slot [2] registered Jul 2 08:05:14.219964 kernel: acpiphp: Slot [3] registered Jul 2 08:05:14.219985 kernel: acpiphp: Slot [4] registered Jul 2 08:05:14.220005 kernel: acpiphp: Slot [5] registered Jul 2 08:05:14.220036 kernel: acpiphp: Slot [6] registered Jul 2 08:05:14.220081 kernel: acpiphp: Slot [7] registered Jul 2 08:05:14.220108 kernel: acpiphp: Slot [8] registered Jul 2 08:05:14.220127 kernel: acpiphp: Slot [9] registered Jul 2 08:05:14.220146 kernel: acpiphp: Slot [10] registered Jul 2 08:05:14.220165 kernel: acpiphp: Slot [11] registered Jul 2 08:05:14.220183 kernel: acpiphp: Slot [12] registered Jul 2 08:05:14.220202 kernel: acpiphp: Slot [13] registered Jul 2 08:05:14.220220 kernel: acpiphp: Slot [14] registered Jul 2 08:05:14.220246 kernel: acpiphp: Slot [15] registered Jul 2 08:05:14.220265 kernel: acpiphp: Slot [16] registered Jul 2 08:05:14.220283 kernel: acpiphp: Slot [17] registered Jul 2 08:05:14.220302 kernel: acpiphp: Slot [18] registered Jul 2 08:05:14.220320 kernel: acpiphp: Slot [19] registered Jul 2 08:05:14.220339 kernel: acpiphp: Slot [20] registered Jul 2 08:05:14.220357 kernel: acpiphp: Slot [21] registered Jul 2 08:05:14.220375 kernel: acpiphp: Slot [22] registered Jul 2 08:05:14.220393 kernel: acpiphp: Slot [23] registered Jul 2 08:05:14.220411 kernel: acpiphp: Slot [24] registered Jul 2 08:05:14.220435 kernel: acpiphp: Slot [25] registered Jul 2 08:05:14.220454 kernel: acpiphp: Slot [26] registered Jul 2 08:05:14.220472 kernel: acpiphp: Slot [27] registered Jul 2 08:05:14.220490 kernel: acpiphp: Slot [28] registered Jul 2 08:05:14.220509 kernel: acpiphp: Slot [29] registered Jul 2 08:05:14.220527 kernel: acpiphp: Slot [30] registered Jul 2 08:05:14.220546 kernel: acpiphp: Slot [31] registered Jul 2 08:05:14.220564 kernel: PCI host bridge to bus 0000:00 Jul 2 08:05:14.220826 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Jul 2 08:05:14.223147 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jul 2 08:05:14.223416 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Jul 2 08:05:14.223613 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Jul 2 08:05:14.223887 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Jul 2 08:05:14.224312 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Jul 2 08:05:14.224645 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Jul 2 08:05:14.224961 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Jul 2 08:05:14.225271 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Jul 2 08:05:14.225498 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Jul 2 08:05:14.225726 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Jul 2 08:05:14.225938 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Jul 2 08:05:14.228367 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Jul 2 08:05:14.228609 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Jul 2 08:05:14.228829 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Jul 2 08:05:14.229118 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Jul 2 08:05:14.229347 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Jul 2 08:05:14.229584 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Jul 2 08:05:14.229826 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Jul 2 08:05:14.230152 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Jul 2 08:05:14.230391 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Jul 2 08:05:14.230615 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jul 2 08:05:14.230826 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Jul 2 08:05:14.230856 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jul 2 08:05:14.230877 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jul 2 08:05:14.230898 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jul 2 08:05:14.230919 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jul 2 08:05:14.230938 kernel: iommu: Default domain type: Translated Jul 2 08:05:14.230958 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jul 2 08:05:14.230987 kernel: efivars: Registered efivars operations Jul 2 08:05:14.231007 kernel: vgaarb: loaded Jul 2 08:05:14.231027 kernel: clocksource: Switched to clocksource arch_sys_counter Jul 2 08:05:14.231047 kernel: VFS: Disk quotas dquot_6.6.0 Jul 2 08:05:14.231101 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 2 08:05:14.231124 kernel: pnp: PnP ACPI init Jul 2 08:05:14.231431 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Jul 2 08:05:14.231496 kernel: pnp: PnP ACPI: found 1 devices Jul 2 08:05:14.231568 kernel: NET: Registered PF_INET protocol family Jul 2 08:05:14.231595 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 2 08:05:14.231615 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 2 08:05:14.231634 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 2 08:05:14.231653 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 2 08:05:14.231673 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 2 08:05:14.231693 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 2 08:05:14.231712 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 2 08:05:14.231732 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 2 08:05:14.231761 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 2 08:05:14.231781 kernel: PCI: CLS 0 bytes, default 64 Jul 2 08:05:14.231799 kernel: kvm [1]: HYP mode not available Jul 2 08:05:14.231818 kernel: Initialise system trusted keyrings Jul 2 08:05:14.231838 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 2 08:05:14.231857 kernel: Key type asymmetric registered Jul 2 08:05:14.231875 kernel: Asymmetric key parser 'x509' registered Jul 2 08:05:14.231894 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jul 2 08:05:14.231912 kernel: io scheduler mq-deadline registered Jul 2 08:05:14.231936 kernel: io scheduler kyber registered Jul 2 08:05:14.231955 kernel: io scheduler bfq registered Jul 2 08:05:14.234427 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Jul 2 08:05:14.234476 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jul 2 08:05:14.234498 kernel: ACPI: button: Power Button [PWRB] Jul 2 08:05:14.234518 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Jul 2 08:05:14.234537 kernel: ACPI: button: Sleep Button [SLPB] Jul 2 08:05:14.234556 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 2 08:05:14.234612 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Jul 2 08:05:14.234865 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Jul 2 08:05:14.234896 kernel: printk: console [ttyS0] disabled Jul 2 08:05:14.234916 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Jul 2 08:05:14.234935 kernel: printk: console [ttyS0] enabled Jul 2 08:05:14.234954 kernel: printk: bootconsole [uart0] disabled Jul 2 08:05:14.234972 kernel: thunder_xcv, ver 1.0 Jul 2 08:05:14.234991 kernel: thunder_bgx, ver 1.0 Jul 2 08:05:14.235010 kernel: nicpf, ver 1.0 Jul 2 08:05:14.235030 kernel: nicvf, ver 1.0 Jul 2 08:05:14.235349 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jul 2 08:05:14.235561 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-07-02T08:05:13 UTC (1719907513) Jul 2 08:05:14.235590 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 2 08:05:14.235610 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Jul 2 08:05:14.235629 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jul 2 08:05:14.235648 kernel: watchdog: Hard watchdog permanently disabled Jul 2 08:05:14.235666 kernel: NET: Registered PF_INET6 protocol family Jul 2 08:05:14.235685 kernel: Segment Routing with IPv6 Jul 2 08:05:14.235713 kernel: In-situ OAM (IOAM) with IPv6 Jul 2 08:05:14.235732 kernel: NET: Registered PF_PACKET protocol family Jul 2 08:05:14.235750 kernel: Key type dns_resolver registered Jul 2 08:05:14.235769 kernel: registered taskstats version 1 Jul 2 08:05:14.235788 kernel: Loading compiled-in X.509 certificates Jul 2 08:05:14.235808 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.36-flatcar: 60660d9c77cbf90f55b5b3c47931cf5941193eaf' Jul 2 08:05:14.235827 kernel: Key type .fscrypt registered Jul 2 08:05:14.235845 kernel: Key type fscrypt-provisioning registered Jul 2 08:05:14.235863 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 2 08:05:14.235890 kernel: ima: Allocated hash algorithm: sha1 Jul 2 08:05:14.235908 kernel: ima: No architecture policies found Jul 2 08:05:14.235927 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jul 2 08:05:14.235945 kernel: clk: Disabling unused clocks Jul 2 08:05:14.235964 kernel: Freeing unused kernel memory: 39040K Jul 2 08:05:14.235983 kernel: Run /init as init process Jul 2 08:05:14.236002 kernel: with arguments: Jul 2 08:05:14.236021 kernel: /init Jul 2 08:05:14.236039 kernel: with environment: Jul 2 08:05:14.236131 kernel: HOME=/ Jul 2 08:05:14.236156 kernel: TERM=linux Jul 2 08:05:14.236175 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 2 08:05:14.236200 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) Jul 2 08:05:14.236225 systemd[1]: Detected virtualization amazon. Jul 2 08:05:14.236247 systemd[1]: Detected architecture arm64. Jul 2 08:05:14.236267 systemd[1]: Running in initrd. Jul 2 08:05:14.236287 systemd[1]: No hostname configured, using default hostname. Jul 2 08:05:14.236315 systemd[1]: Hostname set to <localhost>. Jul 2 08:05:14.236337 systemd[1]: Initializing machine ID from VM UUID. Jul 2 08:05:14.236357 systemd[1]: Queued start job for default target initrd.target. Jul 2 08:05:14.236378 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 2 08:05:14.236399 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 2 08:05:14.236421 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 2 08:05:14.236442 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 2 08:05:14.236469 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 2 08:05:14.236491 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 2 08:05:14.236515 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 2 08:05:14.236537 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 2 08:05:14.236558 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 2 08:05:14.236578 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 2 08:05:14.236599 systemd[1]: Reached target paths.target - Path Units. Jul 2 08:05:14.236627 systemd[1]: Reached target slices.target - Slice Units. Jul 2 08:05:14.236648 systemd[1]: Reached target swap.target - Swaps. Jul 2 08:05:14.236669 systemd[1]: Reached target timers.target - Timer Units. Jul 2 08:05:14.236689 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 2 08:05:14.236710 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 2 08:05:14.236733 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 2 08:05:14.236754 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jul 2 08:05:14.236775 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 2 08:05:14.236796 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 2 08:05:14.236824 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 2 08:05:14.236873 systemd[1]: Reached target sockets.target - Socket Units. Jul 2 08:05:14.236897 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 2 08:05:14.236918 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 2 08:05:14.236939 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 2 08:05:14.236960 systemd[1]: Starting systemd-fsck-usr.service... Jul 2 08:05:14.236982 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 2 08:05:14.237003 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 2 08:05:14.237036 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 2 08:05:14.237088 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 2 08:05:14.237118 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 2 08:05:14.237215 systemd-journald[250]: Collecting audit messages is disabled. Jul 2 08:05:14.237276 systemd[1]: Finished systemd-fsck-usr.service. Jul 2 08:05:14.237302 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 2 08:05:14.237324 systemd-journald[250]: Journal started Jul 2 08:05:14.237369 systemd-journald[250]: Runtime Journal (/run/log/journal/ec2d35a78632bb324cfa33f94a5cf8e5) is 8.0M, max 75.3M, 67.3M free. Jul 2 08:05:14.224690 systemd-modules-load[251]: Inserted module 'overlay' Jul 2 08:05:14.248711 systemd[1]: Started systemd-journald.service - Journal Service. Jul 2 08:05:14.270128 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 2 08:05:14.267320 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Jul 2 08:05:14.277502 systemd-modules-load[251]: Inserted module 'br_netfilter' Jul 2 08:05:14.278274 kernel: Bridge firewalling registered Jul 2 08:05:14.281760 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 2 08:05:14.296410 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 2 08:05:14.301507 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 2 08:05:14.316526 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 2 08:05:14.333490 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 2 08:05:14.340331 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 2 08:05:14.353581 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Jul 2 08:05:14.386642 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 2 08:05:14.391147 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 2 08:05:14.399648 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 2 08:05:14.416569 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 2 08:05:14.429402 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 2 08:05:14.451623 dracut-cmdline[288]: dracut-dracut-053 Jul 2 08:05:14.459114 dracut-cmdline[288]: Using kernel command line parameters: rd.driver.pre=btrfs 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=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=19e11d11f09b621c4c7d739b39b57f4bac8caa3f9723d7ceb0e9d7c7445769b7 Jul 2 08:05:14.524217 systemd-resolved[291]: Positive Trust Anchors: Jul 2 08:05:14.524254 systemd-resolved[291]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 2 08:05:14.524319 systemd-resolved[291]: 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 corp home internal intranet lan local private test Jul 2 08:05:14.647092 kernel: SCSI subsystem initialized Jul 2 08:05:14.654119 kernel: Loading iSCSI transport class v2.0-870. Jul 2 08:05:14.668105 kernel: iscsi: registered transport (tcp) Jul 2 08:05:14.692106 kernel: iscsi: registered transport (qla4xxx) Jul 2 08:05:14.692179 kernel: QLogic iSCSI HBA Driver Jul 2 08:05:14.761110 kernel: random: crng init done Jul 2 08:05:14.761336 systemd-resolved[291]: Defaulting to hostname 'linux'. Jul 2 08:05:14.764917 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 2 08:05:14.768115 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 2 08:05:14.797183 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 2 08:05:14.806425 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 2 08:05:14.853114 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 2 08:05:14.853193 kernel: device-mapper: uevent: version 1.0.3 Jul 2 08:05:14.855135 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jul 2 08:05:14.925140 kernel: raid6: neonx8 gen() 6643 MB/s Jul 2 08:05:14.942108 kernel: raid6: neonx4 gen() 6429 MB/s Jul 2 08:05:14.959105 kernel: raid6: neonx2 gen() 5339 MB/s Jul 2 08:05:14.976119 kernel: raid6: neonx1 gen() 3931 MB/s Jul 2 08:05:14.993100 kernel: raid6: int64x8 gen() 3799 MB/s Jul 2 08:05:15.010095 kernel: raid6: int64x4 gen() 3695 MB/s Jul 2 08:05:15.027091 kernel: raid6: int64x2 gen() 3565 MB/s Jul 2 08:05:15.044733 kernel: raid6: int64x1 gen() 2775 MB/s Jul 2 08:05:15.044768 kernel: raid6: using algorithm neonx8 gen() 6643 MB/s Jul 2 08:05:15.062714 kernel: raid6: .... xor() 4881 MB/s, rmw enabled Jul 2 08:05:15.062764 kernel: raid6: using neon recovery algorithm Jul 2 08:05:15.070101 kernel: xor: measuring software checksum speed Jul 2 08:05:15.072090 kernel: 8regs : 11046 MB/sec Jul 2 08:05:15.074089 kernel: 32regs : 11935 MB/sec Jul 2 08:05:15.076091 kernel: arm64_neon : 9545 MB/sec Jul 2 08:05:15.076125 kernel: xor: using function: 32regs (11935 MB/sec) Jul 2 08:05:15.163111 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 2 08:05:15.183102 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 2 08:05:15.196373 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 2 08:05:15.237245 systemd-udevd[471]: Using default interface naming scheme 'v255'. Jul 2 08:05:15.247184 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 2 08:05:15.260374 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 2 08:05:15.299162 dracut-pre-trigger[476]: rd.md=0: removing MD RAID activation Jul 2 08:05:15.363782 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 2 08:05:15.374416 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 2 08:05:15.501108 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 2 08:05:15.513497 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 2 08:05:15.569863 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 2 08:05:15.572834 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 2 08:05:15.575639 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 2 08:05:15.578230 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 2 08:05:15.596419 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 2 08:05:15.650502 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 2 08:05:15.722769 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jul 2 08:05:15.722835 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Jul 2 08:05:15.750235 kernel: ena 0000:00:05.0: ENA device version: 0.10 Jul 2 08:05:15.750568 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Jul 2 08:05:15.750859 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:17:31:a1:6c:15 Jul 2 08:05:15.750808 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 2 08:05:15.751093 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 2 08:05:15.754917 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 2 08:05:15.757089 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 2 08:05:15.762858 (udev-worker)[531]: Network interface NamePolicy= disabled on kernel command line. Jul 2 08:05:15.773133 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 2 08:05:15.777011 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 2 08:05:15.801613 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 2 08:05:15.810128 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Jul 2 08:05:15.810211 kernel: nvme nvme0: pci function 0000:00:04.0 Jul 2 08:05:15.821241 kernel: nvme nvme0: 2/0/0 default/read/poll queues Jul 2 08:05:15.830115 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jul 2 08:05:15.830192 kernel: GPT:9289727 != 16777215 Jul 2 08:05:15.830220 kernel: GPT:Alternate GPT header not at the end of the disk. Jul 2 08:05:15.832081 kernel: GPT:9289727 != 16777215 Jul 2 08:05:15.832154 kernel: GPT: Use GNU Parted to correct GPT errors. Jul 2 08:05:15.833097 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jul 2 08:05:15.846129 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 2 08:05:15.857594 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 2 08:05:15.893748 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 2 08:05:15.977108 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 scanned by (udev-worker) (518) Jul 2 08:05:15.977203 kernel: BTRFS: device fsid 9b0eb482-485a-4aff-8de4-e09ff146eadf devid 1 transid 34 /dev/nvme0n1p3 scanned by (udev-worker) (515) Jul 2 08:05:16.010641 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Jul 2 08:05:16.087088 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Jul 2 08:05:16.117900 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Jul 2 08:05:16.133408 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Jul 2 08:05:16.139196 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Jul 2 08:05:16.153519 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 2 08:05:16.172204 disk-uuid[661]: Primary Header is updated. Jul 2 08:05:16.172204 disk-uuid[661]: Secondary Entries is updated. Jul 2 08:05:16.172204 disk-uuid[661]: Secondary Header is updated. Jul 2 08:05:16.183152 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jul 2 08:05:16.192128 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jul 2 08:05:16.202105 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jul 2 08:05:17.199131 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jul 2 08:05:17.199527 disk-uuid[663]: The operation has completed successfully. Jul 2 08:05:17.386024 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 2 08:05:17.390187 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 2 08:05:17.453412 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 2 08:05:17.474696 sh[1004]: Success Jul 2 08:05:17.506128 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jul 2 08:05:17.608146 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 2 08:05:17.624306 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 2 08:05:17.632651 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 2 08:05:17.666186 kernel: BTRFS info (device dm-0): first mount of filesystem 9b0eb482-485a-4aff-8de4-e09ff146eadf Jul 2 08:05:17.666278 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jul 2 08:05:17.666324 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jul 2 08:05:17.667551 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jul 2 08:05:17.668721 kernel: BTRFS info (device dm-0): using free space tree Jul 2 08:05:17.747096 kernel: BTRFS info (device dm-0): enabling ssd optimizations Jul 2 08:05:17.779881 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 2 08:05:17.783306 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 2 08:05:17.792387 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 2 08:05:17.805642 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 2 08:05:17.833465 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem d9ea85ee-de2c-4ecb-9edd-179b77e44483 Jul 2 08:05:17.833561 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jul 2 08:05:17.835360 kernel: BTRFS info (device nvme0n1p6): using free space tree Jul 2 08:05:17.843372 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jul 2 08:05:17.859854 systemd[1]: mnt-oem.mount: Deactivated successfully. Jul 2 08:05:17.864123 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem d9ea85ee-de2c-4ecb-9edd-179b77e44483 Jul 2 08:05:17.887638 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 2 08:05:17.899559 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 2 08:05:17.981869 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 2 08:05:18.009355 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 2 08:05:18.068017 systemd-networkd[1198]: lo: Link UP Jul 2 08:05:18.068046 systemd-networkd[1198]: lo: Gained carrier Jul 2 08:05:18.072542 systemd-networkd[1198]: Enumeration completed Jul 2 08:05:18.073414 systemd-networkd[1198]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 2 08:05:18.073422 systemd-networkd[1198]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 2 08:05:18.079186 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 2 08:05:18.086355 systemd[1]: Reached target network.target - Network. Jul 2 08:05:18.088492 systemd-networkd[1198]: eth0: Link UP Jul 2 08:05:18.088501 systemd-networkd[1198]: eth0: Gained carrier Jul 2 08:05:18.088521 systemd-networkd[1198]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 2 08:05:18.108207 systemd-networkd[1198]: eth0: DHCPv4 address 172.31.25.167/20, gateway 172.31.16.1 acquired from 172.31.16.1 Jul 2 08:05:18.273660 ignition[1127]: Ignition 2.18.0 Jul 2 08:05:18.273694 ignition[1127]: Stage: fetch-offline Jul 2 08:05:18.275323 ignition[1127]: no configs at "/usr/lib/ignition/base.d" Jul 2 08:05:18.275359 ignition[1127]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 2 08:05:18.276997 ignition[1127]: Ignition finished successfully Jul 2 08:05:18.284599 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 2 08:05:18.294414 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jul 2 08:05:18.328292 ignition[1208]: Ignition 2.18.0 Jul 2 08:05:18.328313 ignition[1208]: Stage: fetch Jul 2 08:05:18.328922 ignition[1208]: no configs at "/usr/lib/ignition/base.d" Jul 2 08:05:18.328948 ignition[1208]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 2 08:05:18.329130 ignition[1208]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 2 08:05:18.338551 ignition[1208]: PUT result: OK Jul 2 08:05:18.341262 ignition[1208]: parsed url from cmdline: "" Jul 2 08:05:18.341425 ignition[1208]: no config URL provided Jul 2 08:05:18.342245 ignition[1208]: reading system config file "/usr/lib/ignition/user.ign" Jul 2 08:05:18.342519 ignition[1208]: no config at "/usr/lib/ignition/user.ign" Jul 2 08:05:18.342578 ignition[1208]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 2 08:05:18.346552 ignition[1208]: PUT result: OK Jul 2 08:05:18.349617 ignition[1208]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Jul 2 08:05:18.351863 ignition[1208]: GET result: OK Jul 2 08:05:18.353185 ignition[1208]: parsing config with SHA512: e87e9a1ec034eaa7343da5fb688dbf0a04ab2c2a53312d62fedab709d7a665d22d9d09be95ecfd719b78a3ebfae236825aba9680c4c9d3683fc6129a361ec867 Jul 2 08:05:18.361549 unknown[1208]: fetched base config from "system" Jul 2 08:05:18.361801 unknown[1208]: fetched base config from "system" Jul 2 08:05:18.362146 ignition[1208]: fetch: fetch complete Jul 2 08:05:18.361816 unknown[1208]: fetched user config from "aws" Jul 2 08:05:18.362159 ignition[1208]: fetch: fetch passed Jul 2 08:05:18.365211 ignition[1208]: Ignition finished successfully Jul 2 08:05:18.374891 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jul 2 08:05:18.384351 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 2 08:05:18.429464 ignition[1215]: Ignition 2.18.0 Jul 2 08:05:18.429490 ignition[1215]: Stage: kargs Jul 2 08:05:18.431040 ignition[1215]: no configs at "/usr/lib/ignition/base.d" Jul 2 08:05:18.431084 ignition[1215]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 2 08:05:18.431236 ignition[1215]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 2 08:05:18.436258 ignition[1215]: PUT result: OK Jul 2 08:05:18.442639 ignition[1215]: kargs: kargs passed Jul 2 08:05:18.442763 ignition[1215]: Ignition finished successfully Jul 2 08:05:18.448308 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 2 08:05:18.458398 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 2 08:05:18.486967 ignition[1222]: Ignition 2.18.0 Jul 2 08:05:18.486998 ignition[1222]: Stage: disks Jul 2 08:05:18.488690 ignition[1222]: no configs at "/usr/lib/ignition/base.d" Jul 2 08:05:18.488721 ignition[1222]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 2 08:05:18.489777 ignition[1222]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 2 08:05:18.494201 ignition[1222]: PUT result: OK Jul 2 08:05:18.499981 ignition[1222]: disks: disks passed Jul 2 08:05:18.500218 ignition[1222]: Ignition finished successfully Jul 2 08:05:18.505113 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 2 08:05:18.507701 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 2 08:05:18.509820 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 2 08:05:18.513134 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 2 08:05:18.532271 systemd[1]: Reached target sysinit.target - System Initialization. Jul 2 08:05:18.537996 systemd[1]: Reached target basic.target - Basic System. Jul 2 08:05:18.547350 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 2 08:05:18.602280 systemd-fsck[1231]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jul 2 08:05:18.609296 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 2 08:05:18.622461 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 2 08:05:18.712212 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 9aacfbff-cef8-4758-afb5-6310e7c6c5e6 r/w with ordered data mode. Quota mode: none. Jul 2 08:05:18.713348 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 2 08:05:18.716862 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 2 08:05:18.734264 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 2 08:05:18.749674 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 2 08:05:18.753860 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 2 08:05:18.753953 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 2 08:05:18.754002 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 2 08:05:18.767051 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 2 08:05:18.781158 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 2 08:05:18.791119 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/nvme0n1p6 scanned by mount (1250) Jul 2 08:05:18.795196 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem d9ea85ee-de2c-4ecb-9edd-179b77e44483 Jul 2 08:05:18.795272 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jul 2 08:05:18.795300 kernel: BTRFS info (device nvme0n1p6): using free space tree Jul 2 08:05:18.802107 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jul 2 08:05:18.804806 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 2 08:05:19.130761 initrd-setup-root[1274]: cut: /sysroot/etc/passwd: No such file or directory Jul 2 08:05:19.139220 initrd-setup-root[1281]: cut: /sysroot/etc/group: No such file or directory Jul 2 08:05:19.147784 initrd-setup-root[1288]: cut: /sysroot/etc/shadow: No such file or directory Jul 2 08:05:19.156128 initrd-setup-root[1295]: cut: /sysroot/etc/gshadow: No such file or directory Jul 2 08:05:19.565677 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 2 08:05:19.580246 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 2 08:05:19.585676 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 2 08:05:19.605155 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem d9ea85ee-de2c-4ecb-9edd-179b77e44483 Jul 2 08:05:19.606321 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 2 08:05:19.645550 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 2 08:05:19.647363 ignition[1363]: INFO : Ignition 2.18.0 Jul 2 08:05:19.647363 ignition[1363]: INFO : Stage: mount Jul 2 08:05:19.651312 ignition[1363]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 2 08:05:19.651312 ignition[1363]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 2 08:05:19.651312 ignition[1363]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 2 08:05:19.657692 ignition[1363]: INFO : PUT result: OK Jul 2 08:05:19.663001 ignition[1363]: INFO : mount: mount passed Jul 2 08:05:19.663001 ignition[1363]: INFO : Ignition finished successfully Jul 2 08:05:19.668044 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 2 08:05:19.689317 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 2 08:05:19.725004 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 2 08:05:19.744091 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by mount (1375) Jul 2 08:05:19.747984 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem d9ea85ee-de2c-4ecb-9edd-179b77e44483 Jul 2 08:05:19.748078 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jul 2 08:05:19.749206 kernel: BTRFS info (device nvme0n1p6): using free space tree Jul 2 08:05:19.754112 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jul 2 08:05:19.757537 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 2 08:05:19.796193 ignition[1392]: INFO : Ignition 2.18.0 Jul 2 08:05:19.796193 ignition[1392]: INFO : Stage: files Jul 2 08:05:19.799616 ignition[1392]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 2 08:05:19.799616 ignition[1392]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 2 08:05:19.799616 ignition[1392]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 2 08:05:19.817174 ignition[1392]: INFO : PUT result: OK Jul 2 08:05:19.820972 ignition[1392]: DEBUG : files: compiled without relabeling support, skipping Jul 2 08:05:19.823947 ignition[1392]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 2 08:05:19.823947 ignition[1392]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 2 08:05:19.858037 ignition[1392]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 2 08:05:19.861033 ignition[1392]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 2 08:05:19.863570 unknown[1392]: wrote ssh authorized keys file for user: core Jul 2 08:05:19.865666 ignition[1392]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 2 08:05:19.881460 ignition[1392]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 2 08:05:19.885143 ignition[1392]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 2 08:05:19.888280 ignition[1392]: INFO : files: op(4): [started] processing unit "etcd-member.service" Jul 2 08:05:19.908484 ignition[1392]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Jul 2 08:05:19.915315 ignition[1392]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Jul 2 08:05:19.915315 ignition[1392]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Jul 2 08:05:19.915315 ignition[1392]: INFO : files: op(6): [started] setting preset to enabled for "etcd-member.service" Jul 2 08:05:19.915315 ignition[1392]: INFO : files: op(6): [finished] setting preset to enabled for "etcd-member.service" Jul 2 08:05:19.915315 ignition[1392]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 2 08:05:19.915315 ignition[1392]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 2 08:05:19.915315 ignition[1392]: INFO : files: files passed Jul 2 08:05:19.915315 ignition[1392]: INFO : Ignition finished successfully Jul 2 08:05:19.937611 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 2 08:05:19.951553 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 2 08:05:19.959165 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 2 08:05:19.966743 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 2 08:05:19.970236 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 2 08:05:19.997587 initrd-setup-root-after-ignition[1421]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 2 08:05:19.997587 initrd-setup-root-after-ignition[1421]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 2 08:05:20.006141 initrd-setup-root-after-ignition[1425]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 2 08:05:20.012431 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 2 08:05:20.013406 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 2 08:05:20.027440 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 2 08:05:20.083172 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 2 08:05:20.083388 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 2 08:05:20.087570 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 2 08:05:20.092893 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 2 08:05:20.100746 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 2 08:05:20.122237 systemd-networkd[1198]: eth0: Gained IPv6LL Jul 2 08:05:20.125324 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 2 08:05:20.153497 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 2 08:05:20.175488 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 2 08:05:20.200765 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 2 08:05:20.205721 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 2 08:05:20.208077 systemd[1]: Stopped target timers.target - Timer Units. Jul 2 08:05:20.209824 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 2 08:05:20.210071 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 2 08:05:20.219621 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 2 08:05:20.221645 systemd[1]: Stopped target basic.target - Basic System. Jul 2 08:05:20.223505 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 2 08:05:20.230401 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 2 08:05:20.232765 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 2 08:05:20.238620 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 2 08:05:20.240606 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 2 08:05:20.243088 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 2 08:05:20.245562 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 2 08:05:20.250954 systemd[1]: Stopped target swap.target - Swaps. Jul 2 08:05:20.252968 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 2 08:05:20.253238 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 2 08:05:20.263203 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 2 08:05:20.265447 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 2 08:05:20.271384 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 2 08:05:20.274869 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 2 08:05:20.277327 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 2 08:05:20.277570 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 2 08:05:20.285371 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 2 08:05:20.285602 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 2 08:05:20.287935 systemd[1]: ignition-files.service: Deactivated successfully. Jul 2 08:05:20.288157 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 2 08:05:20.305585 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 2 08:05:20.308128 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 2 08:05:20.311612 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 2 08:05:20.320488 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 2 08:05:20.322172 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 2 08:05:20.322667 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 2 08:05:20.332213 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 2 08:05:20.335258 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 2 08:05:20.347582 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 2 08:05:20.349680 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 2 08:05:20.368538 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 2 08:05:20.377568 ignition[1445]: INFO : Ignition 2.18.0 Jul 2 08:05:20.377568 ignition[1445]: INFO : Stage: umount Jul 2 08:05:20.377568 ignition[1445]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 2 08:05:20.377568 ignition[1445]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 2 08:05:20.377568 ignition[1445]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 2 08:05:20.388435 ignition[1445]: INFO : PUT result: OK Jul 2 08:05:20.390572 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 2 08:05:20.393208 ignition[1445]: INFO : umount: umount passed Jul 2 08:05:20.393208 ignition[1445]: INFO : Ignition finished successfully Jul 2 08:05:20.398177 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 2 08:05:20.402224 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 2 08:05:20.403522 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 2 08:05:20.407569 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 2 08:05:20.407856 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 2 08:05:20.413211 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 2 08:05:20.413315 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 2 08:05:20.415320 systemd[1]: ignition-fetch.service: Deactivated successfully. Jul 2 08:05:20.415394 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jul 2 08:05:20.423592 systemd[1]: Stopped target network.target - Network. Jul 2 08:05:20.425164 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 2 08:05:20.425252 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 2 08:05:20.427397 systemd[1]: Stopped target paths.target - Path Units. Jul 2 08:05:20.429014 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 2 08:05:20.438144 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 2 08:05:20.440376 systemd[1]: Stopped target slices.target - Slice Units. Jul 2 08:05:20.441984 systemd[1]: Stopped target sockets.target - Socket Units. Jul 2 08:05:20.443760 systemd[1]: iscsid.socket: Deactivated successfully. Jul 2 08:05:20.443841 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 2 08:05:20.445641 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 2 08:05:20.445711 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 2 08:05:20.447564 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 2 08:05:20.447649 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 2 08:05:20.449544 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 2 08:05:20.449657 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 2 08:05:20.451786 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 2 08:05:20.451886 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 2 08:05:20.454240 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 2 08:05:20.456331 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 2 08:05:20.489165 systemd-networkd[1198]: eth0: DHCPv6 lease lost Jul 2 08:05:20.494313 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 2 08:05:20.496229 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 2 08:05:20.500802 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 2 08:05:20.501270 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 2 08:05:20.509468 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 2 08:05:20.511309 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 2 08:05:20.520309 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 2 08:05:20.522199 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 2 08:05:20.522321 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 2 08:05:20.528308 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 2 08:05:20.528417 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 2 08:05:20.539490 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 2 08:05:20.539593 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 2 08:05:20.541761 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 2 08:05:20.541837 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Jul 2 08:05:20.552799 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 2 08:05:20.580672 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 2 08:05:20.581030 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 2 08:05:20.588744 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 2 08:05:20.588892 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 2 08:05:20.592233 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 2 08:05:20.592309 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 2 08:05:20.601374 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 2 08:05:20.601471 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 2 08:05:20.603550 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 2 08:05:20.603631 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 2 08:05:20.605721 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 2 08:05:20.605799 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 2 08:05:20.625501 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 2 08:05:20.629453 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 2 08:05:20.629570 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 2 08:05:20.632866 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 2 08:05:20.632950 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 2 08:05:20.635943 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 2 08:05:20.636158 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 2 08:05:20.666854 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 2 08:05:20.667361 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 2 08:05:20.673313 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 2 08:05:20.682422 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 2 08:05:20.710024 systemd[1]: Switching root. Jul 2 08:05:20.750338 systemd-journald[250]: Journal stopped Jul 2 08:05:23.312804 systemd-journald[250]: Received SIGTERM from PID 1 (systemd). Jul 2 08:05:23.312969 kernel: SELinux: policy capability network_peer_controls=1 Jul 2 08:05:23.313024 kernel: SELinux: policy capability open_perms=1 Jul 2 08:05:23.313084 kernel: SELinux: policy capability extended_socket_class=1 Jul 2 08:05:23.313125 kernel: SELinux: policy capability always_check_network=0 Jul 2 08:05:23.313158 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 2 08:05:23.313193 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 2 08:05:23.313233 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 2 08:05:23.313265 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 2 08:05:23.313306 kernel: audit: type=1403 audit(1719907521.204:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 2 08:05:23.313341 systemd[1]: Successfully loaded SELinux policy in 64.064ms. Jul 2 08:05:23.313384 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 22.829ms. Jul 2 08:05:23.313418 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) Jul 2 08:05:23.313448 systemd[1]: Detected virtualization amazon. Jul 2 08:05:23.313481 systemd[1]: Detected architecture arm64. Jul 2 08:05:23.313517 systemd[1]: Detected first boot. Jul 2 08:05:23.313553 systemd[1]: Initializing machine ID from VM UUID. Jul 2 08:05:23.313585 zram_generator::config[1488]: No configuration found. Jul 2 08:05:23.313623 systemd[1]: Populated /etc with preset unit settings. Jul 2 08:05:23.313667 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 2 08:05:23.313702 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 2 08:05:23.313739 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 2 08:05:23.313776 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 2 08:05:23.313811 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 2 08:05:23.313843 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 2 08:05:23.313876 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 2 08:05:23.313911 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 2 08:05:23.313949 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 2 08:05:23.313984 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 2 08:05:23.314020 systemd[1]: Created slice user.slice - User and Session Slice. Jul 2 08:05:23.317094 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 2 08:05:23.317184 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 2 08:05:23.317218 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 2 08:05:23.317253 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 2 08:05:23.317294 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 2 08:05:23.317339 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 2 08:05:23.317371 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jul 2 08:05:23.317404 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 2 08:05:23.317441 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 2 08:05:23.317474 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 2 08:05:23.317508 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 2 08:05:23.317542 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 2 08:05:23.317575 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 2 08:05:23.317613 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 2 08:05:23.317646 systemd[1]: Reached target slices.target - Slice Units. Jul 2 08:05:23.317681 systemd[1]: Reached target swap.target - Swaps. Jul 2 08:05:23.317718 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 2 08:05:23.317755 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 2 08:05:23.317785 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 2 08:05:23.317815 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 2 08:05:23.317847 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 2 08:05:23.317882 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 2 08:05:23.317913 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 2 08:05:23.317943 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 2 08:05:23.317975 systemd[1]: Mounting media.mount - External Media Directory... Jul 2 08:05:23.318011 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 2 08:05:23.318045 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 2 08:05:23.318108 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 2 08:05:23.318143 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). Jul 2 08:05:23.318174 systemd[1]: Reached target machines.target - Containers. Jul 2 08:05:23.318204 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 2 08:05:23.318235 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 2 08:05:23.318269 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 2 08:05:23.318307 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 2 08:05:23.318338 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 2 08:05:23.318371 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 2 08:05:23.318403 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 2 08:05:23.318433 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 2 08:05:23.318464 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 2 08:05:23.318495 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 2 08:05:23.318525 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 2 08:05:23.318559 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 2 08:05:23.318592 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 2 08:05:23.318622 systemd[1]: Stopped systemd-fsck-usr.service. Jul 2 08:05:23.318652 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 2 08:05:23.318681 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 2 08:05:23.318715 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 2 08:05:23.318744 kernel: fuse: init (API version 7.39) Jul 2 08:05:23.318776 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 2 08:05:23.318808 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 2 08:05:23.318841 systemd[1]: verity-setup.service: Deactivated successfully. Jul 2 08:05:23.318879 systemd[1]: Stopped verity-setup.service. Jul 2 08:05:23.318908 kernel: loop: module loaded Jul 2 08:05:23.318936 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 2 08:05:23.318966 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 2 08:05:23.318997 systemd[1]: Mounted media.mount - External Media Directory. Jul 2 08:05:23.319027 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 2 08:05:23.319104 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 2 08:05:23.319144 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 2 08:05:23.319186 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 2 08:05:23.319218 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 2 08:05:23.319249 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 2 08:05:23.319279 kernel: ACPI: bus type drm_connector registered Jul 2 08:05:23.319309 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 2 08:05:23.319345 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 2 08:05:23.319376 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 2 08:05:23.319408 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 2 08:05:23.319439 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 2 08:05:23.319473 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 2 08:05:23.319503 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 2 08:05:23.319534 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 2 08:05:23.319570 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 2 08:05:23.319602 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 2 08:05:23.319639 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 2 08:05:23.319670 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 2 08:05:23.319702 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 2 08:05:23.319736 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 2 08:05:23.319827 systemd-journald[1569]: Collecting audit messages is disabled. Jul 2 08:05:23.319898 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 2 08:05:23.319931 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 2 08:05:23.319961 systemd-journald[1569]: Journal started Jul 2 08:05:23.320010 systemd-journald[1569]: Runtime Journal (/run/log/journal/ec2d35a78632bb324cfa33f94a5cf8e5) is 8.0M, max 75.3M, 67.3M free. Jul 2 08:05:23.324119 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 2 08:05:22.604855 systemd[1]: Queued start job for default target multi-user.target. Jul 2 08:05:22.685697 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Jul 2 08:05:22.686576 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 2 08:05:23.335357 systemd[1]: Started systemd-journald.service - Journal Service. Jul 2 08:05:23.343449 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 2 08:05:23.346325 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 2 08:05:23.348850 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 2 08:05:23.363757 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 2 08:05:23.391563 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 2 08:05:23.391667 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 2 08:05:23.395902 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jul 2 08:05:23.407486 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 2 08:05:23.412182 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 2 08:05:23.414256 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 2 08:05:23.419375 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 2 08:05:23.425441 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 2 08:05:23.430617 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 2 08:05:23.444050 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 2 08:05:23.458549 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 2 08:05:23.462885 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 2 08:05:23.467166 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 2 08:05:23.470964 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 2 08:05:23.503896 systemd-journald[1569]: Time spent on flushing to /var/log/journal/ec2d35a78632bb324cfa33f94a5cf8e5 is 165.294ms for 889 entries. Jul 2 08:05:23.503896 systemd-journald[1569]: System Journal (/var/log/journal/ec2d35a78632bb324cfa33f94a5cf8e5) is 8.0M, max 195.6M, 187.6M free. Jul 2 08:05:23.685926 systemd-journald[1569]: Received client request to flush runtime journal. Jul 2 08:05:23.686098 kernel: loop0: detected capacity change from 0 to 113672 Jul 2 08:05:23.686168 kernel: block loop0: the capability attribute has been deprecated. Jul 2 08:05:23.556430 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 2 08:05:23.559124 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 2 08:05:23.572389 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jul 2 08:05:23.621169 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 2 08:05:23.634484 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 2 08:05:23.660253 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 2 08:05:23.674536 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jul 2 08:05:23.695208 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 2 08:05:23.720151 udevadm[1631]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jul 2 08:05:23.735894 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 2 08:05:23.744900 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jul 2 08:05:23.758006 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 2 08:05:23.760025 systemd-tmpfiles[1628]: ACLs are not supported, ignoring. Jul 2 08:05:23.760193 systemd-tmpfiles[1628]: ACLs are not supported, ignoring. Jul 2 08:05:23.771966 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 2 08:05:23.783101 kernel: loop1: detected capacity change from 0 to 59672 Jul 2 08:05:23.905145 kernel: loop2: detected capacity change from 0 to 51896 Jul 2 08:05:24.005183 kernel: loop3: detected capacity change from 0 to 113672 Jul 2 08:05:24.022106 kernel: loop4: detected capacity change from 0 to 59672 Jul 2 08:05:24.038107 kernel: loop5: detected capacity change from 0 to 51896 Jul 2 08:05:24.057810 (sd-merge)[1641]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Jul 2 08:05:24.058737 (sd-merge)[1641]: Merged extensions into '/usr'. Jul 2 08:05:24.080618 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 2 08:05:24.094587 systemd[1]: Starting ensure-sysext.service... Jul 2 08:05:24.104792 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Jul 2 08:05:24.152664 systemd[1]: Reloading requested from client PID 1644 ('systemctl') (unit ensure-sysext.service)... Jul 2 08:05:24.152899 systemd[1]: Reloading... Jul 2 08:05:24.176962 systemd-tmpfiles[1645]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 2 08:05:24.177673 systemd-tmpfiles[1645]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 2 08:05:24.183724 systemd-tmpfiles[1645]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 2 08:05:24.186438 systemd-tmpfiles[1645]: ACLs are not supported, ignoring. Jul 2 08:05:24.186596 systemd-tmpfiles[1645]: ACLs are not supported, ignoring. Jul 2 08:05:24.210770 systemd-tmpfiles[1645]: Detected autofs mount point /boot during canonicalization of boot. Jul 2 08:05:24.210800 systemd-tmpfiles[1645]: Skipping /boot Jul 2 08:05:24.266159 systemd-tmpfiles[1645]: Detected autofs mount point /boot during canonicalization of boot. Jul 2 08:05:24.266185 systemd-tmpfiles[1645]: Skipping /boot Jul 2 08:05:24.315136 zram_generator::config[1668]: No configuration found. Jul 2 08:05:24.673600 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. Jul 2 08:05:24.802612 systemd[1]: Reloading finished in 648 ms. Jul 2 08:05:24.856173 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Jul 2 08:05:24.871477 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jul 2 08:05:24.878417 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 2 08:05:24.888373 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 2 08:05:24.909534 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 2 08:05:24.923579 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 2 08:05:24.943139 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 2 08:05:24.950572 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 2 08:05:24.969643 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 2 08:05:24.981727 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 2 08:05:24.983970 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 2 08:05:24.990488 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 2 08:05:24.990879 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 2 08:05:25.006186 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 2 08:05:25.027551 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 2 08:05:25.032882 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 2 08:05:25.035827 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 2 08:05:25.036579 systemd[1]: Reached target time-set.target - System Time Set. Jul 2 08:05:25.050211 systemd[1]: Finished ensure-sysext.service. Jul 2 08:05:25.065054 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 2 08:05:25.068302 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 2 08:05:25.069231 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 2 08:05:25.072196 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 2 08:05:25.073626 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 2 08:05:25.084941 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 2 08:05:25.113838 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 2 08:05:25.130349 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 2 08:05:25.133717 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 2 08:05:25.135232 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 2 08:05:25.139253 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 2 08:05:25.139753 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 2 08:05:25.147578 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 2 08:05:25.147717 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). Jul 2 08:05:25.175182 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 2 08:05:25.190567 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 2 08:05:25.242894 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 2 08:05:25.249728 augenrules[1759]: No rules Jul 2 08:05:25.260242 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jul 2 08:05:25.316828 systemd-udevd[1755]: Using default interface naming scheme 'v255'. Jul 2 08:05:25.357555 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 2 08:05:25.389669 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 2 08:05:25.473477 systemd-resolved[1728]: Positive Trust Anchors: Jul 2 08:05:25.473525 systemd-resolved[1728]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 2 08:05:25.473589 systemd-resolved[1728]: 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 corp home internal intranet lan local private test Jul 2 08:05:25.499237 systemd-resolved[1728]: Defaulting to hostname 'linux'. Jul 2 08:05:25.509156 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 2 08:05:25.513123 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 2 08:05:25.556107 ldconfig[1616]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 2 08:05:25.569171 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 2 08:05:25.596366 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 2 08:05:25.599942 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jul 2 08:05:25.605251 systemd-networkd[1776]: lo: Link UP Jul 2 08:05:25.605272 systemd-networkd[1776]: lo: Gained carrier Jul 2 08:05:25.609541 systemd-networkd[1776]: Enumeration completed Jul 2 08:05:25.609761 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 2 08:05:25.612899 systemd[1]: Reached target network.target - Network. Jul 2 08:05:25.616628 (udev-worker)[1781]: Network interface NamePolicy= disabled on kernel command line. Jul 2 08:05:25.623361 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 2 08:05:25.631163 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1771) Jul 2 08:05:25.655917 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 2 08:05:25.821455 systemd-networkd[1776]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 2 08:05:25.822413 systemd-networkd[1776]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 2 08:05:25.825729 systemd-networkd[1776]: eth0: Link UP Jul 2 08:05:25.826041 systemd-networkd[1776]: eth0: Gained carrier Jul 2 08:05:25.826105 systemd-networkd[1776]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 2 08:05:25.847319 systemd-networkd[1776]: eth0: DHCPv4 address 172.31.25.167/20, gateway 172.31.16.1 acquired from 172.31.16.1 Jul 2 08:05:25.892147 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 34 scanned by (udev-worker) (1778) Jul 2 08:05:25.928882 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 2 08:05:26.110185 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 2 08:05:26.137897 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Jul 2 08:05:26.151573 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 2 08:05:26.156988 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jul 2 08:05:26.171351 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jul 2 08:05:26.194196 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 2 08:05:26.203177 lvm[1897]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 2 08:05:26.243217 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jul 2 08:05:26.246848 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 2 08:05:26.249653 systemd[1]: Reached target sysinit.target - System Initialization. Jul 2 08:05:26.251928 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 2 08:05:26.254353 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 2 08:05:26.257210 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 2 08:05:26.259722 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 2 08:05:26.262248 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 2 08:05:26.264809 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 2 08:05:26.264896 systemd[1]: Reached target paths.target - Path Units. Jul 2 08:05:26.266978 systemd[1]: Reached target timers.target - Timer Units. Jul 2 08:05:26.270774 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 2 08:05:26.275909 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 2 08:05:26.284160 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 2 08:05:26.288908 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jul 2 08:05:26.294493 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 2 08:05:26.297800 systemd[1]: Reached target sockets.target - Socket Units. Jul 2 08:05:26.300016 systemd[1]: Reached target basic.target - Basic System. Jul 2 08:05:26.302271 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 2 08:05:26.302550 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 2 08:05:26.311583 systemd[1]: Starting containerd.service - containerd container runtime... Jul 2 08:05:26.319596 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jul 2 08:05:26.332108 lvm[1903]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 2 08:05:26.333436 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 2 08:05:26.349418 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 2 08:05:26.354506 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 2 08:05:26.357260 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). Jul 2 08:05:26.361475 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 2 08:05:26.384507 systemd[1]: Started ntpd.service - Network Time Service. Jul 2 08:05:26.391254 systemd[1]: Starting setup-oem.service - Setup OEM... Jul 2 08:05:26.410458 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 2 08:05:26.426416 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 2 08:05:26.452509 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 2 08:05:26.455995 jq[1907]: false Jul 2 08:05:26.456655 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 2 08:05:26.457713 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 2 08:05:26.466640 systemd[1]: Starting update-engine.service - Update Engine... Jul 2 08:05:26.472396 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 2 08:05:26.478183 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jul 2 08:05:26.486004 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 2 08:05:26.488203 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 2 08:05:26.523319 dbus-daemon[1906]: [system] SELinux support is enabled Jul 2 08:05:26.523711 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 2 08:05:26.531912 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). Jul 2 08:05:26.543552 dbus-daemon[1906]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1776 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Jul 2 08:05:26.533086 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 2 08:05:26.535594 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). Jul 2 08:05:26.535640 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 2 08:05:26.552451 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Jul 2 08:05:26.554928 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 2 08:05:26.556240 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 2 08:05:26.606634 jq[1916]: true Jul 2 08:05:26.635108 extend-filesystems[1908]: Found loop3 Jul 2 08:05:26.635108 extend-filesystems[1908]: Found loop4 Jul 2 08:05:26.635108 extend-filesystems[1908]: Found loop5 Jul 2 08:05:26.653843 extend-filesystems[1908]: Found nvme0n1 Jul 2 08:05:26.653843 extend-filesystems[1908]: Found nvme0n1p1 Jul 2 08:05:26.653843 extend-filesystems[1908]: Found nvme0n1p2 Jul 2 08:05:26.653843 extend-filesystems[1908]: Found nvme0n1p3 Jul 2 08:05:26.653843 extend-filesystems[1908]: Found usr Jul 2 08:05:26.653843 extend-filesystems[1908]: Found nvme0n1p4 Jul 2 08:05:26.653843 extend-filesystems[1908]: Found nvme0n1p6 Jul 2 08:05:26.653843 extend-filesystems[1908]: Found nvme0n1p7 Jul 2 08:05:26.653843 extend-filesystems[1908]: Found nvme0n1p9 Jul 2 08:05:26.653843 extend-filesystems[1908]: Checking size of /dev/nvme0n1p9 Jul 2 08:05:26.696306 update_engine[1915]: I0702 08:05:26.680536 1915 main.cc:92] Flatcar Update Engine starting Jul 2 08:05:26.699484 ntpd[1910]: ntpd 4.2.8p17@1.4004-o Mon Jul 1 22:11:12 UTC 2024 (1): Starting Jul 2 08:05:26.702862 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: ntpd 4.2.8p17@1.4004-o Mon Jul 1 22:11:12 UTC 2024 (1): Starting Jul 2 08:05:26.702862 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Jul 2 08:05:26.702862 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: ---------------------------------------------------- Jul 2 08:05:26.702862 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: ntp-4 is maintained by Network Time Foundation, Jul 2 08:05:26.702862 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Jul 2 08:05:26.702862 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: corporation. Support and training for ntp-4 are Jul 2 08:05:26.702862 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: available at https://www.nwtime.org/support Jul 2 08:05:26.702862 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: ---------------------------------------------------- Jul 2 08:05:26.699560 ntpd[1910]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Jul 2 08:05:26.699582 ntpd[1910]: ---------------------------------------------------- Jul 2 08:05:26.703900 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: proto: precision = 0.108 usec (-23) Jul 2 08:05:26.699601 ntpd[1910]: ntp-4 is maintained by Network Time Foundation, Jul 2 08:05:26.699620 ntpd[1910]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Jul 2 08:05:26.699644 ntpd[1910]: corporation. Support and training for ntp-4 are Jul 2 08:05:26.717787 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: basedate set to 2024-06-19 Jul 2 08:05:26.717787 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: gps base set to 2024-06-23 (week 2320) Jul 2 08:05:26.717787 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: Listen and drop on 0 v6wildcard [::]:123 Jul 2 08:05:26.717787 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jul 2 08:05:26.717787 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: Listen normally on 2 lo 127.0.0.1:123 Jul 2 08:05:26.717787 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: Listen normally on 3 eth0 172.31.25.167:123 Jul 2 08:05:26.717787 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: Listen normally on 4 lo [::1]:123 Jul 2 08:05:26.717787 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: bind(21) AF_INET6 fe80::417:31ff:fea1:6c15%2#123 flags 0x11 failed: Cannot assign requested address Jul 2 08:05:26.717787 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: unable to create socket on eth0 (5) for fe80::417:31ff:fea1:6c15%2#123 Jul 2 08:05:26.717787 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: failed to init interface for address fe80::417:31ff:fea1:6c15%2 Jul 2 08:05:26.717787 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: Listening on routing socket on fd #21 for interface updates Jul 2 08:05:26.705349 systemd[1]: Started update-engine.service - Update Engine. Jul 2 08:05:26.718398 update_engine[1915]: I0702 08:05:26.709383 1915 update_check_scheduler.cc:74] Next update check in 7m40s Jul 2 08:05:26.699664 ntpd[1910]: available at https://www.nwtime.org/support Jul 2 08:05:26.699683 ntpd[1910]: ---------------------------------------------------- Jul 2 08:05:26.703706 ntpd[1910]: proto: precision = 0.108 usec (-23) Jul 2 08:05:26.711159 ntpd[1910]: basedate set to 2024-06-19 Jul 2 08:05:26.711216 ntpd[1910]: gps base set to 2024-06-23 (week 2320) Jul 2 08:05:26.715021 ntpd[1910]: Listen and drop on 0 v6wildcard [::]:123 Jul 2 08:05:26.716169 ntpd[1910]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jul 2 08:05:26.716473 ntpd[1910]: Listen normally on 2 lo 127.0.0.1:123 Jul 2 08:05:26.716540 ntpd[1910]: Listen normally on 3 eth0 172.31.25.167:123 Jul 2 08:05:26.716627 ntpd[1910]: Listen normally on 4 lo [::1]:123 Jul 2 08:05:26.716746 ntpd[1910]: bind(21) AF_INET6 fe80::417:31ff:fea1:6c15%2#123 flags 0x11 failed: Cannot assign requested address Jul 2 08:05:26.716788 ntpd[1910]: unable to create socket on eth0 (5) for fe80::417:31ff:fea1:6c15%2#123 Jul 2 08:05:26.716817 ntpd[1910]: failed to init interface for address fe80::417:31ff:fea1:6c15%2 Jul 2 08:05:26.716875 ntpd[1910]: Listening on routing socket on fd #21 for interface updates Jul 2 08:05:26.727144 ntpd[1910]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 2 08:05:26.741171 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 2 08:05:26.741171 ntpd[1910]: 2 Jul 08:05:26 ntpd[1910]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 2 08:05:26.727218 ntpd[1910]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 2 08:05:26.752164 extend-filesystems[1908]: Resized partition /dev/nvme0n1p9 Jul 2 08:05:26.754710 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 2 08:05:26.756953 (ntainerd)[1939]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 2 08:05:26.776695 extend-filesystems[1952]: resize2fs 1.47.0 (5-Feb-2023) Jul 2 08:05:26.791019 systemd[1]: motdgen.service: Deactivated successfully. Jul 2 08:05:26.794220 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 2 08:05:26.807127 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Jul 2 08:05:26.818766 jq[1938]: true Jul 2 08:05:26.826207 coreos-metadata[1905]: Jul 02 08:05:26.826 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Jul 2 08:05:26.834503 coreos-metadata[1905]: Jul 02 08:05:26.834 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Jul 2 08:05:26.835800 coreos-metadata[1905]: Jul 02 08:05:26.835 INFO Fetch successful Jul 2 08:05:26.836177 coreos-metadata[1905]: Jul 02 08:05:26.835 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Jul 2 08:05:26.842332 coreos-metadata[1905]: Jul 02 08:05:26.842 INFO Fetch successful Jul 2 08:05:26.842332 coreos-metadata[1905]: Jul 02 08:05:26.842 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Jul 2 08:05:26.847253 coreos-metadata[1905]: Jul 02 08:05:26.847 INFO Fetch successful Jul 2 08:05:26.847253 coreos-metadata[1905]: Jul 02 08:05:26.847 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Jul 2 08:05:26.853201 coreos-metadata[1905]: Jul 02 08:05:26.853 INFO Fetch successful Jul 2 08:05:26.853201 coreos-metadata[1905]: Jul 02 08:05:26.853 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Jul 2 08:05:26.854696 coreos-metadata[1905]: Jul 02 08:05:26.854 INFO Fetch failed with 404: resource not found Jul 2 08:05:26.854696 coreos-metadata[1905]: Jul 02 08:05:26.854 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Jul 2 08:05:26.860230 coreos-metadata[1905]: Jul 02 08:05:26.860 INFO Fetch successful Jul 2 08:05:26.860230 coreos-metadata[1905]: Jul 02 08:05:26.860 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Jul 2 08:05:26.861918 coreos-metadata[1905]: Jul 02 08:05:26.861 INFO Fetch successful Jul 2 08:05:26.861918 coreos-metadata[1905]: Jul 02 08:05:26.861 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Jul 2 08:05:26.866520 coreos-metadata[1905]: Jul 02 08:05:26.866 INFO Fetch successful Jul 2 08:05:26.866520 coreos-metadata[1905]: Jul 02 08:05:26.866 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Jul 2 08:05:26.881529 coreos-metadata[1905]: Jul 02 08:05:26.877 INFO Fetch successful Jul 2 08:05:26.881529 coreos-metadata[1905]: Jul 02 08:05:26.881 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Jul 2 08:05:26.884105 coreos-metadata[1905]: Jul 02 08:05:26.882 INFO Fetch successful Jul 2 08:05:26.888166 systemd[1]: Finished setup-oem.service - Setup OEM. Jul 2 08:05:26.931018 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 2 08:05:26.956104 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Jul 2 08:05:26.984929 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jul 2 08:05:26.987769 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 2 08:05:27.001396 extend-filesystems[1952]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Jul 2 08:05:27.001396 extend-filesystems[1952]: old_desc_blocks = 1, new_desc_blocks = 1 Jul 2 08:05:27.001396 extend-filesystems[1952]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Jul 2 08:05:27.022681 extend-filesystems[1908]: Resized filesystem in /dev/nvme0n1p9 Jul 2 08:05:27.008197 systemd-logind[1914]: Watching system buttons on /dev/input/event0 (Power Button) Jul 2 08:05:27.008257 systemd-logind[1914]: Watching system buttons on /dev/input/event1 (Sleep Button) Jul 2 08:05:27.011298 systemd-logind[1914]: New seat seat0. Jul 2 08:05:27.017757 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 2 08:05:27.018436 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 2 08:05:27.033830 systemd[1]: Started systemd-logind.service - User Login Management. Jul 2 08:05:27.123010 locksmithd[1947]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 2 08:05:27.168125 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 34 scanned by (udev-worker) (1781) Jul 2 08:05:27.183321 bash[1994]: Updated "/home/core/.ssh/authorized_keys" Jul 2 08:05:27.187853 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 2 08:05:27.226934 systemd[1]: Starting sshkeys.service... Jul 2 08:05:27.257877 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Jul 2 08:05:27.262251 dbus-daemon[1906]: [system] Successfully activated service 'org.freedesktop.hostname1' Jul 2 08:05:27.272099 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Jul 2 08:05:27.272818 dbus-daemon[1906]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=1929 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Jul 2 08:05:27.277345 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Jul 2 08:05:27.298751 systemd[1]: Starting polkit.service - Authorization Manager... Jul 2 08:05:27.378788 polkitd[2035]: Started polkitd version 121 Jul 2 08:05:27.408822 polkitd[2035]: Loading rules from directory /etc/polkit-1/rules.d Jul 2 08:05:27.408973 polkitd[2035]: Loading rules from directory /usr/share/polkit-1/rules.d Jul 2 08:05:27.413424 polkitd[2035]: Finished loading, compiling and executing 2 rules Jul 2 08:05:27.418356 dbus-daemon[1906]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jul 2 08:05:27.418659 systemd[1]: Started polkit.service - Authorization Manager. Jul 2 08:05:27.424272 polkitd[2035]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Jul 2 08:05:27.457223 coreos-metadata[2030]: Jul 02 08:05:27.455 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Jul 2 08:05:27.463099 coreos-metadata[2030]: Jul 02 08:05:27.460 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Jul 2 08:05:27.463099 coreos-metadata[2030]: Jul 02 08:05:27.461 INFO Fetch successful Jul 2 08:05:27.463099 coreos-metadata[2030]: Jul 02 08:05:27.461 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Jul 2 08:05:27.463595 coreos-metadata[2030]: Jul 02 08:05:27.463 INFO Fetch successful Jul 2 08:05:27.466651 unknown[2030]: wrote ssh authorized keys file for user: core Jul 2 08:05:27.513620 systemd-hostnamed[1929]: Hostname set to <ip-172-31-25-167> (transient) Jul 2 08:05:27.516193 systemd-resolved[1728]: System hostname changed to 'ip-172-31-25-167'. Jul 2 08:05:27.531438 update-ssh-keys[2069]: Updated "/home/core/.ssh/authorized_keys" Jul 2 08:05:27.531887 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Jul 2 08:05:27.541330 systemd[1]: Finished sshkeys.service. Jul 2 08:05:27.610154 containerd[1939]: time="2024-07-02T08:05:27.609582346Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Jul 2 08:05:27.610320 systemd-networkd[1776]: eth0: Gained IPv6LL Jul 2 08:05:27.624233 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 2 08:05:27.640512 systemd[1]: Reached target network-online.target - Network is Online. Jul 2 08:05:27.649984 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Jul 2 08:05:27.661599 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Jul 2 08:05:27.669623 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 2 08:05:27.729375 (-wrapper)[2098]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Jul 2 08:05:27.808631 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 2 08:05:27.829108 containerd[1939]: time="2024-07-02T08:05:27.827348243Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jul 2 08:05:27.829108 containerd[1939]: time="2024-07-02T08:05:27.827437643Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jul 2 08:05:27.838401 containerd[1939]: time="2024-07-02T08:05:27.838313495Z" 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.36-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jul 2 08:05:27.838649 containerd[1939]: time="2024-07-02T08:05:27.838546175Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jul 2 08:05:27.844116 containerd[1939]: time="2024-07-02T08:05:27.842745995Z" 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 Jul 2 08:05:27.844116 containerd[1939]: time="2024-07-02T08:05:27.842815667Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jul 2 08:05:27.844116 containerd[1939]: time="2024-07-02T08:05:27.843130475Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jul 2 08:05:27.844116 containerd[1939]: time="2024-07-02T08:05:27.843313331Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jul 2 08:05:27.844116 containerd[1939]: time="2024-07-02T08:05:27.843350615Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jul 2 08:05:27.844116 containerd[1939]: time="2024-07-02T08:05:27.843517523Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jul 2 08:05:27.844116 containerd[1939]: time="2024-07-02T08:05:27.844002155Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jul 2 08:05:27.849093 containerd[1939]: time="2024-07-02T08:05:27.848124767Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Jul 2 08:05:27.849093 containerd[1939]: time="2024-07-02T08:05:27.848202803Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jul 2 08:05:27.849093 containerd[1939]: time="2024-07-02T08:05:27.848458859Z" 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 Jul 2 08:05:27.849093 containerd[1939]: time="2024-07-02T08:05:27.848500271Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jul 2 08:05:27.849093 containerd[1939]: time="2024-07-02T08:05:27.848714603Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Jul 2 08:05:27.849093 containerd[1939]: time="2024-07-02T08:05:27.848753411Z" level=info msg="metadata content store policy set" policy=shared Jul 2 08:05:27.867096 amazon-ssm-agent[2096]: Initializing new seelog logger Jul 2 08:05:27.867096 amazon-ssm-agent[2096]: New Seelog Logger Creation Complete Jul 2 08:05:27.867096 amazon-ssm-agent[2096]: 2024/07/02 08:05:27 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jul 2 08:05:27.867096 amazon-ssm-agent[2096]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jul 2 08:05:27.875107 amazon-ssm-agent[2096]: 2024/07/02 08:05:27 processing appconfig overrides Jul 2 08:05:27.876639 amazon-ssm-agent[2096]: 2024/07/02 08:05:27 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jul 2 08:05:27.876639 amazon-ssm-agent[2096]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jul 2 08:05:27.876639 amazon-ssm-agent[2096]: 2024/07/02 08:05:27 processing appconfig overrides Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877223567Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877305347Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877345967Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877417091Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877458779Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877488299Z" level=info msg="NRI interface is disabled by configuration." Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877519355Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877769915Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877814999Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877855451Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877890503Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877927379Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877966475Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jul 2 08:05:27.879121 containerd[1939]: time="2024-07-02T08:05:27.877997423Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jul 2 08:05:27.879846 containerd[1939]: time="2024-07-02T08:05:27.878046047Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jul 2 08:05:27.879846 containerd[1939]: time="2024-07-02T08:05:27.878119559Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jul 2 08:05:27.879846 containerd[1939]: time="2024-07-02T08:05:27.878158343Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jul 2 08:05:27.879846 containerd[1939]: time="2024-07-02T08:05:27.878189315Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jul 2 08:05:27.879846 containerd[1939]: time="2024-07-02T08:05:27.878224919Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jul 2 08:05:27.879846 containerd[1939]: time="2024-07-02T08:05:27.878502935Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jul 2 08:05:27.879846 containerd[1939]: time="2024-07-02T08:05:27.878986367Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jul 2 08:05:27.883096 amazon-ssm-agent[2096]: 2024-07-02 08:05:27 INFO Proxy environment variables: Jul 2 08:05:27.883096 amazon-ssm-agent[2096]: 2024/07/02 08:05:27 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jul 2 08:05:27.883096 amazon-ssm-agent[2096]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jul 2 08:05:27.883096 amazon-ssm-agent[2096]: 2024/07/02 08:05:27 processing appconfig overrides Jul 2 08:05:27.885800 containerd[1939]: time="2024-07-02T08:05:27.885725747Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.887180 containerd[1939]: time="2024-07-02T08:05:27.886284443Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jul 2 08:05:27.887180 containerd[1939]: time="2024-07-02T08:05:27.886384019Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jul 2 08:05:27.887180 containerd[1939]: time="2024-07-02T08:05:27.886538111Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.887180 containerd[1939]: time="2024-07-02T08:05:27.886579043Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.887180 containerd[1939]: time="2024-07-02T08:05:27.886616279Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.887180 containerd[1939]: time="2024-07-02T08:05:27.886646855Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.887180 containerd[1939]: time="2024-07-02T08:05:27.886679027Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.890138 containerd[1939]: time="2024-07-02T08:05:27.886715075Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.890265 containerd[1939]: time="2024-07-02T08:05:27.890166935Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.890265 containerd[1939]: time="2024-07-02T08:05:27.890214635Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.890265 containerd[1939]: time="2024-07-02T08:05:27.890252255Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jul 2 08:05:27.890733 containerd[1939]: time="2024-07-02T08:05:27.890660231Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.890901 containerd[1939]: time="2024-07-02T08:05:27.890738375Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.890901 containerd[1939]: time="2024-07-02T08:05:27.890775059Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.890901 containerd[1939]: time="2024-07-02T08:05:27.890809463Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.890901 containerd[1939]: time="2024-07-02T08:05:27.890840171Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.890901 containerd[1939]: time="2024-07-02T08:05:27.890877803Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.891841 containerd[1939]: time="2024-07-02T08:05:27.890908931Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.891841 containerd[1939]: time="2024-07-02T08:05:27.890936675Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jul 2 08:05:27.895522 containerd[1939]: time="2024-07-02T08:05:27.895316651Z" 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}" Jul 2 08:05:27.895522 containerd[1939]: time="2024-07-02T08:05:27.895486571Z" level=info msg="Connect containerd service" Jul 2 08:05:27.895900 containerd[1939]: time="2024-07-02T08:05:27.895561091Z" level=info msg="using legacy CRI server" Jul 2 08:05:27.895900 containerd[1939]: time="2024-07-02T08:05:27.895582439Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 2 08:05:27.895900 containerd[1939]: time="2024-07-02T08:05:27.895799291Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jul 2 08:05:27.900135 amazon-ssm-agent[2096]: 2024/07/02 08:05:27 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jul 2 08:05:27.900135 amazon-ssm-agent[2096]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jul 2 08:05:27.900135 amazon-ssm-agent[2096]: 2024/07/02 08:05:27 processing appconfig overrides Jul 2 08:05:27.907403 containerd[1939]: time="2024-07-02T08:05:27.907321211Z" 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" Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.907459919Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.907546943Z" 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 Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.907583579Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.907621967Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.907626527Z" level=info msg="Start subscribing containerd event" Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.907780859Z" level=info msg="Start recovering state" Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.907921283Z" level=info msg="Start event monitor" Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.907952351Z" level=info msg="Start snapshots syncer" Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.907977815Z" level=info msg="Start cni network conf syncer for default" Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.907998743Z" level=info msg="Start streaming server" Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.908316623Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.908445419Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 2 08:05:27.913328 containerd[1939]: time="2024-07-02T08:05:27.908588435Z" level=info msg="containerd successfully booted in 0.307091s" Jul 2 08:05:27.910541 systemd[1]: Started containerd.service - containerd container runtime. Jul 2 08:05:27.980833 amazon-ssm-agent[2096]: 2024-07-02 08:05:27 INFO https_proxy: Jul 2 08:05:28.081750 amazon-ssm-agent[2096]: 2024-07-02 08:05:27 INFO http_proxy: Jul 2 08:05:28.124565 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 2 08:05:28.144649 (dockerd)[2130]: 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 Jul 2 08:05:28.181540 amazon-ssm-agent[2096]: 2024-07-02 08:05:27 INFO no_proxy: Jul 2 08:05:28.279917 amazon-ssm-agent[2096]: 2024-07-02 08:05:27 INFO Checking if agent identity type OnPrem can be assumed Jul 2 08:05:28.378449 amazon-ssm-agent[2096]: 2024-07-02 08:05:27 INFO Checking if agent identity type EC2 can be assumed Jul 2 08:05:28.479100 amazon-ssm-agent[2096]: 2024-07-02 08:05:28 INFO Agent will take identity from EC2 Jul 2 08:05:28.577608 amazon-ssm-agent[2096]: 2024-07-02 08:05:28 INFO [amazon-ssm-agent] using named pipe channel for IPC Jul 2 08:05:28.678311 amazon-ssm-agent[2096]: 2024-07-02 08:05:28 INFO [amazon-ssm-agent] using named pipe channel for IPC Jul 2 08:05:28.762096 dockerd[2130]: time="2024-07-02T08:05:28.759747263Z" level=info msg="Starting up" Jul 2 08:05:28.777620 amazon-ssm-agent[2096]: 2024-07-02 08:05:28 INFO [amazon-ssm-agent] using named pipe channel for IPC Jul 2 08:05:28.810847 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport1115087681-merged.mount: Deactivated successfully. Jul 2 08:05:28.852053 systemd[1]: var-lib-docker-metacopy\x2dcheck2607024967-merged.mount: Deactivated successfully. Jul 2 08:05:28.876858 amazon-ssm-agent[2096]: 2024-07-02 08:05:28 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Jul 2 08:05:28.885244 dockerd[2130]: time="2024-07-02T08:05:28.884653980Z" level=info msg="Loading containers: start." Jul 2 08:05:28.980428 amazon-ssm-agent[2096]: 2024-07-02 08:05:28 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Jul 2 08:05:29.081193 amazon-ssm-agent[2096]: 2024-07-02 08:05:28 INFO [amazon-ssm-agent] Starting Core Agent Jul 2 08:05:29.182310 amazon-ssm-agent[2096]: 2024-07-02 08:05:28 INFO [amazon-ssm-agent] registrar detected. Attempting registration Jul 2 08:05:29.207604 kernel: Initializing XFRM netlink socket Jul 2 08:05:29.288139 amazon-ssm-agent[2096]: 2024-07-02 08:05:28 INFO [Registrar] Starting registrar module Jul 2 08:05:29.285705 (udev-worker)[1790]: Network interface NamePolicy= disabled on kernel command line. Jul 2 08:05:29.384291 amazon-ssm-agent[2096]: 2024-07-02 08:05:28 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Jul 2 08:05:29.439268 systemd-networkd[1776]: docker0: Link UP Jul 2 08:05:29.447100 amazon-ssm-agent[2096]: 2024-07-02 08:05:29 INFO [EC2Identity] EC2 registration was successful. Jul 2 08:05:29.447100 amazon-ssm-agent[2096]: 2024-07-02 08:05:29 INFO [CredentialRefresher] credentialRefresher has started Jul 2 08:05:29.447100 amazon-ssm-agent[2096]: 2024-07-02 08:05:29 INFO [CredentialRefresher] Starting credentials refresher loop Jul 2 08:05:29.447100 amazon-ssm-agent[2096]: 2024-07-02 08:05:29 INFO EC2RoleProvider Successfully connected with instance profile role credentials Jul 2 08:05:29.465308 dockerd[2130]: time="2024-07-02T08:05:29.465245387Z" level=info msg="Loading containers: done." Jul 2 08:05:29.484701 amazon-ssm-agent[2096]: 2024-07-02 08:05:29 INFO [CredentialRefresher] Next credential rotation will be in 31.2248893218 minutes Jul 2 08:05:29.590766 sshd_keygen[1944]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 2 08:05:29.642985 dockerd[2130]: time="2024-07-02T08:05:29.642025212Z" 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 Jul 2 08:05:29.642985 dockerd[2130]: time="2024-07-02T08:05:29.642422880Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Jul 2 08:05:29.642985 dockerd[2130]: time="2024-07-02T08:05:29.642693888Z" level=info msg="Daemon has completed initialization" Jul 2 08:05:29.648248 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 2 08:05:29.659695 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 2 08:05:29.672348 systemd[1]: Started sshd@0-172.31.25.167:22-139.178.89.65:57282.service - OpenSSH per-connection server daemon (139.178.89.65:57282). Jul 2 08:05:29.689775 systemd[1]: issuegen.service: Deactivated successfully. Jul 2 08:05:29.690517 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 2 08:05:29.701680 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 2 08:05:29.738820 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 2 08:05:29.741470 dockerd[2130]: time="2024-07-02T08:05:29.741030288Z" level=info msg="API listen on /run/docker.sock" Jul 2 08:05:29.745928 etcd-wrapper[2121]: Error response from daemon: No such container: etcd-member Jul 2 08:05:29.755803 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 2 08:05:29.767684 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jul 2 08:05:29.770466 systemd[1]: Reached target getty.target - Login Prompts. Jul 2 08:05:29.773081 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 2 08:05:29.799189 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck712192506-merged.mount: Deactivated successfully. Jul 2 08:05:29.808040 etcd-wrapper[2262]: Error response from daemon: No such container: etcd-member Jul 2 08:05:29.863999 etcd-wrapper[2279]: Unable to find image 'quay.io/coreos/etcd:v3.5.0-arm64' locally Jul 2 08:05:29.947629 sshd[2238]: Accepted publickey for core from 139.178.89.65 port 57282 ssh2: RSA SHA256:zev8WD4CKaPapZVhVIFgLFFY23WI3PrYJfjwYFJuZUY Jul 2 08:05:29.949156 sshd[2238]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:05:29.964595 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 2 08:05:29.975593 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 2 08:05:29.982304 systemd-logind[1914]: New session 1 of user core. Jul 2 08:05:30.006133 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 2 08:05:30.025515 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 2 08:05:30.034025 (systemd)[2286]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:05:30.266244 systemd[2286]: Queued start job for default target default.target. Jul 2 08:05:30.279339 systemd[2286]: Created slice app.slice - User Application Slice. Jul 2 08:05:30.279428 systemd[2286]: Reached target paths.target - Paths. Jul 2 08:05:30.279463 systemd[2286]: Reached target timers.target - Timers. Jul 2 08:05:30.282122 systemd[2286]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 2 08:05:30.314651 systemd[2286]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 2 08:05:30.314935 systemd[2286]: Reached target sockets.target - Sockets. Jul 2 08:05:30.314975 systemd[2286]: Reached target basic.target - Basic System. Jul 2 08:05:30.315136 systemd[2286]: Reached target default.target - Main User Target. Jul 2 08:05:30.315213 systemd[2286]: Startup finished in 265ms. Jul 2 08:05:30.315421 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 2 08:05:30.326362 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 2 08:05:30.490764 systemd[1]: Started sshd@1-172.31.25.167:22-139.178.89.65:45764.service - OpenSSH per-connection server daemon (139.178.89.65:45764). Jul 2 08:05:30.498097 amazon-ssm-agent[2096]: 2024-07-02 08:05:30 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Jul 2 08:05:30.598532 amazon-ssm-agent[2096]: 2024-07-02 08:05:30 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2299) started Jul 2 08:05:30.670693 sshd[2298]: Accepted publickey for core from 139.178.89.65 port 45764 ssh2: RSA SHA256:zev8WD4CKaPapZVhVIFgLFFY23WI3PrYJfjwYFJuZUY Jul 2 08:05:30.676262 sshd[2298]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:05:30.690649 systemd-logind[1914]: New session 2 of user core. Jul 2 08:05:30.698769 amazon-ssm-agent[2096]: 2024-07-02 08:05:30 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Jul 2 08:05:30.699328 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 2 08:05:30.828417 sshd[2298]: pam_unix(sshd:session): session closed for user core Jul 2 08:05:30.833419 systemd[1]: sshd@1-172.31.25.167:22-139.178.89.65:45764.service: Deactivated successfully. Jul 2 08:05:30.837247 systemd[1]: session-2.scope: Deactivated successfully. Jul 2 08:05:30.839620 systemd-logind[1914]: Session 2 logged out. Waiting for processes to exit. Jul 2 08:05:30.841561 systemd-logind[1914]: Removed session 2. Jul 2 08:05:30.873545 systemd[1]: Started sshd@2-172.31.25.167:22-139.178.89.65:45770.service - OpenSSH per-connection server daemon (139.178.89.65:45770). Jul 2 08:05:31.038633 sshd[2315]: Accepted publickey for core from 139.178.89.65 port 45770 ssh2: RSA SHA256:zev8WD4CKaPapZVhVIFgLFFY23WI3PrYJfjwYFJuZUY Jul 2 08:05:31.041911 sshd[2315]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:05:31.050008 systemd-logind[1914]: New session 3 of user core. Jul 2 08:05:31.061334 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 2 08:05:31.188164 sshd[2315]: pam_unix(sshd:session): session closed for user core Jul 2 08:05:31.194613 systemd[1]: sshd@2-172.31.25.167:22-139.178.89.65:45770.service: Deactivated successfully. Jul 2 08:05:31.198960 systemd[1]: session-3.scope: Deactivated successfully. Jul 2 08:05:31.200292 systemd-logind[1914]: Session 3 logged out. Waiting for processes to exit. Jul 2 08:05:31.202583 systemd-logind[1914]: Removed session 3. Jul 2 08:05:31.273687 etcd-wrapper[2279]: v3.5.0-arm64: Pulling from coreos/etcd Jul 2 08:05:31.273687 etcd-wrapper[2279]: 6022c6b01d76: Pulling fs layer Jul 2 08:05:31.273687 etcd-wrapper[2279]: 1d97b1ec77fc: Pulling fs layer Jul 2 08:05:31.273687 etcd-wrapper[2279]: 99ef4b690837: Pulling fs layer Jul 2 08:05:31.273687 etcd-wrapper[2279]: 435b7bf0967c: Pulling fs layer Jul 2 08:05:31.273687 etcd-wrapper[2279]: 17e4a5f7c1b5: Pulling fs layer Jul 2 08:05:31.273687 etcd-wrapper[2279]: 5b0292999756: Pulling fs layer Jul 2 08:05:31.273687 etcd-wrapper[2279]: 435b7bf0967c: Waiting Jul 2 08:05:31.273687 etcd-wrapper[2279]: 17e4a5f7c1b5: Waiting Jul 2 08:05:31.273687 etcd-wrapper[2279]: 5b0292999756: Waiting Jul 2 08:05:31.688425 etcd-wrapper[2279]: 99ef4b690837: Verifying Checksum Jul 2 08:05:31.688425 etcd-wrapper[2279]: 99ef4b690837: Download complete Jul 2 08:05:31.700335 ntpd[1910]: Listen normally on 6 eth0 [fe80::417:31ff:fea1:6c15%2]:123 Jul 2 08:05:31.701484 ntpd[1910]: 2 Jul 08:05:31 ntpd[1910]: Listen normally on 6 eth0 [fe80::417:31ff:fea1:6c15%2]:123 Jul 2 08:05:31.709568 etcd-wrapper[2279]: 1d97b1ec77fc: Verifying Checksum Jul 2 08:05:31.709568 etcd-wrapper[2279]: 1d97b1ec77fc: Download complete Jul 2 08:05:31.861234 etcd-wrapper[2279]: 6022c6b01d76: Verifying Checksum Jul 2 08:05:31.861234 etcd-wrapper[2279]: 6022c6b01d76: Download complete Jul 2 08:05:32.093697 etcd-wrapper[2279]: 435b7bf0967c: Verifying Checksum Jul 2 08:05:32.093697 etcd-wrapper[2279]: 435b7bf0967c: Download complete Jul 2 08:05:32.097900 etcd-wrapper[2279]: 17e4a5f7c1b5: Verifying Checksum Jul 2 08:05:32.097900 etcd-wrapper[2279]: 17e4a5f7c1b5: Download complete Jul 2 08:05:32.222793 etcd-wrapper[2279]: 5b0292999756: Verifying Checksum Jul 2 08:05:32.222970 etcd-wrapper[2279]: 5b0292999756: Download complete Jul 2 08:05:33.262766 etcd-wrapper[2279]: 6022c6b01d76: Pull complete Jul 2 08:05:33.519193 systemd[1]: var-lib-docker-overlay2-1770996c6c465bc842adb2b03f5b05ca74b45d2d5ec7009f6cfbbf8324a68660-merged.mount: Deactivated successfully. Jul 2 08:05:33.603843 etcd-wrapper[2279]: 1d97b1ec77fc: Pull complete Jul 2 08:05:33.551277 systemd-resolved[1728]: Clock change detected. Flushing caches. Jul 2 08:05:33.601863 systemd-journald[1569]: Time jumped backwards, rotating. Jul 2 08:05:33.603172 kernel: overlayfs: lowerdir is in-use as upperdir/workdir of another mount, accessing files from both mounts will result in undefined behavior. Jul 2 08:05:33.811619 systemd[1]: var-lib-docker-overlay2-95373629580b270d4dcbf0c345d059eab8e8622f94a66848adad432a787572d6-merged.mount: Deactivated successfully. Jul 2 08:05:34.029332 etcd-wrapper[2279]: 99ef4b690837: Pull complete Jul 2 08:05:34.109218 kernel: overlayfs: lowerdir is in-use as upperdir/workdir of another mount, accessing files from both mounts will result in undefined behavior. Jul 2 08:05:34.110122 kernel: overlayfs: lowerdir is in-use as upperdir/workdir of another mount, accessing files from both mounts will result in undefined behavior. Jul 2 08:05:34.266724 systemd[1]: var-lib-docker-overlay2-89f17333e33c8c1a23c0d772a103ef42f6428b29a2f91965624cdc3f3791e31b-merged.mount: Deactivated successfully. Jul 2 08:05:34.841499 etcd-wrapper[2279]: 435b7bf0967c: Pull complete Jul 2 08:05:34.917689 systemd[1]: var-lib-docker-overlay2-f6f9b6b6cc0c2a1f3b1bdcfdc1fbfae2153f178e2c24c048c59a98b4c2935019-merged.mount: Deactivated successfully. Jul 2 08:05:34.931883 etcd-wrapper[2279]: 17e4a5f7c1b5: Pull complete Jul 2 08:05:34.996570 systemd[1]: var-lib-docker-overlay2-ac15b19da435ff7685379a40a09ff285bf9a8ba77440cb1dd49db6431be50436-merged.mount: Deactivated successfully. Jul 2 08:05:35.018378 etcd-wrapper[2279]: 5b0292999756: Pull complete Jul 2 08:05:35.032856 etcd-wrapper[2279]: Digest: sha256:96255d1ad67e7afcea46b4dc1b7e74024b9f6971193cb7316b093b3b5671efb0 Jul 2 08:05:35.074446 etcd-wrapper[2279]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0-arm64 Jul 2 08:05:35.510596 containerd[1939]: time="2024-07-02T08:05:35.510410433Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 2 08:05:35.512077 containerd[1939]: time="2024-07-02T08:05:35.511632321Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 2 08:05:35.512077 containerd[1939]: time="2024-07-02T08:05:35.511755537Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 2 08:05:35.512077 containerd[1939]: time="2024-07-02T08:05:35.511819533Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 2 08:05:35.550216 systemd[1]: Started docker-8f7384a9ddecb56fd6b8f2140d4709deb4e9647545d68b6783c0a0751804c56e.scope - libcontainer container 8f7384a9ddecb56fd6b8f2140d4709deb4e9647545d68b6783c0a0751804c56e. Jul 2 08:05:35.638265 etcd-wrapper[2279]: {"level":"info","ts":1719907535.6378062,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Jul 2 08:05:35.638265 etcd-wrapper[2279]: {"level":"info","ts":1719907535.6382332,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec2d35a78632bb324cfa33f94a5cf8e5"} Jul 2 08:05:35.639058 etcd-wrapper[2279]: {"level":"warn","ts":1719907535.63831,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Jul 2 08:05:35.639058 etcd-wrapper[2279]: {"level":"warn","ts":1719907535.6383364,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0-arm64"} Jul 2 08:05:35.639058 etcd-wrapper[2279]: {"level":"warn","ts":1719907535.6383536,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Jul 2 08:05:35.639058 etcd-wrapper[2279]: {"level":"warn","ts":1719907535.638436,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Jul 2 08:05:35.639058 etcd-wrapper[2279]: {"level":"warn","ts":1719907535.6384554,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Jul 2 08:05:35.639058 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.638Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://172.31.25.167:2379"]} Jul 2 08:05:35.639058 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.638Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Jul 2 08:05:35.658482 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.658Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Jul 2 08:05:35.659225 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.658Z","caller":"embed/etcd.go:307","msg":"starting an etcd server","etcd-version":"3.5.0","git-sha":"946a5a6f2","go-version":"go1.16.3","go-os":"linux","go-arch":"arm64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"ec2d35a78632bb324cfa33f94a5cf8e5","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://172.31.25.167:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec2d35a78632bb324cfa33f94a5cf8e5=http://localhost:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-size-bytes":2147483648,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} Jul 2 08:05:35.663386 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.663Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.039636ms"} Jul 2 08:05:35.680297 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.679Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Jul 2 08:05:35.680985 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.680Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Jul 2 08:05:35.680985 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.680Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Jul 2 08:05:35.680985 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.680Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Jul 2 08:05:35.680985 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.680Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Jul 2 08:05:35.680985 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.680Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Jul 2 08:05:35.683874 etcd-wrapper[2279]: {"level":"warn","ts":"2024-07-02T08:05:35.683Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Jul 2 08:05:35.686349 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.685Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Jul 2 08:05:35.687720 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.687Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} Jul 2 08:05:35.689450 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.688Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.0","cluster-version":"to_be_decided"} Jul 2 08:05:35.690131 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.689Z","caller":"etcdserver/server.go:728","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} Jul 2 08:05:35.700589 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Jul 2 08:05:35.700589 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.699Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} Jul 2 08:05:35.701126 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.700Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://172.31.25.167:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Jul 2 08:05:35.701126 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.700Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"127.0.0.1:2380"} Jul 2 08:05:35.701126 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.700Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"127.0.0.1:2380"} Jul 2 08:05:35.781843 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Jul 2 08:05:35.781843 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Jul 2 08:05:35.781843 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Jul 2 08:05:35.782468 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Jul 2 08:05:35.782468 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Jul 2 08:05:35.782468 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Jul 2 08:05:35.782468 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Jul 2 08:05:35.782468 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.782Z","caller":"etcdserver/server.go:2476","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Jul 2 08:05:35.783809 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.783Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Jul 2 08:05:35.784603 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.783Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Jul 2 08:05:35.784603 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.783Z","caller":"etcdserver/server.go:2500","msg":"cluster version is updated","cluster-version":"3.5"} Jul 2 08:05:35.784603 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.783Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:ec2d35a78632bb324cfa33f94a5cf8e5 ClientURLs:[http://172.31.25.167:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Jul 2 08:05:35.784603 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.783Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Jul 2 08:05:35.785659 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.784Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Jul 2 08:05:35.785659 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.784Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Jul 2 08:05:35.787866 etcd-wrapper[2279]: {"level":"info","ts":"2024-07-02T08:05:35.786Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Jul 2 08:05:35.787319 systemd[1]: Started etcd-member.service - etcd (System Application Container). Jul 2 08:05:35.787905 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 2 08:05:35.788717 systemd[1]: Startup finished in 1.277s (kernel) + 7.388s (initrd) + 14.796s (userspace) = 23.462s. Jul 2 08:05:41.083451 systemd[1]: Started sshd@3-172.31.25.167:22-139.178.89.65:35754.service - OpenSSH per-connection server daemon (139.178.89.65:35754). Jul 2 08:05:41.261423 sshd[2407]: Accepted publickey for core from 139.178.89.65 port 35754 ssh2: RSA SHA256:zev8WD4CKaPapZVhVIFgLFFY23WI3PrYJfjwYFJuZUY Jul 2 08:05:41.263998 sshd[2407]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:05:41.271377 systemd-logind[1914]: New session 4 of user core. Jul 2 08:05:41.280220 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 2 08:05:41.409752 sshd[2407]: pam_unix(sshd:session): session closed for user core Jul 2 08:05:41.416020 systemd-logind[1914]: Session 4 logged out. Waiting for processes to exit. Jul 2 08:05:41.416479 systemd[1]: sshd@3-172.31.25.167:22-139.178.89.65:35754.service: Deactivated successfully. Jul 2 08:05:41.420406 systemd[1]: session-4.scope: Deactivated successfully. Jul 2 08:05:41.424660 systemd-logind[1914]: Removed session 4. Jul 2 08:05:41.451461 systemd[1]: Started sshd@4-172.31.25.167:22-139.178.89.65:35764.service - OpenSSH per-connection server daemon (139.178.89.65:35764). Jul 2 08:05:41.634141 sshd[2414]: Accepted publickey for core from 139.178.89.65 port 35764 ssh2: RSA SHA256:zev8WD4CKaPapZVhVIFgLFFY23WI3PrYJfjwYFJuZUY Jul 2 08:05:41.636647 sshd[2414]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:05:41.644019 systemd-logind[1914]: New session 5 of user core. Jul 2 08:05:41.653195 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 2 08:05:41.773341 sshd[2414]: pam_unix(sshd:session): session closed for user core Jul 2 08:05:41.780716 systemd[1]: sshd@4-172.31.25.167:22-139.178.89.65:35764.service: Deactivated successfully. Jul 2 08:05:41.784559 systemd[1]: session-5.scope: Deactivated successfully. Jul 2 08:05:41.786141 systemd-logind[1914]: Session 5 logged out. Waiting for processes to exit. Jul 2 08:05:41.787737 systemd-logind[1914]: Removed session 5. Jul 2 08:05:41.812470 systemd[1]: Started sshd@5-172.31.25.167:22-139.178.89.65:35778.service - OpenSSH per-connection server daemon (139.178.89.65:35778). Jul 2 08:05:41.990757 sshd[2421]: Accepted publickey for core from 139.178.89.65 port 35778 ssh2: RSA SHA256:zev8WD4CKaPapZVhVIFgLFFY23WI3PrYJfjwYFJuZUY Jul 2 08:05:41.993253 sshd[2421]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:05:42.000492 systemd-logind[1914]: New session 6 of user core. Jul 2 08:05:42.011201 systemd[1]: Started session-6.scope - Session 6 of User core. Jul 2 08:05:42.137377 sshd[2421]: pam_unix(sshd:session): session closed for user core Jul 2 08:05:42.143028 systemd[1]: sshd@5-172.31.25.167:22-139.178.89.65:35778.service: Deactivated successfully. Jul 2 08:05:42.146016 systemd[1]: session-6.scope: Deactivated successfully. Jul 2 08:05:42.149604 systemd-logind[1914]: Session 6 logged out. Waiting for processes to exit. Jul 2 08:05:42.151411 systemd-logind[1914]: Removed session 6. Jul 2 08:05:42.178453 systemd[1]: Started sshd@6-172.31.25.167:22-139.178.89.65:35782.service - OpenSSH per-connection server daemon (139.178.89.65:35782). Jul 2 08:05:42.350638 sshd[2428]: Accepted publickey for core from 139.178.89.65 port 35782 ssh2: RSA SHA256:zev8WD4CKaPapZVhVIFgLFFY23WI3PrYJfjwYFJuZUY Jul 2 08:05:42.353165 sshd[2428]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:05:42.362270 systemd-logind[1914]: New session 7 of user core. Jul 2 08:05:42.369203 systemd[1]: Started session-7.scope - Session 7 of User core. Jul 2 08:05:42.489907 sshd[2428]: pam_unix(sshd:session): session closed for user core Jul 2 08:05:42.497063 systemd[1]: sshd@6-172.31.25.167:22-139.178.89.65:35782.service: Deactivated successfully. Jul 2 08:05:42.500751 systemd[1]: session-7.scope: Deactivated successfully. Jul 2 08:05:42.502283 systemd-logind[1914]: Session 7 logged out. Waiting for processes to exit. Jul 2 08:05:42.504158 systemd-logind[1914]: Removed session 7. Jul 2 08:05:42.528487 systemd[1]: Started sshd@7-172.31.25.167:22-139.178.89.65:35788.service - OpenSSH per-connection server daemon (139.178.89.65:35788). Jul 2 08:05:42.706864 sshd[2437]: Accepted publickey for core from 139.178.89.65 port 35788 ssh2: RSA SHA256:zev8WD4CKaPapZVhVIFgLFFY23WI3PrYJfjwYFJuZUY Jul 2 08:05:42.709319 sshd[2437]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 2 08:05:42.717250 systemd-logind[1914]: New session 8 of user core. Jul 2 08:05:42.728271 systemd[1]: Started session-8.scope - Session 8 of User core. Jul 2 08:05:42.995258 sshd[2437]: pam_unix(sshd:session): session closed for user core Jul 2 08:05:43.000797 systemd[1]: sshd@7-172.31.25.167:22-139.178.89.65:35788.service: Deactivated successfully. Jul 2 08:05:43.001355 systemd-logind[1914]: Session 8 logged out. Waiting for processes to exit. Jul 2 08:05:43.003739 systemd[1]: session-8.scope: Deactivated successfully. Jul 2 08:05:43.007609 systemd-logind[1914]: Removed session 8. Jul 2 08:05:57.385811 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Jul 2 08:06:11.340622 update_engine[1915]: I0702 08:06:11.340551 1915 update_attempter.cc:509] Updating boot flags... Jul 2 08:06:11.419776 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 34 scanned by (udev-worker) (2466) Jul 2 08:06:11.643034 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 34 scanned by (udev-worker) (2465) Jul 2 08:06:11.879997 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 34 scanned by (udev-worker) (2465)